builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-061 starttime: 1478657278.75 results: success (0) buildid: 20161108153206 builduid: 6e455738738f4627a52b1120baeec078 revision: 7fb5ed60089575611b832109c91f501a0a7c3f14 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 18:07:58.753430) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-11-08 18:07:58.753877) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 18:07:58.754153) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-11-08 18:07:58.768758) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 18:07:58.769017) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-11-08 18:07:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2016-11-08 18:07:59 (227 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.102419 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 18:07:58.884995) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 18:07:58.885358) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016383 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 18:07:58.935755) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-08 18:07:58.936057) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 7fb5ed60089575611b832109c91f501a0a7c3f14 --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 7fb5ed60089575611b832109c91f501a0a7c3f14 --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=516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-11-08 18:07:59,629 truncating revision to first 12 chars 2016-11-08 18:07:59,630 Setting DEBUG logging. 2016-11-08 18:07:59,630 attempt 1/10 2016-11-08 18:07:59,630 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/7fb5ed600895?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-11-08 18:08:00,457 unpacking tar archive at: mozilla-inbound-7fb5ed600895/testing/mozharness/ program finished with exit code 0 elapsedTime=1.143647 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-11-08 18:08:00.095830) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 18:08:00.096258) ========= script_repo_revision: 7fb5ed60089575611b832109c91f501a0a7c3f14 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-11-08 18:08:00.096819) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 18:08:00.097240) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-11-08 18:08:00.110686) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-08 18:08:00.111077) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:08:00 INFO - MultiFileLogger online at 20161108 18:08:00 in /builds/slave/test 18:08:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 18:08:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:08:00 INFO - {'append_to_log': False, 18:08:00 INFO - 'base_work_dir': '/builds/slave/test', 18:08:00 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 18:08:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:08:00 INFO - 'branch': 'Mozilla-Inbound', 18:08:00 INFO - 'buildbot_json_path': 'buildprops.json', 18:08:00 INFO - 'config_files': ('talos/linux_config.py',), 18:08:00 INFO - 'default_actions': ('clobber', 18:08:00 INFO - 'read-buildbot-config', 18:08:00 INFO - 'download-and-extract', 18:08:00 INFO - 'populate-webroot', 18:08:00 INFO - 'create-virtualenv', 18:08:00 INFO - 'install', 18:08:00 INFO - 'run-tests'), 18:08:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:08:00 INFO - 'download_minidump_stackwalk': True, 18:08:00 INFO - 'download_symbols': 'ondemand', 18:08:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:08:00 INFO - 'tooltool.py': '/tools/tooltool.py', 18:08:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:08:00 INFO - '/tools/misc-python/virtualenv.py')}, 18:08:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:08:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:08:00 INFO - 'installer_path': 'installer.exe', 18:08:00 INFO - 'log_level': 'info', 18:08:00 INFO - 'log_name': 'talos', 18:08:00 INFO - 'log_to_console': True, 18:08:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:08:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:08:00 INFO - 'opt_config_files': (), 18:08:00 INFO - 'pip_index': False, 18:08:00 INFO - 'sps_profile': False, 18:08:00 INFO - 'sps_profile_interval': 0, 18:08:00 INFO - 'suite': 'dromaeojs', 18:08:00 INFO - 'system_bits': '32', 18:08:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:08:00 INFO - 'title': 'talos-linux64-ix-061', 18:08:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:08:00 INFO - 'use_talos_json': True, 18:08:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:08:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:08:00 INFO - 'work_dir': 'build'} 18:08:00 INFO - [mozharness: 2016-11-09 02:08:00.906663Z] Running clobber step. 18:08:00 INFO - Running pre-action listener: _resource_record_pre_action 18:08:00 INFO - Running main action method: clobber 18:08:00 INFO - rmtree: /builds/slave/test/build 18:08:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:08:01 INFO - Running post-action listener: _resource_record_post_action 18:08:01 INFO - [mozharness: 2016-11-09 02:08:01.888114Z] Finished clobber step (success) 18:08:01 INFO - [mozharness: 2016-11-09 02:08:01.888213Z] Running read-buildbot-config step. 18:08:01 INFO - Running pre-action listener: _resource_record_pre_action 18:08:01 INFO - Running main action method: read_buildbot_config 18:08:01 INFO - Using buildbot properties: 18:08:01 INFO - { 18:08:01 INFO - "project": "", 18:08:01 INFO - "product": "firefox", 18:08:01 INFO - "script_repo_revision": "production", 18:08:01 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:08:01 INFO - "repository": "", 18:08:01 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 18:08:01 INFO - "buildid": "20161108153206", 18:08:01 INFO - "pgo_build": "True", 18:08:01 INFO - "basedir": "/builds/slave/test", 18:08:01 INFO - "buildnumber": 2829, 18:08:01 INFO - "slavename": "talos-linux64-ix-061", 18:08:01 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 18:08:01 INFO - "platform": "ubuntu64_hw", 18:08:01 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 18:08:01 INFO - "branch": "mozilla-inbound", 18:08:01 INFO - "repo_path": "integration/mozilla-inbound", 18:08:01 INFO - "revision": "7fb5ed60089575611b832109c91f501a0a7c3f14", 18:08:01 INFO - "stage_platform": "linux64-pgo", 18:08:01 INFO - "builduid": "6e455738738f4627a52b1120baeec078", 18:08:01 INFO - "slavebuilddir": "test" 18:08:01 INFO - } 18:08:01 INFO - Found installer url https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 18:08:01 INFO - Running post-action listener: _resource_record_post_action 18:08:01 INFO - [mozharness: 2016-11-09 02:08:01.890672Z] Finished read-buildbot-config step (success) 18:08:01 INFO - [mozharness: 2016-11-09 02:08:01.890761Z] Running download-and-extract step. 18:08:01 INFO - Running pre-action listener: _resource_record_pre_action 18:08:01 INFO - Running main action method: download_and_extract 18:08:01 INFO - mkdir: /builds/slave/test/build/tests 18:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:01 INFO - trying https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:08:01 INFO - Downloading https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:08:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:08:02 INFO - Downloaded 1361 bytes. 18:08:02 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 18:08:02 INFO - Using the following test package requirements: 18:08:02 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:08:02 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:08:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:08:02 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:08:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:08:02 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:08:02 INFO - u'jsshell-linux-x86_64.zip'], 18:08:02 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:08:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:08:02 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 18:08:02 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:08:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:08:02 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:08:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:08:02 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:08:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:08:02 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 18:08:02 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:08:02 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:08:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:08:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:08:02 INFO - Fetch https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:08:03 INFO - Http code: 200 18:08:03 INFO - via: 1.1 d8f42fc9558e3e49ebfdf8834baeb756.cloudfront.net (CloudFront) 18:08:03 INFO - x-amz-cf-id: ZEO7mvuiqj4bj_H3zTbAH7xFhNiSeFpa4OiJa5GuLoMw7h_BEulq8w== 18:08:03 INFO - x-amz-version-id: 5z43l12wtTZnFTwUvjQAPuAtJ5HbmxcY 18:08:03 INFO - Expected file size: 21932518 18:08:03 INFO - Obtained file size: 21932518 18:08:07 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:08:07 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 18:08:07 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:08:07 INFO - Fetch https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 18:08:07 INFO - Http code: 200 18:08:07 INFO - via: 1.1 d897b81191cbfd68a1b6fc44f98c52b0.cloudfront.net (CloudFront) 18:08:07 INFO - x-amz-cf-id: ecLYvmVptj7ZQ5fCYV9wXH9d6-2YKtT96Iop753_EcrtuOqtMo4JLg== 18:08:07 INFO - x-amz-version-id: 5z43l12wtTZnFTwUvjQAPuAtJ5HbmxcY 18:08:08 INFO - Expected file size: 21932518 18:08:08 INFO - Obtained file size: 21932518 18:08:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 18:08:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:08:12 INFO - Fetch https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 18:08:13 INFO - Http code: 200 18:08:13 INFO - via: 1.1 c54d7f08e2f3dab1918454910cc8aad0.cloudfront.net (CloudFront) 18:08:13 INFO - x-amz-cf-id: eAh3cha5bQRF5YbB4gsTmzOCeA7F-WVrpcA9BVL0jGHaVvucC20jrQ== 18:08:13 INFO - x-amz-version-id: DIdHtui9nlPM.A7wm2YkNaHg3gtOgfk9 18:08:16 INFO - Expected file size: 14409038 18:08:16 INFO - Obtained file size: 14409038 18:08:16 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')]} 18:08:16 INFO - trying https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:08:16 INFO - Downloading https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:08:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:08:18 INFO - Downloaded 59268435 bytes. 18:08:18 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:08:18 INFO - mkdir: /builds/slave/test/properties 18:08:18 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:08:18 INFO - Writing to file /builds/slave/test/properties/build_url 18:08:18 INFO - Contents: 18:08:18 INFO - build_url:https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 18:08:19 INFO - Running post-action listener: _resource_record_post_action 18:08:19 INFO - Running post-action listener: set_extra_try_arguments 18:08:19 INFO - [mozharness: 2016-11-09 02:08:19.379262Z] Finished download-and-extract step (success) 18:08:19 INFO - [mozharness: 2016-11-09 02:08:19.379491Z] Running populate-webroot step. 18:08:19 INFO - Running pre-action listener: _resource_record_pre_action 18:08:19 INFO - Running main action method: populate_webroot 18:08:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:08:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:08:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:08:19 INFO - '--tppagecycles', 18:08:19 INFO - '7'], 18:08:19 INFO - 'tests': ['tsvgm']}}, 18:08:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:08:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:08:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:08:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:08:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:08:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:08:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:08:19 INFO - 'talos_options': ['--disable-e10s'], 18:08:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:08:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:08:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:08:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:08:19 INFO - 'talos_options': ['--disable-e10s'], 18:08:19 INFO - 'tests': ['damp', 'tps']}, 18:08:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:08:19 INFO - 'tests': ['damp', 'tps']}, 18:08:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:08:19 INFO - 'tests': ['dromaeo_dom']}, 18:08:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:08:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:08:19 INFO - 'tests': ['basic_compositor_video']}, 18:08:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:08:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:08:19 INFO - 'tests': ['a11yr', 18:08:19 INFO - 'ts_paint', 18:08:19 INFO - 'tpaint', 18:08:19 INFO - 'sessionrestore', 18:08:19 INFO - 'sessionrestore_no_auto_restore', 18:08:19 INFO - 'tabpaint']}, 18:08:19 INFO - 'other-e10s': {'tests': ['a11yr', 18:08:19 INFO - 'ts_paint', 18:08:19 INFO - 'tpaint', 18:08:19 INFO - 'sessionrestore', 18:08:19 INFO - 'sessionrestore_no_auto_restore', 18:08:19 INFO - 'tabpaint']}, 18:08:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:08:19 INFO - 'ts_paint', 18:08:19 INFO - 'tpaint', 18:08:19 INFO - 'sessionrestore', 18:08:19 INFO - 'sessionrestore_no_auto_restore', 18:08:19 INFO - 'tabpaint']}, 18:08:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:08:19 INFO - 'ts_paint', 18:08:19 INFO - 'tpaint', 18:08:19 INFO - 'sessionrestore', 18:08:19 INFO - 'sessionrestore_no_auto_restore', 18:08:19 INFO - 'tabpaint']}, 18:08:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:08:19 INFO - 'tests': ['a11yr', 18:08:19 INFO - 'ts_paint', 18:08:19 INFO - 'tpaint', 18:08:19 INFO - 'sessionrestore', 18:08:19 INFO - 'sessionrestore_no_auto_restore', 18:08:19 INFO - 'tabpaint']}, 18:08:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:08:19 INFO - 'tests': ['a11yr', 18:08:19 INFO - 'ts_paint', 18:08:19 INFO - 'tpaint', 18:08:19 INFO - 'sessionrestore', 18:08:19 INFO - 'sessionrestore_no_auto_restore', 18:08:19 INFO - 'tabpaint']}, 18:08:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:08:19 INFO - 'tests': ['tsvgx', 18:08:19 INFO - 'tsvgr_opacity', 18:08:19 INFO - 'tart', 18:08:19 INFO - 'tscrollx', 18:08:19 INFO - 'cart']}, 18:08:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:08:19 INFO - 'tsvgr_opacity', 18:08:19 INFO - 'tart', 18:08:19 INFO - 'tscrollx', 18:08:19 INFO - 'cart']}, 18:08:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:08:19 INFO - 'talos_options': ['--disable-e10s'], 18:08:19 INFO - 'tests': ['tp5o']}, 18:08:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:08:19 INFO - 'tests': ['tp5o']}, 18:08:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:08:19 INFO - 'talos_options': ['--disable-e10s', 18:08:19 INFO - '--xperf_path', 18:08:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:08:19 INFO - 'tests': ['tp5n']}, 18:08:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:08:19 INFO - 'talos_options': ['--xperf_path', 18:08:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:08:19 INFO - 'tests': ['tp5n']}}, 18:08:19 INFO - 'talos.zip': {'path': '', 18:08:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:08:19 INFO - Running post-action listener: _resource_record_post_action 18:08:19 INFO - [mozharness: 2016-11-09 02:08:19.394738Z] Finished populate-webroot step (success) 18:08:19 INFO - [mozharness: 2016-11-09 02:08:19.394827Z] Running create-virtualenv step. 18:08:19 INFO - Running pre-action listener: _resource_record_pre_action 18:08:19 INFO - Running main action method: create_virtualenv 18:08:19 INFO - Creating virtualenv /builds/slave/test/build/venv 18:08:19 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 18:08:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:08:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:08:19 INFO - Using real prefix '/usr' 18:08:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:08:20 INFO - Installing distribute.............................................................................................................................................................................................done. 18:08:21 INFO - Installing pip.................done. 18:08:21 INFO - Return code: 0 18:08:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 18:08:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 18:08:22 INFO - Reading from file tmpfile_stdout 18:08:22 INFO - Output received: 18:08:22 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) 18:08:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed8e650f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ff60>, '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 0x2ba0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', '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 18:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:08:22 INFO - Using env: {'DISPLAY': ':0', 18:08:22 INFO - 'HOME': '/home/cltbld', 18:08:22 INFO - 'LANG': 'en_US.UTF-8', 18:08:22 INFO - 'LANGUAGE': 'en_US:en', 18:08:22 INFO - 'LOGNAME': 'cltbld', 18:08:22 INFO - 'MAIL': '/var/mail/cltbld', 18:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:22 INFO - 'MOZ_NO_REMOTE': '1', 18:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:22 INFO - 'NO_EM_RESTART': '1', 18:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:22 INFO - 'PWD': '/builds/slave/test', 18:08:22 INFO - 'SHELL': '/bin/bash', 18:08:22 INFO - 'SHLVL': '1', 18:08:22 INFO - 'TERM': 'linux', 18:08:22 INFO - 'TMOUT': '86400', 18:08:22 INFO - 'USER': 'cltbld', 18:08:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', 18:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:22 INFO - '_': '/tools/buildbot/bin/python'} 18:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:22 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 18:08:22 INFO - Cleaning up... 18:08:22 INFO - Return code: 0 18:08:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fed8e650f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ff60>, '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 0x2ba0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', '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 18:08:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:08:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:08:22 INFO - Using env: {'DISPLAY': ':0', 18:08:22 INFO - 'HOME': '/home/cltbld', 18:08:22 INFO - 'LANG': 'en_US.UTF-8', 18:08:22 INFO - 'LANGUAGE': 'en_US:en', 18:08:22 INFO - 'LOGNAME': 'cltbld', 18:08:22 INFO - 'MAIL': '/var/mail/cltbld', 18:08:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:22 INFO - 'MOZ_NO_REMOTE': '1', 18:08:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:22 INFO - 'NO_EM_RESTART': '1', 18:08:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:22 INFO - 'PWD': '/builds/slave/test', 18:08:22 INFO - 'SHELL': '/bin/bash', 18:08:22 INFO - 'SHLVL': '1', 18:08:22 INFO - 'TERM': 'linux', 18:08:22 INFO - 'TMOUT': '86400', 18:08:22 INFO - 'USER': 'cltbld', 18:08:22 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', 18:08:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:22 INFO - '_': '/tools/buildbot/bin/python'} 18:08:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:22 INFO - Downloading/unpacking psutil>=3.1.1 18:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:08:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:08:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:08:24 INFO - Installing collected packages: psutil 18:08:24 INFO - Running setup.py install for psutil 18:08:24 INFO - building 'psutil._psutil_linux' extension 18:08:24 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 18:08:24 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 18:08:24 INFO - building 'psutil._psutil_posix' extension 18:08:24 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 18:08:25 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 18:08:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:08:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:08:25 INFO - Successfully installed psutil 18:08:25 INFO - Cleaning up... 18:08:25 INFO - Return code: 0 18:08:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:08:25 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')]} 18:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:25 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')]} 18:08:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:25 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 0x7fed8e650f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ff60>, '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 0x2ba0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', '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 18:08:25 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 18:08:25 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 18:08:25 INFO - Using env: {'DISPLAY': ':0', 18:08:25 INFO - 'HOME': '/home/cltbld', 18:08:25 INFO - 'LANG': 'en_US.UTF-8', 18:08:25 INFO - 'LANGUAGE': 'en_US:en', 18:08:25 INFO - 'LOGNAME': 'cltbld', 18:08:25 INFO - 'MAIL': '/var/mail/cltbld', 18:08:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:25 INFO - 'MOZ_NO_REMOTE': '1', 18:08:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:25 INFO - 'NO_EM_RESTART': '1', 18:08:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:25 INFO - 'PWD': '/builds/slave/test', 18:08:25 INFO - 'SHELL': '/bin/bash', 18:08:25 INFO - 'SHLVL': '1', 18:08:25 INFO - 'TERM': 'linux', 18:08:25 INFO - 'TMOUT': '86400', 18:08:25 INFO - 'USER': 'cltbld', 18:08:25 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', 18:08:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:25 INFO - '_': '/tools/buildbot/bin/python'} 18:08:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:08:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:08:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:08:27 INFO - Installing collected packages: mozsystemmonitor 18:08:27 INFO - Running setup.py install for mozsystemmonitor 18:08:27 INFO - Successfully installed mozsystemmonitor 18:08:27 INFO - Cleaning up... 18:08:27 INFO - Return code: 0 18:08:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fed8e650f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ff60>, '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 0x2ba0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', '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 18:08:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 18:08:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 18:08:27 INFO - Using env: {'DISPLAY': ':0', 18:08:27 INFO - 'HOME': '/home/cltbld', 18:08:27 INFO - 'LANG': 'en_US.UTF-8', 18:08:27 INFO - 'LANGUAGE': 'en_US:en', 18:08:27 INFO - 'LOGNAME': 'cltbld', 18:08:27 INFO - 'MAIL': '/var/mail/cltbld', 18:08:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:27 INFO - 'MOZ_NO_REMOTE': '1', 18:08:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:27 INFO - 'NO_EM_RESTART': '1', 18:08:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:27 INFO - 'PWD': '/builds/slave/test', 18:08:27 INFO - 'SHELL': '/bin/bash', 18:08:27 INFO - 'SHLVL': '1', 18:08:27 INFO - 'TERM': 'linux', 18:08:27 INFO - 'TMOUT': '86400', 18:08:27 INFO - 'USER': 'cltbld', 18:08:27 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', 18:08:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:27 INFO - '_': '/tools/buildbot/bin/python'} 18:08:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:27 INFO - Downloading/unpacking jsonschema==2.5.1 18:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:08:29 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:08:29 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 18:08:29 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 18:08:29 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 18:08:29 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 18:08:29 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 18:08:29 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 18:08:29 INFO - Downloading functools32-3.2.3-2.tar.gz 18:08:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:08:29 INFO - warning: no files found matching '*.txt' 18:08:29 INFO - no previously-included directories found matching 'build' 18:08:29 INFO - no previously-included directories found matching 'dist' 18:08:29 INFO - no previously-included directories found matching '.git*' 18:08:29 INFO - Installing collected packages: jsonschema, functools32 18:08:30 INFO - Running setup.py install for functools32 18:08:30 INFO - warning: no files found matching '*.txt' 18:08:30 INFO - no previously-included directories found matching 'build' 18:08:30 INFO - no previously-included directories found matching 'dist' 18:08:30 INFO - no previously-included directories found matching '.git*' 18:08:30 INFO - Successfully installed jsonschema functools32 18:08:30 INFO - Cleaning up... 18:08:30 INFO - Return code: 0 18:08:30 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:30 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 0x7fed8e650f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ff60>, '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 0x2ba0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', '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 18:08:30 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 18:08:30 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 18:08:30 INFO - Using env: {'DISPLAY': ':0', 18:08:30 INFO - 'HOME': '/home/cltbld', 18:08:30 INFO - 'LANG': 'en_US.UTF-8', 18:08:30 INFO - 'LANGUAGE': 'en_US:en', 18:08:30 INFO - 'LOGNAME': 'cltbld', 18:08:30 INFO - 'MAIL': '/var/mail/cltbld', 18:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:30 INFO - 'MOZ_NO_REMOTE': '1', 18:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:30 INFO - 'NO_EM_RESTART': '1', 18:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:30 INFO - 'PWD': '/builds/slave/test', 18:08:30 INFO - 'SHELL': '/bin/bash', 18:08:30 INFO - 'SHLVL': '1', 18:08:30 INFO - 'TERM': 'linux', 18:08:30 INFO - 'TMOUT': '86400', 18:08:30 INFO - 'USER': 'cltbld', 18:08:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', 18:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:30 INFO - '_': '/tools/buildbot/bin/python'} 18:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:30 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:08:30 INFO - Cleaning up... 18:08:30 INFO - Return code: 0 18:08:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:30 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 0x7fed8e650f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ff60>, '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 0x2ba0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', '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 18:08:30 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 18:08:30 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 18:08:30 INFO - Using env: {'DISPLAY': ':0', 18:08:30 INFO - 'HOME': '/home/cltbld', 18:08:30 INFO - 'LANG': 'en_US.UTF-8', 18:08:30 INFO - 'LANGUAGE': 'en_US:en', 18:08:30 INFO - 'LOGNAME': 'cltbld', 18:08:30 INFO - 'MAIL': '/var/mail/cltbld', 18:08:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:30 INFO - 'MOZ_NO_REMOTE': '1', 18:08:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:30 INFO - 'NO_EM_RESTART': '1', 18:08:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:30 INFO - 'PWD': '/builds/slave/test', 18:08:30 INFO - 'SHELL': '/bin/bash', 18:08:30 INFO - 'SHLVL': '1', 18:08:30 INFO - 'TERM': 'linux', 18:08:30 INFO - 'TMOUT': '86400', 18:08:30 INFO - 'USER': 'cltbld', 18:08:30 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', 18:08:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:30 INFO - '_': '/tools/buildbot/bin/python'} 18:08:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:30 INFO - Downloading/unpacking blobuploader==1.2.4 18:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:08:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:08:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:08:32 INFO - Downloading blobuploader-1.2.4.tar.gz 18:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:08:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:08: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 18:08: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 18:08: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 18:08: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 18:08: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 18:08: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 18:08:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:08:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:08:33 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 18:08:33 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 18:08:33 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 18:08:33 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 18:08:33 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 18:08:33 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 18:08:33 INFO - Downloading docopt-0.6.1.tar.gz 18:08:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:08:33 INFO - Installing collected packages: blobuploader, requests, docopt 18:08:33 INFO - Running setup.py install for blobuploader 18:08:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:08:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:08:33 INFO - Running setup.py install for requests 18:08:33 INFO - Running setup.py install for docopt 18:08:33 INFO - Successfully installed blobuploader requests docopt 18:08:33 INFO - Cleaning up... 18:08:33 INFO - Return code: 0 18:08:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:08:33 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')]} 18:08:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:33 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')]} 18:08:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:33 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 0x7fed8e650f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ff60>, '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 0x2ba0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', '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 18:08:33 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 18:08:33 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 18:08:33 INFO - Using env: {'DISPLAY': ':0', 18:08:33 INFO - 'HOME': '/home/cltbld', 18:08:33 INFO - 'LANG': 'en_US.UTF-8', 18:08:33 INFO - 'LANGUAGE': 'en_US:en', 18:08:33 INFO - 'LOGNAME': 'cltbld', 18:08:33 INFO - 'MAIL': '/var/mail/cltbld', 18:08:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:33 INFO - 'MOZ_NO_REMOTE': '1', 18:08:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:33 INFO - 'NO_EM_RESTART': '1', 18:08:33 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:33 INFO - 'PWD': '/builds/slave/test', 18:08:33 INFO - 'SHELL': '/bin/bash', 18:08:33 INFO - 'SHLVL': '1', 18:08:33 INFO - 'TERM': 'linux', 18:08:33 INFO - 'TMOUT': '86400', 18:08:33 INFO - 'USER': 'cltbld', 18:08:33 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', 18:08:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:33 INFO - '_': '/tools/buildbot/bin/python'} 18:08:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:08:34 INFO - Running setup.py (path:/tmp/pip-CGy4w7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:08:34 INFO - Running setup.py (path:/tmp/pip-DR6xed-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:08:34 INFO - Running setup.py (path:/tmp/pip-UjqDce-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:08:34 INFO - Running setup.py (path:/tmp/pip-cB1CDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:08:34 INFO - Running setup.py (path:/tmp/pip-5pmQFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:08:34 INFO - Running setup.py (path:/tmp/pip-aKxbDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:08:34 INFO - Running setup.py (path:/tmp/pip-i9cGzy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:08:34 INFO - Running setup.py (path:/tmp/pip-jGoSQI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:08:34 INFO - Running setup.py (path:/tmp/pip-hK_zSO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:08:34 INFO - Running setup.py (path:/tmp/pip-3HgJlF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:08:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:08:34 INFO - Running setup.py (path:/tmp/pip-kiD8Nb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:08:35 INFO - Running setup.py (path:/tmp/pip-l8xIv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:08:35 INFO - Running setup.py (path:/tmp/pip-KgkIpa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:08:35 INFO - Running setup.py (path:/tmp/pip-zESi1g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:08:35 INFO - Running setup.py (path:/tmp/pip-ZkVrIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:08:35 INFO - Running setup.py (path:/tmp/pip-UW0y1F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:08:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:08:35 INFO - Running setup.py (path:/tmp/pip-EEO2hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:08:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:08:35 INFO - Running setup.py install for manifestparser 18:08:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:08:35 INFO - Running setup.py install for mozcrash 18:08:35 INFO - Running setup.py install for mozdebug 18:08:35 INFO - Running setup.py install for mozdevice 18:08:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:08:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:08:35 INFO - Running setup.py install for mozfile 18:08:35 INFO - Running setup.py install for mozhttpd 18:08:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Running setup.py install for mozinfo 18:08:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Running setup.py install for mozInstall 18:08:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Running setup.py install for mozleak 18:08:36 INFO - Running setup.py install for mozlog 18:08:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Running setup.py install for moznetwork 18:08:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Running setup.py install for mozprocess 18:08:36 INFO - Running setup.py install for mozprofile 18:08:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Running setup.py install for mozrunner 18:08:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:08:36 INFO - Running setup.py install for mozscreenshot 18:08:37 INFO - Running setup.py install for moztest 18:08:37 INFO - Running setup.py install for mozversion 18:08:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:08:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:08:37 INFO - Cleaning up... 18:08:37 INFO - Return code: 0 18:08:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:08: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')]} 18:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08: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')]} 18:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:37 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 0x7fed8e650f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ff60>, '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 0x2ba0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', '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 18:08:37 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 18:08:37 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 18:08:37 INFO - Using env: {'DISPLAY': ':0', 18:08:37 INFO - 'HOME': '/home/cltbld', 18:08:37 INFO - 'LANG': 'en_US.UTF-8', 18:08:37 INFO - 'LANGUAGE': 'en_US:en', 18:08:37 INFO - 'LOGNAME': 'cltbld', 18:08:37 INFO - 'MAIL': '/var/mail/cltbld', 18:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:37 INFO - 'MOZ_NO_REMOTE': '1', 18:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:37 INFO - 'NO_EM_RESTART': '1', 18:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:37 INFO - 'PWD': '/builds/slave/test', 18:08:37 INFO - 'SHELL': '/bin/bash', 18:08:37 INFO - 'SHLVL': '1', 18:08:37 INFO - 'TERM': 'linux', 18:08:37 INFO - 'TMOUT': '86400', 18:08:37 INFO - 'USER': 'cltbld', 18:08:37 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', 18:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:37 INFO - '_': '/tools/buildbot/bin/python'} 18:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:08:37 INFO - Running setup.py (path:/tmp/pip-eKS5o1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:08:37 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)) 18:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:08:37 INFO - Running setup.py (path:/tmp/pip-J_KyN2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:08:37 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)) 18:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:08:37 INFO - Running setup.py (path:/tmp/pip-YqQuAU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:08:37 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)) 18:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:08:37 INFO - Running setup.py (path:/tmp/pip-0NwI71-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:08:37 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)) 18:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:08:37 INFO - Running setup.py (path:/tmp/pip-IE3qO6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:08:37 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)) 18:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:08:37 INFO - Running setup.py (path:/tmp/pip-dKRcO7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:08:37 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)) 18:08:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:08:37 INFO - Running setup.py (path:/tmp/pip-WfBy_7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:08:38 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)) 18:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:08:38 INFO - Running setup.py (path:/tmp/pip-vhune7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:08:38 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)) 18:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:08:38 INFO - Running setup.py (path:/tmp/pip-_JeGii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:08:38 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)) 18:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:08:38 INFO - Running setup.py (path:/tmp/pip-GJZ2pd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:08:38 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)) 18:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:08:38 INFO - Running setup.py (path:/tmp/pip-xzXIqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:08:38 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)) 18:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:08:38 INFO - Running setup.py (path:/tmp/pip-ZTehgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:08:38 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)) 18:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:08:38 INFO - Running setup.py (path:/tmp/pip-m0Uv9V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:08:38 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)) 18:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:08:38 INFO - Running setup.py (path:/tmp/pip-rcq51s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:08:38 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)) 18:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:08:38 INFO - Running setup.py (path:/tmp/pip-63YoOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:08:38 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)) 18:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:08:38 INFO - Running setup.py (path:/tmp/pip-0rngq1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:08:38 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)) 18:08:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:08:38 INFO - Running setup.py (path:/tmp/pip-Vjg329-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:08:38 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)) 18:08:38 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)) 18:08:38 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)) 18:08:38 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)) 18:08:38 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)) 18:08:38 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)) 18:08:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:08:38 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 18:08:38 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 18:08:38 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 18:08:38 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 18:08:38 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 18:08:38 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 18:08:40 INFO - Downloading blessings-1.6.tar.gz 18:08:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:08:40 INFO - Installing collected packages: blessings 18:08:40 INFO - Running setup.py install for blessings 18:08:40 INFO - Successfully installed blessings 18:08:40 INFO - Cleaning up... 18:08:40 INFO - Return code: 0 18:08:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:08:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:08:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:08:41 INFO - Reading from file tmpfile_stdout 18:08:41 INFO - Current package versions: 18:08:41 INFO - argparse == 1.2.1 18:08:41 INFO - blessings == 1.6 18:08:41 INFO - blobuploader == 1.2.4 18:08:41 INFO - docopt == 0.6.1 18:08:41 INFO - functools32 == 3.2.3-2 18:08:41 INFO - jsonschema == 2.5.1 18:08:41 INFO - manifestparser == 1.1 18:08:41 INFO - mozInstall == 1.12 18:08:41 INFO - mozcrash == 1.0 18:08:41 INFO - mozdebug == 0.1 18:08:41 INFO - mozdevice == 0.48 18:08:41 INFO - mozfile == 1.2 18:08:41 INFO - mozhttpd == 0.7 18:08:41 INFO - mozinfo == 0.9 18:08:41 INFO - mozleak == 0.1 18:08:41 INFO - mozlog == 3.4 18:08:41 INFO - moznetwork == 0.27 18:08:41 INFO - mozprocess == 0.23 18:08:41 INFO - mozprofile == 0.28 18:08:41 INFO - mozrunner == 6.13 18:08:41 INFO - mozscreenshot == 0.1 18:08:41 INFO - mozsystemmonitor == 0.3 18:08:41 INFO - moztest == 0.7 18:08:41 INFO - mozversion == 1.4 18:08:41 INFO - psutil == 3.1.1 18:08:41 INFO - requests == 1.2.3 18:08:41 INFO - wsgiref == 0.1.2 18:08:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:41 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 0x7fed8e650f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ff60>, '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 0x2ba0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', '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 18:08:41 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 18:08:41 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 18:08:41 INFO - Using env: {'DISPLAY': ':0', 18:08:41 INFO - 'HOME': '/home/cltbld', 18:08:41 INFO - 'LANG': 'en_US.UTF-8', 18:08:41 INFO - 'LANGUAGE': 'en_US:en', 18:08:41 INFO - 'LOGNAME': 'cltbld', 18:08:41 INFO - 'MAIL': '/var/mail/cltbld', 18:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:41 INFO - 'MOZ_NO_REMOTE': '1', 18:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:41 INFO - 'NO_EM_RESTART': '1', 18:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:41 INFO - 'PWD': '/builds/slave/test', 18:08:41 INFO - 'SHELL': '/bin/bash', 18:08:41 INFO - 'SHLVL': '1', 18:08:41 INFO - 'TERM': 'linux', 18:08:41 INFO - 'TMOUT': '86400', 18:08:41 INFO - 'USER': 'cltbld', 18:08:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', 18:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:41 INFO - '_': '/tools/buildbot/bin/python'} 18:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:41 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)) 18:08:41 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)) 18:08:41 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)) 18:08:41 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)) 18:08:41 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)) 18:08:41 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)) 18:08:41 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)) 18:08:41 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)) 18:08:41 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)) 18:08:41 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)) 18:08:41 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)) 18:08:41 INFO - Cleaning up... 18:08:41 INFO - Return code: 0 18:08:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:08:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:08:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:08:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fed8e650f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ad58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2ba2ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ff60>, '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 0x2ba0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba11d0>, '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': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', '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 18:08:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:08:41 INFO - Using env: {'DISPLAY': ':0', 18:08:41 INFO - 'HOME': '/home/cltbld', 18:08:41 INFO - 'LANG': 'en_US.UTF-8', 18:08:41 INFO - 'LANGUAGE': 'en_US:en', 18:08:41 INFO - 'LOGNAME': 'cltbld', 18:08:41 INFO - 'MAIL': '/var/mail/cltbld', 18:08:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:41 INFO - 'MOZ_NO_REMOTE': '1', 18:08:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:41 INFO - 'NO_EM_RESTART': '1', 18:08:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:41 INFO - 'PWD': '/builds/slave/test', 18:08:41 INFO - 'SHELL': '/bin/bash', 18:08:41 INFO - 'SHLVL': '1', 18:08:41 INFO - 'TERM': 'linux', 18:08:41 INFO - 'TMOUT': '86400', 18:08:41 INFO - 'USER': 'cltbld', 18:08:41 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', 18:08:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:41 INFO - '_': '/tools/buildbot/bin/python'} 18:08:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:08:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:08:41 INFO - Cleaning up... 18:08:41 INFO - Return code: 0 18:08:41 INFO - Running post-action listener: _resource_record_post_action 18:08:41 INFO - Running post-action listener: _start_resource_monitoring 18:08:41 INFO - Starting resource monitoring. 18:08:41 INFO - [mozharness: 2016-11-09 02:08:41.657897Z] Finished create-virtualenv step (success) 18:08:41 INFO - [mozharness: 2016-11-09 02:08:41.658429Z] Running install step. 18:08:41 INFO - Running pre-action listener: _resource_record_pre_action 18:08:41 INFO - Running main action method: install 18:08:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:08:41 INFO - Reading from file tmpfile_stdout 18:08:41 INFO - Detecting whether we're running mozinstall >=1.0... 18:08:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:08:41 INFO - Reading from file tmpfile_stdout 18:08:41 INFO - Output received: 18:08:41 INFO - Usage: mozinstall [options] installer 18:08:41 INFO - Options: 18:08:41 INFO - -h, --help show this help message and exit 18:08:41 INFO - -d DEST, --destination=DEST 18:08:41 INFO - Directory to install application into. [default: 18:08:41 INFO - "/builds/slave/test"] 18:08:41 INFO - --app=APP Application being installed. [default: firefox] 18:08:41 INFO - mkdir: /builds/slave/test/build/application 18:08:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:08:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:08:58 INFO - Reading from file tmpfile_stdout 18:08:58 INFO - Output received: 18:08:58 INFO - /builds/slave/test/build/application/firefox/firefox 18:08:58 INFO - Running post-action listener: _resource_record_post_action 18:08:58 INFO - [mozharness: 2016-11-09 02:08:58.801350Z] Finished install step (success) 18:08:58 INFO - [mozharness: 2016-11-09 02:08:58.801594Z] Running run-tests step. 18:08:58 INFO - Running pre-action listener: _resource_record_pre_action 18:08:58 INFO - Running main action method: run_tests 18:08:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:08:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:08:58 INFO - Python 2.7.3 18:08:58 INFO - Return code: 0 18:08:58 INFO - grabbing minidump binary from tooltool 18:08:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:08:58 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 0x2b9ff60>, '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 0x2ba0d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2ba11d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:08:58 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 18:08:58 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 18:08:58 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 18:08:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:08:58 INFO - Return code: 0 18:08:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:08:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:08:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:08:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:08:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:08:58 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:08:58 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:08:58 INFO - Using env: {'DISPLAY': ':0', 18:08:58 INFO - 'HOME': '/home/cltbld', 18:08:58 INFO - 'LANG': 'en_US.UTF-8', 18:08:58 INFO - 'LANGUAGE': 'en_US:en', 18:08:58 INFO - 'LOGNAME': 'cltbld', 18:08:58 INFO - 'MAIL': '/var/mail/cltbld', 18:08:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:08:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:08:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:08:58 INFO - 'MOZ_NO_REMOTE': '1', 18:08:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:08:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:08:58 INFO - 'NO_EM_RESTART': '1', 18:08:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:08:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:08:58 INFO - 'PWD': '/builds/slave/test', 18:08:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:08:58 INFO - 'SHELL': '/bin/bash', 18:08:58 INFO - 'SHLVL': '1', 18:08:58 INFO - 'TERM': 'linux', 18:08:58 INFO - 'TMOUT': '86400', 18:08:58 INFO - 'USER': 'cltbld', 18:08:58 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029', 18:08:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:08:58 INFO - '_': '/tools/buildbot/bin/python'} 18:08:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:08:59 INFO - mozversion application_buildid: 20161108153206 18:08:59 INFO - mozversion application_changeset: 7fb5ed60089575611b832109c91f501a0a7c3f14 18:08:59 INFO - mozversion application_display_name: Nightly 18:08:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:08:59 INFO - mozversion application_name: Firefox 18:08:59 INFO - mozversion application_remotingname: firefox 18:08:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:08:59 INFO - mozversion application_vendor: Mozilla 18:08:59 INFO - mozversion application_version: 52.0a1 18:08:59 INFO - mozversion platform_buildid: 20161108153206 18:08:59 INFO - mozversion platform_changeset: 7fb5ed60089575611b832109c91f501a0a7c3f14 18:08:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:08:59 INFO - mozversion platform_version: 52.0a1 18:08:59 INFO - using testdate: 1478657339 18:08:59 INFO - actual date: 1478657339 18:08:59 INFO - starting webserver on 'localhost:57763' 18:08:59 INFO - SUITE-START | Running 2 tests 18:08:59 INFO - TEST-START | dromaeo_css 18:08:59 INFO - operating with platform_type : linux_ 18:08:59 INFO - Initialising browser for dromaeo_css test... 18:08:59 INFO - TEST-INFO | started process 16029 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPOkMW3/profile http://localhost:57763/getInfo.html) 18:09:03 INFO - PROCESS | 16029 | __metrics Screen width/height:1600/1200 18:09:03 INFO - PROCESS | 16029 | colorDepth:24 18:09:03 INFO - PROCESS | 16029 | Browser inner width/height: 1024/697 18:09:03 INFO - PROCESS | 16029 | __metrics 18:09:04 INFO - PROCESS | 16029 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:09:04 INFO - PROCESS | 16029 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:09:04 INFO - PROCESS | 16029 | console.error: PushService: 18:09:04 INFO - PROCESS | 16029 | stateChangeProcessEnqueue: Error transitioning state 18:09:04 INFO - PROCESS | 16029 | UnknownError 18:09:05 INFO - TEST-INFO | 16029: exit 0 18:09:05 INFO - Browser initialized. 18:09:05 INFO - Running cycle 1/1 for dromaeo_css test... 18:09:05 INFO - TEST-INFO | started process 16109 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPOkMW3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:09:17 INFO - PROCESS | 16109 | RSS: Main: 172605440 18:09:17 INFO - PROCESS | 16109 | 18:10:09 INFO - PROCESS | 16109 | 1478657409040 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] 18:12:19 INFO - PROCESS | 16109 | Cycle 1(1): loaded http://localhost:57763/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57763/tests/dromaeo/cssquery-ext.html) 18:12:21 INFO - PROCESS | 16109 | RSS: Main: 419221504 18:12:21 INFO - PROCESS | 16109 | 18:15:24 INFO - PROCESS | 16109 | Cycle 1(1): loaded http://localhost:57763/tests/dromaeo/cssquery-ext.html (next: http://localhost:57763/tests/dromaeo/cssquery-jquery.html) 18:15:25 INFO - PROCESS | 16109 | RSS: Main: 286953472 18:15:25 INFO - PROCESS | 16109 | 18:18:27 INFO - PROCESS | 16109 | Cycle 1(1): loaded http://localhost:57763/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57763/tests/dromaeo/cssquery-mootools.html) 18:18:27 INFO - PROCESS | 16109 | RSS: Main: 224407552 18:18:27 INFO - PROCESS | 16109 | 18:21:29 INFO - PROCESS | 16109 | Cycle 1(1): loaded http://localhost:57763/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57763/tests/dromaeo/cssquery-prototype.html) 18:21:30 INFO - PROCESS | 16109 | RSS: Main: 220614656 18:21:30 INFO - PROCESS | 16109 | 18:24:33 INFO - PROCESS | 16109 | Cycle 1(1): loaded http://localhost:57763/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57763/tests/dromaeo/cssquery-yui.html) 18:24:33 INFO - PROCESS | 16109 | RSS: Main: 224198656 18:24:33 INFO - PROCESS | 16109 | 18:27:36 INFO - PROCESS | 16109 | Cycle 1(1): loaded http://localhost:57763/tests/dromaeo/cssquery-yui.html (next: http://localhost:57763/tests/dromaeo/cssquery-dojo.html) 18:27:36 INFO - PROCESS | 16109 | RSS: Main: 308162560 18:27:36 INFO - PROCESS | 16109 | 18:27:36 INFO - PROCESS | 16109 | __start_tp_report 18:27:36 INFO - PROCESS | 16109 | _x_x_mozilla_page_load 18:27:36 INFO - PROCESS | 16109 | _x_x_mozilla_page_load_details 18:27:36 INFO - PROCESS | 16109 | |i|pagename|runs| 18:27:36 INFO - PROCESS | 16109 | |0;dojo.html;3011.6837732038134;3060.3420264643096;3061.8162910225383;3090.520969249767;3111.3621707549955;5232.3459567554055;5265.921011184831;5316.175992721134;5322.281491998579;5322.520973112419;5331.2003199520095;5381.031414345416;5413.702246376448;5422.701751403681;5482.342118945732;4775.522447755231;4810.855674329759;4849.224124140138;4868.123737727207;4879.097366987119;4915.3855768029;4918.778654960517;4980.501949805009;4986.177280748672;5031.874203144914;4765.475797662254;4898.853034408973;4905.583025442842;4920.114379411704;5002.374703162105;4787.952120478785;4869.099216644932;4870.878228044292;4881.829135980223;4887.804487820483;4833.29917162013;4839.782209800567;4850.005748821518;4851.781669824866;4859.222524396115;5311.123664595337;5373.113436283009;5395;5413.972930135364;5457.863553411157;5739.799107031234;5768.711564421762;5769.769209231626;5771.682557459338;5774.797882074149;5550.417206193332;5783.971080144573;5836.941630583682;5837.416258374129;5853.180554722342;5232.738363081869;5252.527272545489;5280.075986702312;5292.9735351323;5349.5720342372515;5720.370759216483;5757.510611598061;5772.942270577324;5773.769049238067;5775.220345253337;5555.999920014437;5568.303962004749;5568.6101972862325;5570.749316280696;5572.4148964358155;5516.531094856982;5568.638038527482;5592.217089607459;5645.1532270159805;5655.321361436654;5692.6015178937905;5698.515626171739;5702.54379649627;5720.914186287209;5745.080787074048;5686.346070201897;5687.51656109227;5691.146328050825;5693.259876216065;5694.316681998187;4263.381809637585;4310.396544483775;4312.741235525878;4333.631641310524;4371.584699453547;3887.00881275273;3910.3743401055694;3941.5664276929515;3943.940840887389;3957.050307926135;5409.702466364388;5438.374586922476;5453.291072160594;5454.836354909359;5461.481159289861;5594.440555944373;5637.041702910515;5737.799177028784;5784.3926387729525;5798.33319168301;5286.682799032071;5347.465253474699;5377.193420986883;5401.3248343957;5445.156000819879;4829.1790395632825;4834.081524510332;4834.830780922651;4846.733429661403;4871.756412179377;5785.334686511105;5923.08192230205;5930.584859059824;5934.080217566284;5934.228550288435;5638.37977822431;5676.318841739017;5728.255326807488;5735.512481439125;5826.096954971986;5931.466168044896;5967.8209653710455;5976.641401515923;5979.790707325396;5983.401659833982;5600.215969764317;5660.405657405913;5660.660360378391;5662.235598194191;5662.801801936913;5560.277163968658;5609.719514024364;5622.9156562652415;5690.601657883908;5707.543396528351;5559.444055594408;5564.137558678412;5569.832905012856;5569.888602228014;5570.359408668055;5546.195801608825;5549.5837812165055;5558.138488534284;5559.777608895599;5564.777408903598;5454.836354909359;5482.2873026506295;5492.148716948879;5501.724913754216;5502.8349149525575;5596.580256480699;5602.3837377887585;5602.383737788921;5605.131204663284;5611.915821262603;5449.891002179855;5467.343918729778;5473.945260547343;5484.972575137099;5495.972520137374 18:27:36 INFO - PROCESS | 16109 | |1;ext.html;579.1891352107051;595.1221947627249;611.7491828350375;622.9065640153979;628.481502760223;40768.79615601921;42087.158256834846;42089;45115.0976980461;45288.773556132255;43216.78391608038;43668.781656091756;43678.563214367845;43681;43776.781116094375;7827.6868925242925;8007.559584222866;8486.066532681385;8632;8636.481811091324;10067.89932100677;10368.326058806191;10378.481075946172;10379.740506487322;10394.06453419192;10307.484625768682;10360.37837729735;10360.740981475448;10376.325538839988;10381.221408394364;10188.541515631778;10237.999999999925;10239.180865530778;10257.538410771458;10263.332883362558;10083.697489075339;10109;10116.14012808912;10140.89859101407;10144.239182061376;39869.80065099685;39974.60025399767;40058;40229.19541609151;40493.39259911104;3313.3042061167184;3341.832908354597;3367.932641347184;3380.222548813762;3407.557017587698;28832.27919302013;30800.845995769876;31242.37515249705;32147.196320091953;32786.18034549132;3773.415120656303;3827.2919509890758;3882.5340959085092;4014.337634290368;4056.290149223874;337579;338774;339704;339980;340370.29814851016;60119.39880601226;60551.394486054574;60564.69717651472;60709.392906070374;60744.39255607387;35890.461643075374;36479.817600911825;36527.4520882187;38690.41964370537;38714.22571548553;15320.923395382952;15422.537323880302;15432.151231682365;15437.768433473508;15439.536813895602;11219.439028048564;11353.772924541629;11715;11958.760824783456;11981.88018119825;18930.716039259423;19106.61786764257;19179.712304315446;19210.13554390028;19212.519687007938;6821.908494640834;6915;7058.188308344504;7077.893831592531;7121.074260346122;881.4094556647062;966.8259713251541;981.3866333541537;1097.1990446973755;1112.8608923884515;29886;30020.399592008038;30334.241643959078;30857.69142308593;30875.536866947015;985.5860538573672;1065.94137322448;1084.8426978088132;1120.9495572699248;1143.5940241214248;15264.236788160548;15932.362705491882;16091.195440227943;16093.517194484184;16408.589785255463;486285;486338;487210;487508;489331;57191.14213286804;58011.709941450026;58034;58036.12945805816;58114;1227.4844565282604;1251.8685538018376;1313.3236383262818;1317.5981325695564;1333.6265845563257;25061.122860699787;26455.735442645328;26986.325341865824;27391.589126163522;27674.44651107007;50270.49729502658;51403.2289515665;51426.228606570185;51438.22842657438;51479;371680;372293;373005;373848;374443;24761.133360332304;25825.354366140244;25828.48343033091;27689.307767305978;28141.57787633228;41776.58223417727;42132.368014479194;42166.789166053975;42904.57095429006;43355.566444335156;35938.28123437464;37128.81435592805;37203.44194837025;37767;38652;36869.36351456764;37123.44314835226;37346.626533734314;37407.43888841615;37653.62346376501;35851.82074089613;36159.63840361563;37047.444288336235;37263.62736372602;37273.627263727016;30053;32672.673273266962;33634.66365336315;33658.32683346368;33749.83125084359;25440.74559254458;25890.61164082578;25927.22218333453;25961;26081.73918260793 18:27:36 INFO - PROCESS | 16109 | |2;jquery.html;384.1663590009679;393.1292187804015;396.99206015879685;409.1469286537569;413.9777188434497;13563.728725425486;15727.921360393211;18317.816821831777;18737.43787686368;19045.2381904724;17828.37600683973;18100.275988960424;18233.54416139597;18337.358192463267;18832.81167188331;5483.424240454765;5700.543956483471;5725.312962444513;5725.627834190765;5726.427357264281;5005.324281222043;6203.720832562523;6240.937590624104;6318.136149835809;6356.269029061647;6042.57701960863;6149.815505534819;6311.747530098791;6320.367963203666;6323.177986861701;6231.127642130105;6254.906176407358;6264.718087686019;6271.498280137578;6271.529635277349;5334.27987221724;5504.394516603171;5540.722963851791;5542.057850165482;5554.86112847178;20228.79771202284;20997.79002209989;21162.682559761615;22690;22882.54234915309;2146.1415433826437;2172.2940044485604;2228.5320082782637;2493.3143385568933;2506.9122580709586;9938.453385063818;10755.623553175601;12420.503179872794;14273;14650.550394995169;1791.8745687801859;1838.4392760208132;1936.1287420660758;1940.980590194094;2017.8284845788125;73178.26821731767;83049;86892;87560;90584.09415905822;10807.40559269232;10851.78296434067;11023.283486573348;11107.166962477846;11141.164412669083;15456.304466299043;15503.147326896904;15519.456819011506;15587.688246235011;15625.3749850007;7733.458657894006;7914.643841027168;7939.28546430824;8157.428979971463;8206.097329293772;7566.924330756622;7732.342750866127;7741.303282704584;7924.128345881948;7980.720674776355;4648.930266046012;4753.691010084333;4753.691010084333;4776.546228108324;4881.658283920092;1756.7540544323806;1772.7252275897256;1859.3678149429259;1945.8540609454349;1989.4529004523872;941.5621735892706;944.2351695126969;978.0952618827556;1016.0753714120262;1025.4052649463292;17372.65254694899;18339.633207335777;18500.352487663138;18839.529011774543;18894.338698145773;927.4296307770808;930.5626355612851;952.766572189804;959.6689142245914;961.7595601099725;9580.377275477073;9774;10259.794804103876;10375.16998640107;10448.477576121164;445121;464658;467569;483854;488691;90158.54920725354;90616.54691726499;92531.53734231286;93424.53287733518;93515.53242233745;956.6747305916022;995.2088089968493;1009.3086235928266;1021.9029192226726;1025.261811495722;15619.297131628877;16108.597285067966;16434.178291085158;16455.83544164543;16526.421575244807;39811.80094099627;40631.39052914149;40828.38757418701;41474;41965;56154.719226403606;56554.15168772554;56776.14835777384;57349.426505736075;57621.55946101381;8314.958425207835;8386.622601982803;8482.830343392974;8621.827563448822;8625.67106881151;10588.629397971034;12600.936995314965;12905.225686458842;12920.418581164058;12943.964482841538;10645.148388129086;10871.945640271748;10977;11295.661130166109;11544.82682759776;10521.473926303808;10650.57397704083;10813.080888124598;10889.836652450378;11217.383043932661;10917.454127293444;10928.071113955402;11090.16823738239;11519.712007199887;11906.76186476283;8098.716544921135;8145.470544414594;8172.346212302882;8258.25675689191;8274.83450330978;10990.705912790789;11264.887351126385;11476.311421314747;11503.827442588201;11557.13321500874 18:27:36 INFO - PROCESS | 16109 | |3;mootools.html;1366.97949530757;1440.2366745624815;1481.207553958632;1573.4335639169904;1715.2710098208258;7046.753363632274;8084.31283340916;8292.95853520733;8302.211289927462;8547.273481754042;8369.497830130196;8442.451240669352;8448.704295349664;8451.197136272045;8453.239208471236;2318.397216723651;2345.718513778349;2347.1432926981615;2351.8824058797077;2353.8234632402555;2283.1666441748725;2334.1363695432715;2346.178837406911;2347.7065366829147;2350.5298940212024;2321.3268152235833;2322.4310044039235;2324.651302304651;2344.5076533927895;2359.445530300378;2240.115154513958;2260.7965283124518;2270.920517781878;2282.486440550871;2299.2872209614907;2214.5460180662926;2235.0724449353497;2235.3294011796397;2238.373255488466;2241.1707668162885;8223.712170074079;8294.502329860228;8375.581220938928;8376.120507346703;8413.28487078599;5093.363329583802;5227.3465816772905;5228.241904923765;5246.606504512177;5250.081235783722;3236.2071292533246;3289.3256882339065;3341.6491268416953;3410.471376936579;3417.7778444401283;1077.7736675298197;1112.7496313329516;1897.250586018515;1958.8071443546928;2037.9796202037937;11605.825912611317;11685.649430517098;11797;11819.34993575353;11827.526898924032;4338.913221735547;4346.739195648272;4361.890952726144;4365.650747940157;4549.567791059844;9307.674231401868;9349.953250233706;9360.812783744423;9369.531523423802;9372.343935924557;5009.0983622948215;5095.490450954949;5132.9743351283005;5138.177891537336;5138.511841375063;4312.137572485515;4429.025614364835;4684.765761711969;4747.8575642730775;4771.141194584939;3542.468629705513;3661.56061272649;3707.9073023174096;3734.636857546976;3749.268892565978;1141.9257748246337;1153.3195414705197;1186.0748616079472;1188.1148544334526;1193.546452348102;928.7956649537091;931.2131249094505;943.3962264150812;947.403624892059;981.1513041219293;5544.889102217933;5568.164775283659;5643.322801263875;5728.768314812335;5876.206712093813;428.79846472158033;431.24747315933894;431.27115175353555;438.7806096951524;449.7144313360974;3829.927620266274;3892.649661530419;3942.980285098556;3948.9012774680864;4052.0882801369457;10080.899191007997;10273.332233404804;10339.844902326471;10344.120749736358;10374.17006639467;9977.45124018186;10153.4923253837;10255.9487202565;10296.897031029594;10299;7583.962080189674;7722.073351197892;7835.882461763078;7916.722914697958;7937.325327347125;5476.67139971603;5479.287692599936;5541.362743284574;5582.190582365615;5981.282246130492;9510.85733713981;9520.666776662783;9535.237181025363;9541.236701063759;9547.809043819223;9024.097590240923;9378.906210938076;9389.154976052188;9635.614575417185;9643.228541716786;7212.639368031682;7389.8152546186775;7644.923550764421;7928.286454219148;8104.5137291762685;7876.56678882667;8224.958875205824;8227.71203007892;8255.050669172882;8267.83464330722;7158.355747982707;7374.115106187077;7444.813879652836;7496.437767167376;7706.306432421109;7274.709011639475;7275.090613673291;7308.378787802883;7420.406367490696;7428.888566671396;6468.15913931186;6638.867222655616;6650.667466626746;6653.168353955755;6655.467562595078;4929.457759646364;5051.191809310492;5068.062408454448;5071.518205770446;5342.786288548415;5130.618735973358;5135;5177.637565370388;5190.377154741455;5335.759890804846 18:27:36 INFO - PROCESS | 16109 | |4;prototype.html;318.1632307032504;327.55779697408497;332.4033360118587;348.20956428906396;349.39031390224045;5178.792848286069;5227.660202086867;5231.633785635007;5233.450487698794;5241.344831896013;5188.247704082915;5192.987367463346;5196.610254230929;5197.558207552353;5219.399769026563;3955.42646316284;4047.9797601011956;4056.9391459128137;4065.2479291331124;4075.1034772350035;4048.2308361411237;4097.647776233851;4128.1330920506725;4129.339305711087;4148.232576973254;4073.572274911136;4086.121483880965;4091.6931230157707;4107.281225785476;4108.938365924513;3891.1633998690418;3925.60743925608;3963.5441924178513;4079.1433798902117;4130.80206740045;3610.837512311952;3618.475321078455;3626.909327266813;3627.6372362763514;3635.3274644190647;4997.2004479283505;5001.824936127255;5003.324551185579;5019.723915184663;5026.497350264981;4357;4408.603225709701;4409.735415875058;4657.930131048037;4661.160991021615;5343.519083282523;5357.19642053695;5382.865428364283;5421.674699518042;5430.484104010113;3970.622790834866;3972.463717398143;3991.102002049545;3991.4212439196153;3994;5326.946730532683;5540.030494663418;5551.361593416768;5551.583631227674;5604.411536788619;3992.860249891298;3997.700172487075;4006.419069234945;4013.1973605279063;4013.658838998718;4044.9595504045174;4054.5742697016976;4066.7356621819486;4068.6745060395097;4070;4476.865694029184;4612.907741845212;4624.421947256593;4651.511591282867;4657.115148121846;5279.630425870152;5324.840254792362;5330.253764472977;5331.680099194061;5344.866378340573;1327.2567362277155;1342.41604901868;1344.3412727763325;1356.7015256643522;1367.8426980897325;899.7570655922995;942.9156470059487;950.7195377363694;962.1574684479144;965.8985806490217;4981.476944920803;4990.428015175208;4991.850244492671;4994.675346102492;5008.749562521933;5270.92093618596;5278.366596008504;5279.366476022902;5281.603879709037;5282.286891269706;4765.904681906342;4967.801287948514;4979.775910084055;4983;4996.602310428943;2678.946421071568;2739.465804168208;2761.254461295439;2800.453911487281;2810.7329803668617;5479.465749590121;5563.054280772279;5621.100623900238;5624.71876406178;5632.802851900164;5398.703071331114;5438.673679579238;5442.863928401822;5462.289902312754;5485.753141108659;5257.63196576236;5416.402161362407;5471.7264136793;5484.561235101102;5523.475269849358;5321.866953326198;5327.866803329948;5344.866378340573;5348.796520782793;5364.30264065669;5111.693298402108;5190.900492807099;5288.963748956602;5303.522682958398;5383.2463455117095;5478.315210598676;5490.423505532021;5511;5524.8342549723575;5525.613207075467;3842.5773164952393;3882.22355528901;3893.162969961472;3899.615636449133;3914.9412758809212;5231.42454330031;5361.839144825505;5389.865253368697;5417.729113544386;5418.674879507084;5134.229865520202;5187.962407518436;5213.504717051874;5218.191180367049;5263.894722105613;5218.904030153559;5226.63413561047;5241.475852414728;5246.580273578181;5253.555272300148;4909.828156014522;5171.63798534099;5186.792528298825;5188.948110518997;5192.45479224676;5202.869928251824;5226.790928362975;5237.476252374732;5289.6826190427155;5292.391374991926;5119.46245644202;5123.205903085028;5133.614978876524;5164.631372686166;5204.193350030751 18:27:36 INFO - PROCESS | 16109 | |5;yui.html;702.4836744992431;739.6745432009911;764.02586701955;767.8425922685843;795.7493389582281;14441.711165776678;15270.16014119223;15305.234738263098;15402.922985385072;15451.381944722198;14119.364628591713;14219.289035548232;14242.145471271706;14243.074200177007;14261.643458913506;658.5324419662022;676.0096458688021;766.6626684258908;773.443120952913;793.7579038393317;785.6739453126945;793.4525177627447;794.3922898982283;795.7493389582291;797.2067792546425;845.4039901869168;845.9703910363138;847.2332539052137;847.4025811802665;847.7287268074218;704.9400800931927;840.369722707969;842.4650347029619;843.1105184030876;844.3835999720208;529.6213207556616;598.8592680720027;599.9610025348338;602.9547783916224;614.1494030767419;14296.92851535746;14350.425982960669;14375.496857610038;14382.496612618614;14440.277986100758;12918.741625167444;13172;13400.798988015187;13542.119762215425;13544.984126190477;11894.464749086312;11961.760764784656;12313.19964202333;12396.56612018584;12414.689632759162;4081.8163182656554;4088.7342322748927;4102.979485102555;4119.423280740699;4217.093324935123;54176.72911635456;57894.99999999958;58840;61848;62016;10407.843882341771;10859.78280434387;10865.556216537869;11131.387773672526;11137.721556960978;19323.903380483007;19642.11610477532;19779.307724229584;20041.498962525762;20067;7323.7436689715605;7506.399488040944;7801.843963120706;7923.564203968837;7946.364290856717;4271.594198551133;4273.081287523135;4289.501564295291;4345.34819777036;4390.692651514427;3274.918127046843;3360.7647464677725;3371.2414706690797;3378.5101160331615;3380.3070370573973;582.469952343374;587.6943989125716;591.60362557086;602.8492876780805;605.9787907423218;583.5710752596838;586.3608666553478;614.2475467552302;625.7559551774812;655.6918248423234;8572.785680358042;8783.912160878437;8862.335324850663;8908.777280568038;8965.193132618097;548.8682716148096;606.7239406070228;631.009315374857;644.1979735229576;645.0839807473399;3916.9020774480864;3980.104476492824;3993.9352830866055;4038.63652271297;4077.3680079587116;51162;51323;73481;89143;92796.53601732083;75811.62094189494;78634.6068269655;81251.5937420309;84810.5759471211;86132;68241;70245.2975470249;70382.2961770386;70520.64739676268;71907;7708.535378278109;7714.498557593738;7750.946638558884;7819.452638315263;7902.24928631779;48673.75663121662;48929.60858112572;50190.2471462921;50233;50506.49493505018;62151.689241553504;67875.3212467869;69191.65404172947;70362.29637703762;71249.28750712426;9886.752831179278;9940.552675129491;9978.401295922267;10003.849942250727;10088.092071713581;11373.943130284295;11535.132661486856;11722.355270459866;11729.589464368706;11950.223235489666;10200;10259.333143345957;10376.885046334013;10769.353838769699;11306.886931130583;10396.740081498023;11506.769864602493;11907.175511826881;12117.69705757363;12144.269069164397;11995.220310679779;12030.398480076135;12736.872631273569;12912.8063079052;13428.530001450294;9848.261380396356;9901.207903367856;10322.587096516056;10503.474826258504;10838.349699018085;10296.845547316947;11024.944875275572;11270.267432616854;11284.21010529255;11350.716232094264 18:27:36 INFO - PROCESS | 16109 | __end_tp_report 18:27:36 INFO - PROCESS | 16109 | __start_cc_report 18:27:36 INFO - PROCESS | 16109 | _x_x_mozilla_cycle_collect,2607 18:27:36 INFO - PROCESS | 16109 | __end_cc_report 18:27:36 INFO - PROCESS | 16109 | __startTimestamp1478658456952__endTimestamp 18:27:36 INFO - PROCESS | 16109 | 18:27:36 INFO - PROCESS | 16109 | ------- Summary: start ------- 18:27:36 INFO - PROCESS | 16109 | Number of tests: 6 18:27:36 INFO - PROCESS | 16109 | 18:27:36 INFO - PROCESS | 16109 | [#0] dojo.html Cycles:165 Average:5299.62 Median:5495.97 stddev:601.01 (10.9%) stddev-sans-first:575.43 18:27:36 INFO - PROCESS | 16109 | Values: 3011.7 3060.3 3061.8 3090.5 3111.4 5232.3 5265.9 5316.2 5322.3 5322.5 5331.2 5381.0 5413.7 5422.7 5482.3 4775.5 4810.9 4849.2 4868.1 4879.1 4915.4 4918.8 4980.5 4986.2 5031.9 4765.5 4898.9 4905.6 4920.1 5002.4 4788.0 4869.1 4870.9 4881.8 4887.8 4833.3 4839.8 4850.0 4851.8 4859.2 5311.1 5373.1 5395.0 5414.0 5457.9 5739.8 5768.7 5769.8 5771.7 5774.8 5550.4 5784.0 5836.9 5837.4 5853.2 5232.7 5252.5 5280.1 5293.0 5349.6 5720.4 5757.5 5772.9 5773.8 5775.2 5556.0 5568.3 5568.6 5570.7 5572.4 5516.5 5568.6 5592.2 5645.2 5655.3 5692.6 5698.5 5702.5 5720.9 5745.1 5686.3 5687.5 5691.1 5693.3 5694.3 4263.4 4310.4 4312.7 4333.6 4371.6 3887.0 3910.4 3941.6 3943.9 3957.1 5409.7 5438.4 5453.3 5454.8 5461.5 5594.4 5637.0 5737.8 5784.4 5798.3 5286.7 5347.5 5377.2 5401.3 5445.2 4829.2 4834.1 4834.8 4846.7 4871.8 5785.3 5923.1 5930.6 5934.1 5934.2 5638.4 5676.3 5728.3 5735.5 5826.1 5931.5 5967.8 5976.6 5979.8 5983.4 5600.2 5660.4 5660.7 5662.2 5662.8 5560.3 5609.7 5622.9 5690.6 5707.5 5559.4 5564.1 5569.8 5569.9 5570.4 5546.2 5549.6 5558.1 5559.8 5564.8 5454.8 5482.3 5492.1 5501.7 5502.8 5596.6 5602.4 5602.4 5605.1 5611.9 5449.9 5467.3 5473.9 5485.0 5496.0 18:27:36 INFO - PROCESS | 16109 | 18:27:36 INFO - PROCESS | 16109 | [#1] ext.html Cycles:180 Average:55284.26 Median:19629.69 stddev:107108.28 (545.6%) stddev-sans-first:107329.99 18:27:36 INFO - PROCESS | 16109 | Values: 579.2 595.1 611.7 622.9 628.5 40768.8 42087.2 42089.0 45115.1 45288.8 43216.8 43668.8 43678.6 43681.0 43776.8 7827.7 8007.6 8486.1 8632.0 8636.5 10067.9 10368.3 10378.5 10379.7 10394.1 10307.5 10360.4 10360.7 10376.3 10381.2 10188.5 10238.0 10239.2 10257.5 10263.3 10083.7 10109.0 10116.1 10140.9 10144.2 39869.8 39974.6 40058.0 40229.2 40493.4 3313.3 3341.8 3367.9 3380.2 3407.6 28832.3 30800.8 31242.4 32147.2 32786.2 3773.4 3827.3 3882.5 4014.3 4056.3 337579.0 338774.0 339704.0 339980.0 340370.3 60119.4 60551.4 60564.7 60709.4 60744.4 35890.5 36479.8 36527.5 38690.4 38714.2 15320.9 15422.5 15432.2 15437.8 15439.5 11219.4 11353.8 11715.0 11958.8 11981.9 18930.7 19106.6 19179.7 19210.1 19212.5 6821.9 6915.0 7058.2 7077.9 7121.1 881.4 966.8 981.4 1097.2 1112.9 29886.0 30020.4 30334.2 30857.7 30875.5 985.6 1065.9 1084.8 1120.9 1143.6 15264.2 15932.4 16091.2 16093.5 16408.6 486285.0 486338.0 487210.0 487508.0 489331.0 57191.1 58011.7 58034.0 58036.1 58114.0 1227.5 1251.9 1313.3 1317.6 1333.6 25061.1 26455.7 26986.3 27391.6 27674.4 50270.5 51403.2 51426.2 51438.2 51479.0 371680.0 372293.0 373005.0 373848.0 374443.0 24761.1 25825.4 25828.5 27689.3 28141.6 41776.6 42132.4 42166.8 42904.6 43355.6 35938.3 37128.8 37203.4 37767.0 38652.0 36869.4 37123.4 37346.6 37407.4 37653.6 35851.8 36159.6 37047.4 37263.6 37273.6 30053.0 32672.7 33634.7 33658.3 33749.8 25440.7 25890.6 25927.2 25961.0 26081.7 18:27:36 INFO - PROCESS | 16109 | 18:27:36 INFO - PROCESS | 16109 | [#2] jquery.html Cycles:180 Average:28275.12 Median:40221.60 stddev:77731.61 (193.3%) stddev-sans-first:77921.46 18:27:36 INFO - PROCESS | 16109 | Values: 384.2 393.1 397.0 409.1 414.0 13563.7 15727.9 18317.8 18737.4 19045.2 17828.4 18100.3 18233.5 18337.4 18832.8 5483.4 5700.5 5725.3 5725.6 5726.4 5005.3 6203.7 6240.9 6318.1 6356.3 6042.6 6149.8 6311.7 6320.4 6323.2 6231.1 6254.9 6264.7 6271.5 6271.5 5334.3 5504.4 5540.7 5542.1 5554.9 20228.8 20997.8 21162.7 22690.0 22882.5 2146.1 2172.3 2228.5 2493.3 2506.9 9938.5 10755.6 12420.5 14273.0 14650.6 1791.9 1838.4 1936.1 1941.0 2017.8 73178.3 83049.0 86892.0 87560.0 90584.1 10807.4 10851.8 11023.3 11107.2 11141.2 15456.3 15503.1 15519.5 15587.7 15625.4 7733.5 7914.6 7939.3 8157.4 8206.1 7566.9 7732.3 7741.3 7924.1 7980.7 4648.9 4753.7 4753.7 4776.5 4881.7 1756.8 1772.7 1859.4 1945.9 1989.5 941.6 944.2 978.1 1016.1 1025.4 17372.7 18339.6 18500.4 18839.5 18894.3 927.4 930.6 952.8 959.7 961.8 9580.4 9774.0 10259.8 10375.2 10448.5 445121.0 464658.0 467569.0 483854.0 488691.0 90158.5 90616.5 92531.5 93424.5 93515.5 956.7 995.2 1009.3 1021.9 1025.3 15619.3 16108.6 16434.2 16455.8 16526.4 39811.8 40631.4 40828.4 41474.0 41965.0 56154.7 56554.2 56776.1 57349.4 57621.6 8315.0 8386.6 8482.8 8621.8 8625.7 10588.6 12600.9 12905.2 12920.4 12944.0 10645.1 10871.9 10977.0 11295.7 11544.8 10521.5 10650.6 10813.1 10889.8 11217.4 10917.5 10928.1 11090.2 11519.7 11906.8 8098.7 8145.5 8172.3 8258.3 8274.8 10990.7 11264.9 11476.3 11503.8 11557.1 18:27:36 INFO - PROCESS | 16109 | 18:27:36 INFO - PROCESS | 16109 | [#3] mootools.html Cycles:180 Average:5538.37 Median:5113.05 stddev:3081.97 (60.3%) stddev-sans-first:3074.67 18:27:36 INFO - PROCESS | 16109 | Values: 1367.0 1440.2 1481.2 1573.4 1715.3 7046.8 8084.3 8293.0 8302.2 8547.3 8369.5 8442.5 8448.7 8451.2 8453.2 2318.4 2345.7 2347.1 2351.9 2353.8 2283.2 2334.1 2346.2 2347.7 2350.5 2321.3 2322.4 2324.7 2344.5 2359.4 2240.1 2260.8 2270.9 2282.5 2299.3 2214.5 2235.1 2235.3 2238.4 2241.2 8223.7 8294.5 8375.6 8376.1 8413.3 5093.4 5227.3 5228.2 5246.6 5250.1 3236.2 3289.3 3341.6 3410.5 3417.8 1077.8 1112.7 1897.3 1958.8 2038.0 11605.8 11685.6 11797.0 11819.3 11827.5 4338.9 4346.7 4361.9 4365.7 4549.6 9307.7 9350.0 9360.8 9369.5 9372.3 5009.1 5095.5 5133.0 5138.2 5138.5 4312.1 4429.0 4684.8 4747.9 4771.1 3542.5 3661.6 3707.9 3734.6 3749.3 1141.9 1153.3 1186.1 1188.1 1193.5 928.8 931.2 943.4 947.4 981.2 5544.9 5568.2 5643.3 5728.8 5876.2 428.8 431.2 431.3 438.8 449.7 3829.9 3892.6 3943.0 3948.9 4052.1 10080.9 10273.3 10339.8 10344.1 10374.2 9977.5 10153.5 10255.9 10296.9 10299.0 7584.0 7722.1 7835.9 7916.7 7937.3 5476.7 5479.3 5541.4 5582.2 5981.3 9510.9 9520.7 9535.2 9541.2 9547.8 9024.1 9378.9 9389.2 9635.6 9643.2 7212.6 7389.8 7644.9 7928.3 8104.5 7876.6 8225.0 8227.7 8255.1 8267.8 7158.4 7374.1 7444.8 7496.4 7706.3 7274.7 7275.1 7308.4 7420.4 7428.9 6468.2 6638.9 6650.7 6653.2 6655.5 4929.5 5051.2 5068.1 5071.5 5342.8 5130.6 5135.0 5177.6 5190.4 5335.8 18:27:36 INFO - PROCESS | 16109 | 18:27:36 INFO - PROCESS | 16109 | [#4] prototype.html Cycles:180 Average:4473.74 Median:5149.43 stddev:1282.39 (24.9%) stddev-sans-first:1247.48 18:27:36 INFO - PROCESS | 16109 | Values: 318.2 327.6 332.4 348.2 349.4 5178.8 5227.7 5231.6 5233.5 5241.3 5188.2 5193.0 5196.6 5197.6 5219.4 3955.4 4048.0 4056.9 4065.2 4075.1 4048.2 4097.6 4128.1 4129.3 4148.2 4073.6 4086.1 4091.7 4107.3 4108.9 3891.2 3925.6 3963.5 4079.1 4130.8 3610.8 3618.5 3626.9 3627.6 3635.3 4997.2 5001.8 5003.3 5019.7 5026.5 4357.0 4408.6 4409.7 4657.9 4661.2 5343.5 5357.2 5382.9 5421.7 5430.5 3970.6 3972.5 3991.1 3991.4 3994.0 5326.9 5540.0 5551.4 5551.6 5604.4 3992.9 3997.7 4006.4 4013.2 4013.7 4045.0 4054.6 4066.7 4068.7 4070.0 4476.9 4612.9 4624.4 4651.5 4657.1 5279.6 5324.8 5330.3 5331.7 5344.9 1327.3 1342.4 1344.3 1356.7 1367.8 899.8 942.9 950.7 962.2 965.9 4981.5 4990.4 4991.9 4994.7 5008.7 5270.9 5278.4 5279.4 5281.6 5282.3 4765.9 4967.8 4979.8 4983.0 4996.6 2678.9 2739.5 2761.3 2800.5 2810.7 5479.5 5563.1 5621.1 5624.7 5632.8 5398.7 5438.7 5442.9 5462.3 5485.8 5257.6 5416.4 5471.7 5484.6 5523.5 5321.9 5327.9 5344.9 5348.8 5364.3 5111.7 5190.9 5289.0 5303.5 5383.2 5478.3 5490.4 5511.0 5524.8 5525.6 3842.6 3882.2 3893.2 3899.6 3914.9 5231.4 5361.8 5389.9 5417.7 5418.7 5134.2 5188.0 5213.5 5218.2 5263.9 5218.9 5226.6 5241.5 5246.6 5253.6 4909.8 5171.6 5186.8 5188.9 5192.5 5202.9 5226.8 5237.5 5289.7 5292.4 5119.5 5123.2 5133.6 5164.6 5204.2 18:27:36 INFO - PROCESS | 16109 | 18:27:36 INFO - PROCESS | 16109 | [#5] yui.html Cycles:180 Average:17337.52 Median:51242.50 stddev:23284.62 (45.4%) stddev-sans-first:23316.44 18:27:36 INFO - PROCESS | 16109 | Values: 702.5 739.7 764.0 767.8 795.7 14441.7 15270.2 15305.2 15402.9 15451.4 14119.4 14219.3 14242.1 14243.1 14261.6 658.5 676.0 766.7 773.4 793.8 785.7 793.5 794.4 795.7 797.2 845.4 846.0 847.2 847.4 847.7 704.9 840.4 842.5 843.1 844.4 529.6 598.9 600.0 603.0 614.1 14296.9 14350.4 14375.5 14382.5 14440.3 12918.7 13172.0 13400.8 13542.1 13545.0 11894.5 11961.8 12313.2 12396.6 12414.7 4081.8 4088.7 4103.0 4119.4 4217.1 54176.7 57895.0 58840.0 61848.0 62016.0 10407.8 10859.8 10865.6 11131.4 11137.7 19323.9 19642.1 19779.3 20041.5 20067.0 7323.7 7506.4 7801.8 7923.6 7946.4 4271.6 4273.1 4289.5 4345.3 4390.7 3274.9 3360.8 3371.2 3378.5 3380.3 582.5 587.7 591.6 602.8 606.0 583.6 586.4 614.2 625.8 655.7 8572.8 8783.9 8862.3 8908.8 8965.2 548.9 606.7 631.0 644.2 645.1 3916.9 3980.1 3993.9 4038.6 4077.4 51162.0 51323.0 73481.0 89143.0 92796.5 75811.6 78634.6 81251.6 84810.6 86132.0 68241.0 70245.3 70382.3 70520.6 71907.0 7708.5 7714.5 7750.9 7819.5 7902.2 48673.8 48929.6 50190.2 50233.0 50506.5 62151.7 67875.3 69191.7 70362.3 71249.3 9886.8 9940.6 9978.4 10003.8 10088.1 11373.9 11535.1 11722.4 11729.6 11950.2 10200.0 10259.3 10376.9 10769.4 11306.9 10396.7 11506.8 11907.2 12117.7 12144.3 11995.2 12030.4 12736.9 12912.8 13428.5 9848.3 9901.2 10322.6 10503.5 10838.3 10296.8 11024.9 11270.3 11284.2 11350.7 18:27:36 INFO - PROCESS | 16109 | -------- Summary: end -------- 18:27:36 INFO - PROCESS | 16109 | 18:27:37 INFO - TEST-INFO | 16109: exit 0 18:27:37 INFO - TEST-OK | dromaeo_css | took 1118799ms 18:27:37 INFO - TEST-START | kraken 18:27:37 INFO - operating with platform_type : linux_ 18:27:37 INFO - Initialising browser for kraken test... 18:27:37 INFO - TEST-INFO | started process 16417 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUrHIqQ/profile http://localhost:57763/getInfo.html) 18:27:42 INFO - PROCESS | 16417 | __metrics Screen width/height:1600/1200 18:27:42 INFO - PROCESS | 16417 | colorDepth:24 18:27:42 INFO - PROCESS | 16417 | Browser inner width/height: 1024/697 18:27:42 INFO - PROCESS | 16417 | __metrics 18:27:42 INFO - PROCESS | 16417 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 18:27:42 INFO - PROCESS | 16417 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:27:43 INFO - PROCESS | 16417 | console.error: PushService: 18:27:43 INFO - PROCESS | 16417 | stateChangeProcessEnqueue: Error transitioning state 18:27:43 INFO - PROCESS | 16417 | UnknownError 18:27:44 INFO - TEST-INFO | 16417: exit 0 18:27:44 INFO - Browser initialized. 18:27:44 INFO - Running cycle 1/1 for kraken test... 18:27:44 INFO - TEST-INFO | started process 16503 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUrHIqQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:27:56 INFO - PROCESS | 16503 | RSS: Main: 172785664 18:27:56 INFO - PROCESS | 16503 | 18:27:58 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57763/tests/kraken/driver.html?testName=audio-beat-detection) 18:27:59 INFO - PROCESS | 16503 | RSS: Main: 229576704 18:27:59 INFO - PROCESS | 16503 | 18:28:02 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57763/tests/kraken/driver.html?testName=audio-dft) 18:28:02 INFO - PROCESS | 16503 | RSS: Main: 216166400 18:28:02 INFO - PROCESS | 16503 | 18:28:06 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57763/tests/kraken/driver.html?testName=audio-fft) 18:28:06 INFO - PROCESS | 16503 | RSS: Main: 297619456 18:28:06 INFO - PROCESS | 16503 | 18:28:08 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57763/tests/kraken/driver.html?testName=audio-oscillator) 18:28:09 INFO - PROCESS | 16503 | RSS: Main: 209461248 18:28:09 INFO - PROCESS | 16503 | 18:28:11 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57763/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:28:12 INFO - PROCESS | 16503 | RSS: Main: 212750336 18:28:12 INFO - PROCESS | 16503 | 18:28:15 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57763/tests/kraken/driver.html?testName=imaging-darkroom) 18:28:15 INFO - PROCESS | 16503 | RSS: Main: 248369152 18:28:15 INFO - PROCESS | 16503 | 18:28:18 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57763/tests/kraken/driver.html?testName=imaging-desaturate) 18:28:19 INFO - PROCESS | 16503 | RSS: Main: 247156736 18:28:19 INFO - PROCESS | 16503 | 18:28:22 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57763/tests/kraken/driver.html?testName=json-parse-financial) 18:28:22 INFO - PROCESS | 16503 | RSS: Main: 246435840 18:28:22 INFO - PROCESS | 16503 | 18:28:24 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57763/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:28:24 INFO - PROCESS | 16503 | RSS: Main: 209174528 18:28:24 INFO - PROCESS | 16503 | 18:28:26 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57763/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:28:27 INFO - PROCESS | 16503 | RSS: Main: 217133056 18:28:27 INFO - PROCESS | 16503 | 18:28:29 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57763/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:28:29 INFO - PROCESS | 16503 | RSS: Main: 225296384 18:28:29 INFO - PROCESS | 16503 | 18:28:32 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57763/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:28:33 INFO - PROCESS | 16503 | RSS: Main: 234229760 18:28:33 INFO - PROCESS | 16503 | 18:28:36 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57763/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:28:36 INFO - PROCESS | 16503 | RSS: Main: 230957056 18:28:36 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | Cycle 1(1): loaded http://localhost:57763/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57763/tests/kraken/driver.html?testName=ai-astar) 18:28:38 INFO - PROCESS | 16503 | RSS: Main: 282140672 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | __start_tp_report 18:28:38 INFO - PROCESS | 16503 | _x_x_mozilla_page_load 18:28:38 INFO - PROCESS | 16503 | _x_x_mozilla_page_load_details 18:28:38 INFO - PROCESS | 16503 | |i|pagename|runs| 18:28:38 INFO - PROCESS | 16503 | |0;ai-astar;104;111;112;113;113;113;111;112;111;112 18:28:38 INFO - PROCESS | 16503 | |1;audio-beat-detection;148;125;123;159;123;122;123;122;157;124 18:28:38 INFO - PROCESS | 16503 | |2;audio-dft;161;161;161;160;163;160;162;162;163;163 18:28:38 INFO - PROCESS | 16503 | |3;audio-fft;75;86;76;121;78;77;78;78;103;75 18:28:38 INFO - PROCESS | 16503 | |4;audio-oscillator;83;83;115;83;84;84;109;83;83;113 18:28:38 INFO - PROCESS | 16503 | |5;imaging-gaussian-blur;117;117;116;117;117;117;117;117;117;116 18:28:38 INFO - PROCESS | 16503 | |6;imaging-darkroom;146;145;147;145;146;148;147;146;147;147 18:28:38 INFO - PROCESS | 16503 | |7;imaging-desaturate;85;85;85;84;84;85;85;84;86;85 18:28:38 INFO - PROCESS | 16503 | |8;json-parse-financial;55;51;51;53;52;54;56;52;52;53 18:28:38 INFO - PROCESS | 16503 | |9;json-stringify-tinderbox;62;63;62;62;62;62;62;62;63;62 18:28:38 INFO - PROCESS | 16503 | |10;stanford-crypto-aes;80;79;79;80;81;85;79;89;78;79 18:28:38 INFO - PROCESS | 16503 | |11;stanford-crypto-ccm;131;137;147;130;131;139;130;135;173;147 18:28:38 INFO - PROCESS | 16503 | |12;stanford-crypto-pbkdf2;165;170;165;162;162;167;163;164;168;164 18:28:38 INFO - PROCESS | 16503 | |13;stanford-crypto-sha256-iterative;65;65;65;64;68;66;68;63;63;64 18:28:38 INFO - PROCESS | 16503 | __end_tp_report 18:28:38 INFO - PROCESS | 16503 | __start_cc_report 18:28:38 INFO - PROCESS | 16503 | _x_x_mozilla_cycle_collect,1730 18:28:38 INFO - PROCESS | 16503 | __end_cc_report 18:28:38 INFO - PROCESS | 16503 | __startTimestamp1478658518615__endTimestamp 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | ------- Summary: start ------- 18:28:38 INFO - PROCESS | 16503 | Number of tests: 14 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#0] ai-astar Cycles:10 Average:111.20 Median:112.00 stddev:2.66 (2.4%) stddev-sans-first:0.87 18:28:38 INFO - PROCESS | 16503 | Values: 104.0 111.0 112.0 113.0 113.0 113.0 111.0 112.0 111.0 112.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#1] audio-beat-detection Cycles:10 Average:132.60 Median:124.50 stddev:15.50 (12.5%) stddev-sans-first:15.41 18:28:38 INFO - PROCESS | 16503 | Values: 148.0 125.0 123.0 159.0 123.0 122.0 123.0 122.0 157.0 124.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#2] audio-dft Cycles:10 Average:161.60 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 18:28:38 INFO - PROCESS | 16503 | Values: 161.0 161.0 161.0 160.0 163.0 160.0 162.0 162.0 163.0 163.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#3] audio-fft Cycles:10 Average:84.70 Median:77.50 stddev:15.32 (19.8%) stddev-sans-first:15.84 18:28:38 INFO - PROCESS | 16503 | Values: 75.0 86.0 76.0 121.0 78.0 77.0 78.0 78.0 103.0 75.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#4] audio-oscillator Cycles:10 Average:92.00 Median:83.00 stddev:14.11 (17.0%) stddev-sans-first:14.59 18:28:38 INFO - PROCESS | 16503 | Values: 83.0 83.0 115.0 83.0 84.0 84.0 109.0 83.0 83.0 113.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:28:38 INFO - PROCESS | 16503 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.97 (0.7%) stddev-sans-first:1.01 18:28:38 INFO - PROCESS | 16503 | Values: 146.0 145.0 147.0 145.0 146.0 148.0 147.0 146.0 147.0 147.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#7] imaging-desaturate Cycles:10 Average:84.80 Median:85.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 18:28:38 INFO - PROCESS | 16503 | Values: 85.0 85.0 85.0 84.0 84.0 85.0 85.0 84.0 86.0 85.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#8] json-parse-financial Cycles:10 Average:52.90 Median:53.00 stddev:1.66 (3.1%) stddev-sans-first:1.58 18:28:38 INFO - PROCESS | 16503 | Values: 55.0 51.0 51.0 53.0 52.0 54.0 56.0 52.0 52.0 53.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#9] json-stringify-tinderbox Cycles:10 Average:62.20 Median:62.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 18:28:38 INFO - PROCESS | 16503 | Values: 62.0 63.0 62.0 62.0 62.0 62.0 62.0 62.0 63.0 62.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.00 stddev:3.45 (4.3%) stddev-sans-first:3.64 18:28:38 INFO - PROCESS | 16503 | Values: 80.0 79.0 79.0 80.0 81.0 85.0 79.0 89.0 78.0 79.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#11] stanford-crypto-ccm Cycles:10 Average:140.00 Median:138.00 stddev:13.27 (9.6%) stddev-sans-first:13.67 18:28:38 INFO - PROCESS | 16503 | Values: 131.0 137.0 147.0 130.0 131.0 139.0 130.0 135.0 173.0 147.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:165.00 stddev:2.62 (1.6%) stddev-sans-first:2.78 18:28:38 INFO - PROCESS | 16503 | Values: 165.0 170.0 165.0 162.0 162.0 167.0 163.0 164.0 168.0 164.0 18:28:38 INFO - PROCESS | 16503 | 18:28:38 INFO - PROCESS | 16503 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.10 Median:65.00 stddev:1.79 (2.8%) stddev-sans-first:1.90 18:28:38 INFO - PROCESS | 16503 | Values: 65.0 65.0 65.0 64.0 68.0 66.0 68.0 63.0 63.0 64.0 18:28:38 INFO - PROCESS | 16503 | -------- Summary: end -------- 18:28:38 INFO - PROCESS | 16503 | 18:28:39 INFO - TEST-INFO | 16503: exit 0 18:28:39 INFO - TEST-OK | kraken | took 62024ms 18:28:39 INFO - SUITE-END | took 1180s 18:28:40 INFO - Completed test suite (00:19:41) 18:28:40 INFO - javascript benchmark 18:28:40 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3011.6837732038134, 3060.3420264643096, 3061.8162910225383, 3090.520969249767, 3111.3621707549955, 5232.3459567554055, 5265.921011184831, 5316.175992721134, 5322.281491998579, 5322.520973112419, 5331.2003199520095, 5381.031414345416, 5413.702246376448, 5422.701751403681, 5482.342118945732, 4775.522447755231, 4810.855674329759, 4849.224124140138, 4868.123737727207, 4879.097366987119, 4915.3855768029, 4918.778654960517, 4980.501949805009, 4986.177280748672, 5031.874203144914, 4765.475797662254, 4898.853034408973, 4905.583025442842, 4920.114379411704, 5002.374703162105, 4787.952120478785, 4869.099216644932, 4870.878228044292, 4881.829135980223, 4887.804487820483, 4833.29917162013, 4839.782209800567, 4850.005748821518, 4851.781669824866, 4859.222524396115, 5311.123664595337, 5373.113436283009, 5395.0, 5413.972930135364, 5457.863553411157, 5739.799107031234, 5768.711564421762, 5769.769209231626, 5771.682557459338, 5774.797882074149, 5550.417206193332, 5783.971080144573, 5836.941630583682, 5837.416258374129, 5853.180554722342, 5232.738363081869, 5252.527272545489, 5280.075986702312, 5292.9735351323, 5349.5720342372515, 5720.370759216483, 5757.510611598061, 5772.942270577324, 5773.769049238067, 5775.220345253337, 5555.999920014437, 5568.303962004749, 5568.6101972862325, 5570.749316280696, 5572.4148964358155, 5516.531094856982, 5568.638038527482, 5592.217089607459, 5645.1532270159805, 5655.321361436654, 5692.6015178937905, 5698.515626171739, 5702.54379649627, 5720.914186287209, 5745.080787074048, 5686.346070201897, 5687.51656109227, 5691.146328050825, 5693.259876216065, 5694.316681998187, 4263.381809637585, 4310.396544483775, 4312.741235525878, 4333.631641310524, 4371.584699453547, 3887.00881275273, 3910.3743401055694, 3941.5664276929515, 3943.940840887389, 3957.050307926135, 5409.702466364388, 5438.374586922476, 5453.291072160594, 5454.836354909359, 5461.481159289861, 5594.440555944373, 5637.041702910515, 5737.799177028784, 5784.3926387729525, 5798.33319168301, 5286.682799032071, 5347.465253474699, 5377.193420986883, 5401.3248343957, 5445.156000819879, 4829.1790395632825, 4834.081524510332, 4834.830780922651, 4846.733429661403, 4871.756412179377, 5785.334686511105, 5923.08192230205, 5930.584859059824, 5934.080217566284, 5934.228550288435, 5638.37977822431, 5676.318841739017, 5728.255326807488, 5735.512481439125, 5826.096954971986, 5931.466168044896, 5967.8209653710455, 5976.641401515923, 5979.790707325396, 5983.401659833982, 5600.215969764317, 5660.405657405913, 5660.660360378391, 5662.235598194191, 5662.801801936913, 5560.277163968658, 5609.719514024364, 5622.9156562652415, 5690.601657883908, 5707.543396528351, 5559.444055594408, 5564.137558678412, 5569.832905012856, 5569.888602228014, 5570.359408668055, 5546.195801608825, 5549.5837812165055, 5558.138488534284, 5559.777608895599, 5564.777408903598, 5454.836354909359, 5482.2873026506295, 5492.148716948879, 5501.724913754216, 5502.8349149525575, 5596.580256480699, 5602.3837377887585, 5602.383737788921, 5605.131204663284, 5611.915821262603, 5449.891002179855, 5467.343918729778, 5473.945260547343, 5484.972575137099, 5495.972520137374], "value": 5258.866092868082, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [579.1891352107051, 595.1221947627249, 611.7491828350375, 622.9065640153979, 628.481502760223, 40768.79615601921, 42087.158256834846, 42089.0, 45115.0976980461, 45288.773556132255, 43216.78391608038, 43668.781656091756, 43678.563214367845, 43681.0, 43776.781116094375, 7827.6868925242925, 8007.559584222866, 8486.066532681385, 8632.0, 8636.481811091324, 10067.89932100677, 10368.326058806191, 10378.481075946172, 10379.740506487322, 10394.06453419192, 10307.484625768682, 10360.37837729735, 10360.740981475448, 10376.325538839988, 10381.221408394364, 10188.541515631778, 10237.999999999925, 10239.180865530778, 10257.538410771458, 10263.332883362558, 10083.697489075339, 10109.0, 10116.14012808912, 10140.89859101407, 10144.239182061376, 39869.80065099685, 39974.60025399767, 40058.0, 40229.19541609151, 40493.39259911104, 3313.3042061167184, 3341.832908354597, 3367.932641347184, 3380.222548813762, 3407.557017587698, 28832.27919302013, 30800.845995769876, 31242.37515249705, 32147.196320091953, 32786.18034549132, 3773.415120656303, 3827.2919509890758, 3882.5340959085092, 4014.337634290368, 4056.290149223874, 337579.0, 338774.0, 339704.0, 339980.0, 340370.29814851016, 60119.39880601226, 60551.394486054574, 60564.69717651472, 60709.392906070374, 60744.39255607387, 35890.461643075374, 36479.817600911825, 36527.4520882187, 38690.41964370537, 38714.22571548553, 15320.923395382952, 15422.537323880302, 15432.151231682365, 15437.768433473508, 15439.536813895602, 11219.439028048564, 11353.772924541629, 11715.0, 11958.760824783456, 11981.88018119825, 18930.716039259423, 19106.61786764257, 19179.712304315446, 19210.13554390028, 19212.519687007938, 6821.908494640834, 6915.0, 7058.188308344504, 7077.893831592531, 7121.074260346122, 881.4094556647062, 966.8259713251541, 981.3866333541537, 1097.1990446973755, 1112.8608923884515, 29886.0, 30020.399592008038, 30334.241643959078, 30857.69142308593, 30875.536866947015, 985.5860538573672, 1065.94137322448, 1084.8426978088132, 1120.9495572699248, 1143.5940241214248, 15264.236788160548, 15932.362705491882, 16091.195440227943, 16093.517194484184, 16408.589785255463, 486285.0, 486338.0, 487210.0, 487508.0, 489331.0, 57191.14213286804, 58011.709941450026, 58034.0, 58036.12945805816, 58114.0, 1227.4844565282604, 1251.8685538018376, 1313.3236383262818, 1317.5981325695564, 1333.6265845563257, 25061.122860699787, 26455.735442645328, 26986.325341865824, 27391.589126163522, 27674.44651107007, 50270.49729502658, 51403.2289515665, 51426.228606570185, 51438.22842657438, 51479.0, 371680.0, 372293.0, 373005.0, 373848.0, 374443.0, 24761.133360332304, 25825.354366140244, 25828.48343033091, 27689.307767305978, 28141.57787633228, 41776.58223417727, 42132.368014479194, 42166.789166053975, 42904.57095429006, 43355.566444335156, 35938.28123437464, 37128.81435592805, 37203.44194837025, 37767.0, 38652.0, 36869.36351456764, 37123.44314835226, 37346.626533734314, 37407.43888841615, 37653.62346376501, 35851.82074089613, 36159.63840361563, 37047.444288336235, 37263.62736372602, 37273.627263727016, 30053.0, 32672.673273266962, 33634.66365336315, 33658.32683346368, 33749.83125084359, 25440.74559254458, 25890.61164082578, 25927.22218333453, 25961.0, 26081.73918260793], "value": 19178.904273765835, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.1663590009679, 393.1292187804015, 396.99206015879685, 409.1469286537569, 413.9777188434497, 13563.728725425486, 15727.921360393211, 18317.816821831777, 18737.43787686368, 19045.2381904724, 17828.37600683973, 18100.275988960424, 18233.54416139597, 18337.358192463267, 18832.81167188331, 5483.424240454765, 5700.543956483471, 5725.312962444513, 5725.627834190765, 5726.427357264281, 5005.324281222043, 6203.720832562523, 6240.937590624104, 6318.136149835809, 6356.269029061647, 6042.57701960863, 6149.815505534819, 6311.747530098791, 6320.367963203666, 6323.177986861701, 6231.127642130105, 6254.906176407358, 6264.718087686019, 6271.498280137578, 6271.529635277349, 5334.27987221724, 5504.394516603171, 5540.722963851791, 5542.057850165482, 5554.86112847178, 20228.79771202284, 20997.79002209989, 21162.682559761615, 22690.0, 22882.54234915309, 2146.1415433826437, 2172.2940044485604, 2228.5320082782637, 2493.3143385568933, 2506.9122580709586, 9938.453385063818, 10755.623553175601, 12420.503179872794, 14273.0, 14650.550394995169, 1791.8745687801859, 1838.4392760208132, 1936.1287420660758, 1940.980590194094, 2017.8284845788125, 73178.26821731767, 83049.0, 86892.0, 87560.0, 90584.09415905822, 10807.40559269232, 10851.78296434067, 11023.283486573348, 11107.166962477846, 11141.164412669083, 15456.304466299043, 15503.147326896904, 15519.456819011506, 15587.688246235011, 15625.3749850007, 7733.458657894006, 7914.643841027168, 7939.28546430824, 8157.428979971463, 8206.097329293772, 7566.924330756622, 7732.342750866127, 7741.303282704584, 7924.128345881948, 7980.720674776355, 4648.930266046012, 4753.691010084333, 4753.691010084333, 4776.546228108324, 4881.658283920092, 1756.7540544323806, 1772.7252275897256, 1859.3678149429259, 1945.8540609454349, 1989.4529004523872, 941.5621735892706, 944.2351695126969, 978.0952618827556, 1016.0753714120262, 1025.4052649463292, 17372.65254694899, 18339.633207335777, 18500.352487663138, 18839.529011774543, 18894.338698145773, 927.4296307770808, 930.5626355612851, 952.766572189804, 959.6689142245914, 961.7595601099725, 9580.377275477073, 9774.0, 10259.794804103876, 10375.16998640107, 10448.477576121164, 445121.0, 464658.0, 467569.0, 483854.0, 488691.0, 90158.54920725354, 90616.54691726499, 92531.53734231286, 93424.53287733518, 93515.53242233745, 956.6747305916022, 995.2088089968493, 1009.3086235928266, 1021.9029192226726, 1025.261811495722, 15619.297131628877, 16108.597285067966, 16434.178291085158, 16455.83544164543, 16526.421575244807, 39811.80094099627, 40631.39052914149, 40828.38757418701, 41474.0, 41965.0, 56154.719226403606, 56554.15168772554, 56776.14835777384, 57349.426505736075, 57621.55946101381, 8314.958425207835, 8386.622601982803, 8482.830343392974, 8621.827563448822, 8625.67106881151, 10588.629397971034, 12600.936995314965, 12905.225686458842, 12920.418581164058, 12943.964482841538, 10645.148388129086, 10871.945640271748, 10977.0, 11295.661130166109, 11544.82682759776, 10521.473926303808, 10650.57397704083, 10813.080888124598, 10889.836652450378, 11217.383043932661, 10917.454127293444, 10928.071113955402, 11090.16823738239, 11519.712007199887, 11906.76186476283, 8098.716544921135, 8145.470544414594, 8172.346212302882, 8258.25675689191, 8274.83450330978, 10990.705912790789, 11264.887351126385, 11476.311421314747, 11503.827442588201, 11557.13321500874], "value": 9088.477543782175, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1366.97949530757, 1440.2366745624815, 1481.207553958632, 1573.4335639169904, 1715.2710098208258, 7046.753363632274, 8084.31283340916, 8292.95853520733, 8302.211289927462, 8547.273481754042, 8369.497830130196, 8442.451240669352, 8448.704295349664, 8451.197136272045, 8453.239208471236, 2318.397216723651, 2345.718513778349, 2347.1432926981615, 2351.8824058797077, 2353.8234632402555, 2283.1666441748725, 2334.1363695432715, 2346.178837406911, 2347.7065366829147, 2350.5298940212024, 2321.3268152235833, 2322.4310044039235, 2324.651302304651, 2344.5076533927895, 2359.445530300378, 2240.115154513958, 2260.7965283124518, 2270.920517781878, 2282.486440550871, 2299.2872209614907, 2214.5460180662926, 2235.0724449353497, 2235.3294011796397, 2238.373255488466, 2241.1707668162885, 8223.712170074079, 8294.502329860228, 8375.581220938928, 8376.120507346703, 8413.28487078599, 5093.363329583802, 5227.3465816772905, 5228.241904923765, 5246.606504512177, 5250.081235783722, 3236.2071292533246, 3289.3256882339065, 3341.6491268416953, 3410.471376936579, 3417.7778444401283, 1077.7736675298197, 1112.7496313329516, 1897.250586018515, 1958.8071443546928, 2037.9796202037937, 11605.825912611317, 11685.649430517098, 11797.0, 11819.34993575353, 11827.526898924032, 4338.913221735547, 4346.739195648272, 4361.890952726144, 4365.650747940157, 4549.567791059844, 9307.674231401868, 9349.953250233706, 9360.812783744423, 9369.531523423802, 9372.343935924557, 5009.0983622948215, 5095.490450954949, 5132.9743351283005, 5138.177891537336, 5138.511841375063, 4312.137572485515, 4429.025614364835, 4684.765761711969, 4747.8575642730775, 4771.141194584939, 3542.468629705513, 3661.56061272649, 3707.9073023174096, 3734.636857546976, 3749.268892565978, 1141.9257748246337, 1153.3195414705197, 1186.0748616079472, 1188.1148544334526, 1193.546452348102, 928.7956649537091, 931.2131249094505, 943.3962264150812, 947.403624892059, 981.1513041219293, 5544.889102217933, 5568.164775283659, 5643.322801263875, 5728.768314812335, 5876.206712093813, 428.79846472158033, 431.24747315933894, 431.27115175353555, 438.7806096951524, 449.7144313360974, 3829.927620266274, 3892.649661530419, 3942.980285098556, 3948.9012774680864, 4052.0882801369457, 10080.899191007997, 10273.332233404804, 10339.844902326471, 10344.120749736358, 10374.17006639467, 9977.45124018186, 10153.4923253837, 10255.9487202565, 10296.897031029594, 10299.0, 7583.962080189674, 7722.073351197892, 7835.882461763078, 7916.722914697958, 7937.325327347125, 5476.67139971603, 5479.287692599936, 5541.362743284574, 5582.190582365615, 5981.282246130492, 9510.85733713981, 9520.666776662783, 9535.237181025363, 9541.236701063759, 9547.809043819223, 9024.097590240923, 9378.906210938076, 9389.154976052188, 9635.614575417185, 9643.228541716786, 7212.639368031682, 7389.8152546186775, 7644.923550764421, 7928.286454219148, 8104.5137291762685, 7876.56678882667, 8224.958875205824, 8227.71203007892, 8255.050669172882, 8267.83464330722, 7158.355747982707, 7374.115106187077, 7444.813879652836, 7496.437767167376, 7706.306432421109, 7274.709011639475, 7275.090613673291, 7308.378787802883, 7420.406367490696, 7428.888566671396, 6468.15913931186, 6638.867222655616, 6650.667466626746, 6653.168353955755, 6655.467562595078, 4929.457759646364, 5051.191809310492, 5068.062408454448, 5071.518205770446, 5342.786288548415, 5130.618735973358, 5135.0, 5177.637565370388, 5190.377154741455, 5335.759890804846], "value": 4420.788068871486, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [318.1632307032504, 327.55779697408497, 332.4033360118587, 348.20956428906396, 349.39031390224045, 5178.792848286069, 5227.660202086867, 5231.633785635007, 5233.450487698794, 5241.344831896013, 5188.247704082915, 5192.987367463346, 5196.610254230929, 5197.558207552353, 5219.399769026563, 3955.42646316284, 4047.9797601011956, 4056.9391459128137, 4065.2479291331124, 4075.1034772350035, 4048.2308361411237, 4097.647776233851, 4128.1330920506725, 4129.339305711087, 4148.232576973254, 4073.572274911136, 4086.121483880965, 4091.6931230157707, 4107.281225785476, 4108.938365924513, 3891.1633998690418, 3925.60743925608, 3963.5441924178513, 4079.1433798902117, 4130.80206740045, 3610.837512311952, 3618.475321078455, 3626.909327266813, 3627.6372362763514, 3635.3274644190647, 4997.2004479283505, 5001.824936127255, 5003.324551185579, 5019.723915184663, 5026.497350264981, 4357.0, 4408.603225709701, 4409.735415875058, 4657.930131048037, 4661.160991021615, 5343.519083282523, 5357.19642053695, 5382.865428364283, 5421.674699518042, 5430.484104010113, 3970.622790834866, 3972.463717398143, 3991.102002049545, 3991.4212439196153, 3994.0, 5326.946730532683, 5540.030494663418, 5551.361593416768, 5551.583631227674, 5604.411536788619, 3992.860249891298, 3997.700172487075, 4006.419069234945, 4013.1973605279063, 4013.658838998718, 4044.9595504045174, 4054.5742697016976, 4066.7356621819486, 4068.6745060395097, 4070.0, 4476.865694029184, 4612.907741845212, 4624.421947256593, 4651.511591282867, 4657.115148121846, 5279.630425870152, 5324.840254792362, 5330.253764472977, 5331.680099194061, 5344.866378340573, 1327.2567362277155, 1342.41604901868, 1344.3412727763325, 1356.7015256643522, 1367.8426980897325, 899.7570655922995, 942.9156470059487, 950.7195377363694, 962.1574684479144, 965.8985806490217, 4981.476944920803, 4990.428015175208, 4991.850244492671, 4994.675346102492, 5008.749562521933, 5270.92093618596, 5278.366596008504, 5279.366476022902, 5281.603879709037, 5282.286891269706, 4765.904681906342, 4967.801287948514, 4979.775910084055, 4983.0, 4996.602310428943, 2678.946421071568, 2739.465804168208, 2761.254461295439, 2800.453911487281, 2810.7329803668617, 5479.465749590121, 5563.054280772279, 5621.100623900238, 5624.71876406178, 5632.802851900164, 5398.703071331114, 5438.673679579238, 5442.863928401822, 5462.289902312754, 5485.753141108659, 5257.63196576236, 5416.402161362407, 5471.7264136793, 5484.561235101102, 5523.475269849358, 5321.866953326198, 5327.866803329948, 5344.866378340573, 5348.796520782793, 5364.30264065669, 5111.693298402108, 5190.900492807099, 5288.963748956602, 5303.522682958398, 5383.2463455117095, 5478.315210598676, 5490.423505532021, 5511.0, 5524.8342549723575, 5525.613207075467, 3842.5773164952393, 3882.22355528901, 3893.162969961472, 3899.615636449133, 3914.9412758809212, 5231.42454330031, 5361.839144825505, 5389.865253368697, 5417.729113544386, 5418.674879507084, 5134.229865520202, 5187.962407518436, 5213.504717051874, 5218.191180367049, 5263.894722105613, 5218.904030153559, 5226.63413561047, 5241.475852414728, 5246.580273578181, 5253.555272300148, 4909.828156014522, 5171.63798534099, 5186.792528298825, 5188.948110518997, 5192.45479224676, 5202.869928251824, 5226.790928362975, 5237.476252374732, 5289.6826190427155, 5292.391374991926, 5119.46245644202, 5123.205903085028, 5133.614978876524, 5164.631372686166, 5204.193350030751], "value": 4069.537227788873, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [702.4836744992431, 739.6745432009911, 764.02586701955, 767.8425922685843, 795.7493389582281, 14441.711165776678, 15270.16014119223, 15305.234738263098, 15402.922985385072, 15451.381944722198, 14119.364628591713, 14219.289035548232, 14242.145471271706, 14243.074200177007, 14261.643458913506, 658.5324419662022, 676.0096458688021, 766.6626684258908, 773.443120952913, 793.7579038393317, 785.6739453126945, 793.4525177627447, 794.3922898982283, 795.7493389582291, 797.2067792546425, 845.4039901869168, 845.9703910363138, 847.2332539052137, 847.4025811802665, 847.7287268074218, 704.9400800931927, 840.369722707969, 842.4650347029619, 843.1105184030876, 844.3835999720208, 529.6213207556616, 598.8592680720027, 599.9610025348338, 602.9547783916224, 614.1494030767419, 14296.92851535746, 14350.425982960669, 14375.496857610038, 14382.496612618614, 14440.277986100758, 12918.741625167444, 13172.0, 13400.798988015187, 13542.119762215425, 13544.984126190477, 11894.464749086312, 11961.760764784656, 12313.19964202333, 12396.56612018584, 12414.689632759162, 4081.8163182656554, 4088.7342322748927, 4102.979485102555, 4119.423280740699, 4217.093324935123, 54176.72911635456, 57894.99999999958, 58840.0, 61848.0, 62016.0, 10407.843882341771, 10859.78280434387, 10865.556216537869, 11131.387773672526, 11137.721556960978, 19323.903380483007, 19642.11610477532, 19779.307724229584, 20041.498962525762, 20067.0, 7323.7436689715605, 7506.399488040944, 7801.843963120706, 7923.564203968837, 7946.364290856717, 4271.594198551133, 4273.081287523135, 4289.501564295291, 4345.34819777036, 4390.692651514427, 3274.918127046843, 3360.7647464677725, 3371.2414706690797, 3378.5101160331615, 3380.3070370573973, 582.469952343374, 587.6943989125716, 591.60362557086, 602.8492876780805, 605.9787907423218, 583.5710752596838, 586.3608666553478, 614.2475467552302, 625.7559551774812, 655.6918248423234, 8572.785680358042, 8783.912160878437, 8862.335324850663, 8908.777280568038, 8965.193132618097, 548.8682716148096, 606.7239406070228, 631.009315374857, 644.1979735229576, 645.0839807473399, 3916.9020774480864, 3980.104476492824, 3993.9352830866055, 4038.63652271297, 4077.3680079587116, 51162.0, 51323.0, 73481.0, 89143.0, 92796.53601732083, 75811.62094189494, 78634.6068269655, 81251.5937420309, 84810.5759471211, 86132.0, 68241.0, 70245.2975470249, 70382.2961770386, 70520.64739676268, 71907.0, 7708.535378278109, 7714.498557593738, 7750.946638558884, 7819.452638315263, 7902.24928631779, 48673.75663121662, 48929.60858112572, 50190.2471462921, 50233.0, 50506.49493505018, 62151.689241553504, 67875.3212467869, 69191.65404172947, 70362.29637703762, 71249.28750712426, 9886.752831179278, 9940.552675129491, 9978.401295922267, 10003.849942250727, 10088.092071713581, 11373.943130284295, 11535.132661486856, 11722.355270459866, 11729.589464368706, 11950.223235489666, 10200.0, 10259.333143345957, 10376.885046334013, 10769.353838769699, 11306.886931130583, 10396.740081498023, 11506.769864602493, 11907.175511826881, 12117.69705757363, 12144.269069164397, 11995.220310679779, 12030.398480076135, 12736.872631273569, 12912.8063079052, 13428.530001450294, 9848.261380396356, 9901.207903367856, 10322.587096516056, 10503.474826258504, 10838.349699018085, 10296.845547316947, 11024.944875275572, 11270.267432616854, 11284.21010529255, 11350.716232094264], "value": 6797.9211127781, "unit": "score"}], "name": "dromaeo_css", "value": 6944.043178209246, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 111.0, 112.0, 113.0, 113.0, 113.0, 111.0, 112.0, 111.0, 112.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 125.0, 123.0, 159.0, 123.0, 122.0, 123.0, 122.0, 157.0, 124.0], "value": 132.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 163.0, 160.0, 162.0, 162.0, 163.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 86.0, 76.0, 121.0, 78.0, 77.0, 78.0, 78.0, 103.0, 75.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 115.0, 83.0, 84.0, 84.0, 109.0, 83.0, 83.0, 113.0], "value": 92.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 147.0, 145.0, 146.0, 148.0, 147.0, 146.0, 147.0, 147.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 85.0, 84.0, 84.0, 85.0, 85.0, 84.0, 86.0, 85.0], "value": 84.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 51.0, 51.0, 53.0, 52.0, 54.0, 56.0, 52.0, 52.0, 53.0], "value": 52.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 62.0, 62.0, 62.0, 62.0, 63.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 79.0, 79.0, 80.0, 81.0, 85.0, 79.0, 89.0, 78.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 137.0, 147.0, 130.0, 131.0, 139.0, 130.0, 135.0, 173.0, 147.0], "value": 140.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 170.0, 165.0, 162.0, 162.0, 167.0, 163.0, 164.0, 168.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 68.0, 66.0, 68.0, 63.0, 63.0, 64.0], "value": 65.1, "unit": "score"}], "name": "kraken", "value": 1496.1999999999998, "alertThreshold": 2.0}]} 18:28:40 INFO - Return code: 0 18:28:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:28:40 INFO - # TBPL SUCCESS # 18:28:40 INFO - Running post-action listener: _resource_record_post_action 18:28:40 INFO - [mozharness: 2016-11-09 02:28:40.410795Z] Finished run-tests step (success) 18:28:40 INFO - Running post-run listener: _resource_record_post_run 18:28:40 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 390496256; Read time: 12; Write time: 231100 18:28:40 INFO - TinderboxPrint: CPU usage
13.2% 18:28:40 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 18:28:40 INFO - TinderboxPrint: I/O write bytes / time
390,496,256 / 231,100 18:28:40 INFO - TinderboxPrint: CPU idle
8,300.8 (86.8%) 18:28:40 INFO - TinderboxPrint: CPU user
1,207.9 (12.6%) 18:28:40 INFO - TinderboxPrint: Swap in / out
0 / 0 18:28:40 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 102670336; Read time: 0; Write time: 55860 18:28:40 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 286511104; Read time: 0; Write time: 175156 18:28:41 INFO - Running post-run listener: _upload_blobber_files 18:28:41 INFO - Blob upload gear active. 18:28:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:28:41 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 18:28:41 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'] 18:28:41 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 18:28:41 INFO - (blobuploader) - INFO - Open directory for files ... 18:28:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:28:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:28:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:28:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:28:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:28:42 INFO - (blobuploader) - INFO - Done attempting. 18:28:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:28:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:28:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:28:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:28:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:28:45 INFO - (blobuploader) - INFO - Done attempting. 18:28:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:28:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:28:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:28:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:28:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:28:46 INFO - (blobuploader) - INFO - Done attempting. 18:28:46 INFO - (blobuploader) - INFO - Iteration through files over. 18:28:46 INFO - Return code: 0 18:28:46 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:28:46 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:28:46 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2d747dffab2cfee9afdb528345e4a3cb91c59be4ec4ac50ee688a941270b8973ce67b62ad30b140e818c4405479dae8c652ded4dec3d1bc88fb9a1b130f04baf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d8262c6c0ccaa5f8aa7082ed6728a6ce93211ac22ec58d41fa548d73a6107899a2f9a9506a231dc598013846268e40ffbf63ce57b35cedc2420b854ed7ab48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3f986e54be29140a656a6592715453060fb2d9256527470b3d5dfc614d5eeef2a2b021a72a4246a42e77e440bb9ac874e7549527ceef224ac39483177d7ac34f"} 18:28:46 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:28:46 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:28:46 INFO - Contents: 18:28:46 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2d747dffab2cfee9afdb528345e4a3cb91c59be4ec4ac50ee688a941270b8973ce67b62ad30b140e818c4405479dae8c652ded4dec3d1bc88fb9a1b130f04baf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d8262c6c0ccaa5f8aa7082ed6728a6ce93211ac22ec58d41fa548d73a6107899a2f9a9506a231dc598013846268e40ffbf63ce57b35cedc2420b854ed7ab48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3f986e54be29140a656a6592715453060fb2d9256527470b3d5dfc614d5eeef2a2b021a72a4246a42e77e440bb9ac874e7549527ceef224ac39483177d7ac34f"} 18:28:46 INFO - Running post-run listener: copy_logs_to_upload_dir 18:28:46 INFO - Copying logs to upload dir... 18:28:46 INFO - mkdir: /builds/slave/test/build/upload/logs 18:28:46 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.644448 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-11-08 18:28:45.759537) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 18:28:45.762612) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2d747dffab2cfee9afdb528345e4a3cb91c59be4ec4ac50ee688a941270b8973ce67b62ad30b140e818c4405479dae8c652ded4dec3d1bc88fb9a1b130f04baf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d8262c6c0ccaa5f8aa7082ed6728a6ce93211ac22ec58d41fa548d73a6107899a2f9a9506a231dc598013846268e40ffbf63ce57b35cedc2420b854ed7ab48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3f986e54be29140a656a6592715453060fb2d9256527470b3d5dfc614d5eeef2a2b021a72a4246a42e77e440bb9ac874e7549527ceef224ac39483177d7ac34f"} build_url:https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/eJuhHSS1TNagQZRwrLiDxA/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/2d747dffab2cfee9afdb528345e4a3cb91c59be4ec4ac50ee688a941270b8973ce67b62ad30b140e818c4405479dae8c652ded4dec3d1bc88fb9a1b130f04baf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/5d8262c6c0ccaa5f8aa7082ed6728a6ce93211ac22ec58d41fa548d73a6107899a2f9a9506a231dc598013846268e40ffbf63ce57b35cedc2420b854ed7ab48f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3f986e54be29140a656a6592715453060fb2d9256527470b3d5dfc614d5eeef2a2b021a72a4246a42e77e440bb9ac874e7549527ceef224ac39483177d7ac34f"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-11-08 18:28:45.787478) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 18:28:45.787787) ========= 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=516f8d7ca085b4d087ab0a71000001a4-1478656070.428952-435615029 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004523 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-11-08 18:28:45.869974) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 18:28:45.870296) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-11-08 18:28:45.870586) ========= ========= Total master_lag: 0.16 =========