builder: mozilla-aurora_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-035 starttime: 1481298762.07 results: success (0) buildid: 20161209060650 builduid: 2c3fc1794d494affa82dcfdfc9689e0a revision: f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:42.069441) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:42.070075) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:42.070394) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:42.085488) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:42.085874) ========= 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=ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-12-09 07:52:42-- 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% 38.6M=0s 2016-12-09 07:52:42 (38.6 MB/s) - `archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.299111 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:42.400668) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:42.401041) ========= 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=ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014179 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:42.451150) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-09 07:52:42.451555) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 --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=ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-12-09 07:52:42,507 truncating revision to first 12 chars 2016-12-09 07:52:42,507 Setting DEBUG logging. 2016-12-09 07:52:42,507 attempt 1/10 2016-12-09 07:52:42,507 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/f6f2e2b9fa87?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-12-09 07:52:43,500 unpacking tar archive at: mozilla-aurora-f6f2e2b9fa87/testing/mozharness/ program finished with exit code 0 elapsedTime=1.329816 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-12-09 07:52:43.795516) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:43.795931) ========= script_repo_revision: f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:43.796391) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:43.796698) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-12-09 07:52:43.810180) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-09 07:52:43.810514) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:52:43 INFO - MultiFileLogger online at 20161209 07:52:43 in /builds/slave/test 07:52:43 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 07:52:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:52:43 INFO - {'append_to_log': False, 07:52:43 INFO - 'base_work_dir': '/builds/slave/test', 07:52:43 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 07:52:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:52:43 INFO - 'branch': 'Mozilla-Aurora', 07:52:43 INFO - 'buildbot_json_path': 'buildprops.json', 07:52:43 INFO - 'config_files': ('talos/linux_config.py',), 07:52:43 INFO - 'default_actions': ('clobber', 07:52:43 INFO - 'read-buildbot-config', 07:52:43 INFO - 'download-and-extract', 07:52:43 INFO - 'populate-webroot', 07:52:43 INFO - 'create-virtualenv', 07:52:43 INFO - 'install', 07:52:43 INFO - 'run-tests'), 07:52:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:52:43 INFO - 'download_minidump_stackwalk': True, 07:52:43 INFO - 'download_symbols': 'ondemand', 07:52:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:52:43 INFO - 'tooltool.py': '/tools/tooltool.py', 07:52:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:52:43 INFO - '/tools/misc-python/virtualenv.py')}, 07:52:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:52:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:52:43 INFO - 'installer_path': 'installer.exe', 07:52:43 INFO - 'log_level': 'info', 07:52:43 INFO - 'log_name': 'talos', 07:52:43 INFO - 'log_to_console': True, 07:52:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:52:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:52:43 INFO - 'opt_config_files': (), 07:52:43 INFO - 'pip_index': False, 07:52:43 INFO - 'sps_profile': False, 07:52:43 INFO - 'sps_profile_interval': 0, 07:52:43 INFO - 'suite': 'dromaeojs', 07:52:43 INFO - 'system_bits': '32', 07:52:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:52:43 INFO - 'title': 'talos-linux64-ix-035', 07:52:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:52:43 INFO - 'use_talos_json': True, 07:52:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:52:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:52:43 INFO - 'work_dir': 'build'} 07:52:43 INFO - [mozharness: 2016-12-09 15:52:43.957595Z] Running clobber step. 07:52:43 INFO - Running pre-action listener: _resource_record_pre_action 07:52:43 INFO - Running main action method: clobber 07:52:43 INFO - rmtree: /builds/slave/test/build 07:52:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:52:44 INFO - Running post-action listener: _resource_record_post_action 07:52:44 INFO - [mozharness: 2016-12-09 15:52:44.451877Z] Finished clobber step (success) 07:52:44 INFO - [mozharness: 2016-12-09 15:52:44.451977Z] Running read-buildbot-config step. 07:52:44 INFO - Running pre-action listener: _resource_record_pre_action 07:52:44 INFO - Running main action method: read_buildbot_config 07:52:44 INFO - Using buildbot properties: 07:52:44 INFO - { 07:52:44 INFO - "project": "", 07:52:44 INFO - "product": "firefox", 07:52:44 INFO - "script_repo_revision": "production", 07:52:44 INFO - "builddir": "mozilla-aurora_ubuntu64_hw_test-dromaeojs", 07:52:44 INFO - "repository": "", 07:52:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-aurora pgo talos dromaeojs", 07:52:44 INFO - "buildid": "20161209060650", 07:52:44 INFO - "pgo_build": "True", 07:52:44 INFO - "basedir": "/builds/slave/test", 07:52:44 INFO - "buildnumber": 955, 07:52:44 INFO - "slavename": "talos-linux64-ix-035", 07:52:44 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 07:52:44 INFO - "platform": "ubuntu64_hw", 07:52:44 INFO - "scheduler": "tests-mozilla-aurora-linux64-pgo-talos", 07:52:44 INFO - "branch": "mozilla-aurora", 07:52:44 INFO - "repo_path": "releases/mozilla-aurora", 07:52:44 INFO - "revision": "f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0", 07:52:44 INFO - "stage_platform": "linux64-pgo", 07:52:44 INFO - "builduid": "2c3fc1794d494affa82dcfdfc9689e0a", 07:52:44 INFO - "slavebuilddir": "test" 07:52:44 INFO - } 07:52:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2. 07:52:44 INFO - Running post-action listener: _resource_record_post_action 07:52:44 INFO - [mozharness: 2016-12-09 15:52:44.454414Z] Finished read-buildbot-config step (success) 07:52:44 INFO - [mozharness: 2016-12-09 15:52:44.454502Z] Running download-and-extract step. 07:52:44 INFO - Running pre-action listener: _resource_record_pre_action 07:52:44 INFO - Running main action method: download_and_extract 07:52:44 INFO - mkdir: /builds/slave/test/build/tests 07:52:44 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')]} 07:52:44 INFO - trying https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:52:44 INFO - Downloading https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:52:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json'}, attempt #1 07:52:45 INFO - Downloaded 1361 bytes. 07:52:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.test_packages.json 07:52:45 INFO - Using the following test package requirements: 07:52:45 INFO - {u'common': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:52:45 INFO - u'cppunittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.cppunittest.tests.zip'], 07:52:45 INFO - u'gtest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.gtest.tests.zip'], 07:52:45 INFO - u'jittest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:45 INFO - u'jsshell-linux-x86_64.zip'], 07:52:45 INFO - u'mochitest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.mochitest.tests.zip'], 07:52:45 INFO - u'mozbase': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'], 07:52:45 INFO - u'reftest': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.reftest.tests.zip'], 07:52:45 INFO - u'talos': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'], 07:52:45 INFO - u'web-platform': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.web-platform.tests.zip'], 07:52:45 INFO - u'xpcshell': [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', 07:52:45 INFO - u'firefox-52.0a2.en-US.linux-x86_64.xpcshell.tests.zip']} 07:52:45 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:52:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:52:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:52:45 INFO - Fetch https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:52:45 INFO - Http code: 200 07:52:45 INFO - via: 1.1 37af14ee951b12568cf1cc160d08abe6.cloudfront.net (CloudFront) 07:52:45 INFO - x-amz-cf-id: 0dg88Xq3UDu87Q5G_suNOzKel-34aMEMFx9610RVqV4glEL6jfwYiw== 07:52:45 INFO - x-amz-version-id: G9ni41nfNPVfXrF7p8UJwjQZjt8b0oGS 07:52:45 INFO - Expected file size: 21953522 07:52:45 INFO - Obtained file size: 21953522 07:52:49 INFO - Downloading packages: [u'firefox-52.0a2.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 07:52:49 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip 07:52:49 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip'}, attempt #1 07:52:49 INFO - Fetch https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.common.tests.zip into memory 07:52:50 INFO - Http code: 200 07:52:50 INFO - via: 1.1 ba26a6eef2785fa2e20e601890b882b2.cloudfront.net (CloudFront) 07:52:50 INFO - x-amz-cf-id: 2NgJnnfIWV3A_6-ZEtKoW2ZKX-lGUPpJXup8nLPP49HHFNjptNoOSA== 07:52:50 INFO - x-amz-version-id: G9ni41nfNPVfXrF7p8UJwjQZjt8b0oGS 07:52:50 INFO - Expected file size: 21953522 07:52:50 INFO - Obtained file size: 21953522 07:52:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip 07:52:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 07:52:55 INFO - Fetch https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.talos.tests.zip into memory 07:52:55 INFO - Http code: 200 07:52:55 INFO - via: 1.1 24b0e5a3429d07ef12381da50e07f70f.cloudfront.net (CloudFront) 07:52:55 INFO - x-amz-cf-id: Lfq23DEK-EOuu2A9Ar405QaCG83CGzaJuUXtqOKt0lF1qWtj0_oRsg== 07:52:55 INFO - x-amz-version-id: mduqXIjpjy1HOkZ9.88dWEo5z6q6Fr_E 07:52:55 INFO - Expected file size: 14409038 07:52:55 INFO - Obtained file size: 14409038 07:52:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:52:56 INFO - trying https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:52:56 INFO - Downloading https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:52:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2'}, attempt #1 07:52:57 INFO - Downloaded 64001941 bytes. 07:52:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:52:57 INFO - mkdir: /builds/slave/test/properties 07:52:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:52:57 INFO - Writing to file /builds/slave/test/properties/build_url 07:52:57 INFO - Contents: 07:52:57 INFO - build_url:https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 07:52:57 INFO - Running post-action listener: _resource_record_post_action 07:52:57 INFO - Running post-action listener: set_extra_try_arguments 07:52:57 INFO - [mozharness: 2016-12-09 15:52:57.902186Z] Finished download-and-extract step (success) 07:52:57 INFO - [mozharness: 2016-12-09 15:52:57.902412Z] Running populate-webroot step. 07:52:57 INFO - Running pre-action listener: _resource_record_pre_action 07:52:57 INFO - Running main action method: populate_webroot 07:52:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:52:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:52:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:52:57 INFO - '--tppagecycles', 07:52:57 INFO - '7'], 07:52:57 INFO - 'tests': ['tsvgm']}}, 07:52:57 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:52:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:52:57 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:52:57 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:52:57 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:52:57 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:52:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:57 INFO - 'talos_options': ['--disable-e10s'], 07:52:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:52:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:57 INFO - 'talos_options': ['--disable-e10s'], 07:52:57 INFO - 'tests': ['damp', 'tps']}, 07:52:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:57 INFO - 'tests': ['damp', 'tps']}, 07:52:57 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:52:57 INFO - 'tests': ['dromaeo_dom']}, 07:52:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:52:57 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:52:57 INFO - 'tests': ['basic_compositor_video']}, 07:52:57 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:52:57 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:52:57 INFO - 'tests': ['a11yr', 07:52:57 INFO - 'ts_paint', 07:52:57 INFO - 'tpaint', 07:52:57 INFO - 'sessionrestore', 07:52:57 INFO - 'sessionrestore_no_auto_restore', 07:52:57 INFO - 'tabpaint']}, 07:52:57 INFO - 'other-e10s': {'tests': ['a11yr', 07:52:57 INFO - 'ts_paint', 07:52:57 INFO - 'tpaint', 07:52:57 INFO - 'sessionrestore', 07:52:57 INFO - 'sessionrestore_no_auto_restore', 07:52:57 INFO - 'tabpaint']}, 07:52:57 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:52:57 INFO - 'ts_paint', 07:52:57 INFO - 'tpaint', 07:52:57 INFO - 'sessionrestore', 07:52:57 INFO - 'sessionrestore_no_auto_restore', 07:52:57 INFO - 'tabpaint']}, 07:52:57 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:52:57 INFO - 'ts_paint', 07:52:57 INFO - 'tpaint', 07:52:57 INFO - 'sessionrestore', 07:52:57 INFO - 'sessionrestore_no_auto_restore', 07:52:57 INFO - 'tabpaint']}, 07:52:57 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:52:57 INFO - 'tests': ['a11yr', 07:52:57 INFO - 'ts_paint', 07:52:57 INFO - 'tpaint', 07:52:57 INFO - 'sessionrestore', 07:52:57 INFO - 'sessionrestore_no_auto_restore', 07:52:57 INFO - 'tabpaint']}, 07:52:57 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:52:57 INFO - 'tests': ['a11yr', 07:52:57 INFO - 'ts_paint', 07:52:57 INFO - 'tpaint', 07:52:57 INFO - 'sessionrestore', 07:52:57 INFO - 'sessionrestore_no_auto_restore', 07:52:57 INFO - 'tabpaint']}, 07:52:57 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:52:57 INFO - 'tests': ['tsvgx', 07:52:57 INFO - 'tsvgr_opacity', 07:52:57 INFO - 'tart', 07:52:57 INFO - 'tscrollx', 07:52:57 INFO - 'cart']}, 07:52:57 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:52:57 INFO - 'tsvgr_opacity', 07:52:57 INFO - 'tart', 07:52:57 INFO - 'tscrollx', 07:52:57 INFO - 'cart']}, 07:52:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:57 INFO - 'talos_options': ['--disable-e10s'], 07:52:57 INFO - 'tests': ['tp5o']}, 07:52:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:57 INFO - 'tests': ['tp5o']}, 07:52:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:57 INFO - 'talos_options': ['--disable-e10s', 07:52:57 INFO - '--xperf_path', 07:52:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:57 INFO - 'tests': ['tp5n']}, 07:52:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:52:57 INFO - 'talos_options': ['--xperf_path', 07:52:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:52:57 INFO - 'tests': ['tp5n']}}, 07:52:57 INFO - 'talos.zip': {'path': '', 07:52:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:52:57 INFO - Running post-action listener: _resource_record_post_action 07:52:57 INFO - [mozharness: 2016-12-09 15:52:57.920086Z] Finished populate-webroot step (success) 07:52:57 INFO - [mozharness: 2016-12-09 15:52:57.920173Z] Running create-virtualenv step. 07:52:57 INFO - Running pre-action listener: _resource_record_pre_action 07:52:57 INFO - Running main action method: create_virtualenv 07:52:57 INFO - Creating virtualenv /builds/slave/test/build/venv 07:52:57 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 07:52:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:52:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:52:58 INFO - Using real prefix '/usr' 07:52:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:52:58 INFO - Installing distribute.............................................................................................................................................................................................done. 07:53:00 INFO - Installing pip.................done. 07:53:00 INFO - Return code: 0 07:53:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:53:00 INFO - Reading from file tmpfile_stdout 07:53:00 INFO - Output received: 07:53:00 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) 07:53:00 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f384efd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967f60>, '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 0x2968d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29691d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', '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 07:53:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 07:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 07:53:00 INFO - Using env: {'DISPLAY': ':0', 07:53:00 INFO - 'HOME': '/home/cltbld', 07:53:00 INFO - 'LANG': 'en_US.UTF-8', 07:53:00 INFO - 'LANGUAGE': 'en_US:en', 07:53:00 INFO - 'LOGNAME': 'cltbld', 07:53:00 INFO - 'MAIL': '/var/mail/cltbld', 07:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:00 INFO - 'MOZ_NO_REMOTE': '1', 07:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:00 INFO - 'NO_EM_RESTART': '1', 07:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:00 INFO - 'PWD': '/builds/slave/test', 07:53:00 INFO - 'SHELL': '/bin/bash', 07:53:00 INFO - 'SHLVL': '1', 07:53:00 INFO - 'TERM': 'linux', 07:53:00 INFO - 'TMOUT': '86400', 07:53:00 INFO - 'USER': 'cltbld', 07:53:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', 07:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:00 INFO - '_': '/tools/buildbot/bin/python'} 07:53:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:00 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 07:53:00 INFO - Cleaning up... 07:53:00 INFO - Return code: 0 07:53:00 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f384efd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967f60>, '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 0x2968d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29691d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', '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 07:53:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 07:53:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 07:53:00 INFO - Using env: {'DISPLAY': ':0', 07:53:00 INFO - 'HOME': '/home/cltbld', 07:53:00 INFO - 'LANG': 'en_US.UTF-8', 07:53:00 INFO - 'LANGUAGE': 'en_US:en', 07:53:00 INFO - 'LOGNAME': 'cltbld', 07:53:00 INFO - 'MAIL': '/var/mail/cltbld', 07:53:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:00 INFO - 'MOZ_NO_REMOTE': '1', 07:53:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:00 INFO - 'NO_EM_RESTART': '1', 07:53:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:00 INFO - 'PWD': '/builds/slave/test', 07:53:00 INFO - 'SHELL': '/bin/bash', 07:53:00 INFO - 'SHLVL': '1', 07:53:00 INFO - 'TERM': 'linux', 07:53:00 INFO - 'TMOUT': '86400', 07:53:00 INFO - 'USER': 'cltbld', 07:53:00 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', 07:53:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:00 INFO - '_': '/tools/buildbot/bin/python'} 07:53:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:01 INFO - Downloading/unpacking psutil>=3.1.1 07:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:53:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:03 INFO - Installing collected packages: psutil 07:53:03 INFO - Running setup.py install for psutil 07:53:03 INFO - building 'psutil._psutil_linux' extension 07:53:03 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 07:53:03 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 07:53:03 INFO - building 'psutil._psutil_posix' extension 07:53:03 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 07:53:03 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 07:53:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:53:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:53:03 INFO - Successfully installed psutil 07:53:03 INFO - Cleaning up... 07:53:03 INFO - Return code: 0 07:53:03 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:53:03 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')]} 07:53:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:03 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')]} 07:53:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:03 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 0x7f384efd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967f60>, '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 0x2968d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29691d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', '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 07:53:03 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 07:53:03 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 07:53:03 INFO - Using env: {'DISPLAY': ':0', 07:53:03 INFO - 'HOME': '/home/cltbld', 07:53:03 INFO - 'LANG': 'en_US.UTF-8', 07:53:03 INFO - 'LANGUAGE': 'en_US:en', 07:53:03 INFO - 'LOGNAME': 'cltbld', 07:53:03 INFO - 'MAIL': '/var/mail/cltbld', 07:53:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:03 INFO - 'MOZ_NO_REMOTE': '1', 07:53:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:03 INFO - 'NO_EM_RESTART': '1', 07:53:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:03 INFO - 'PWD': '/builds/slave/test', 07:53:03 INFO - 'SHELL': '/bin/bash', 07:53:03 INFO - 'SHLVL': '1', 07:53:03 INFO - 'TERM': 'linux', 07:53:03 INFO - 'TMOUT': '86400', 07:53:03 INFO - 'USER': 'cltbld', 07:53:03 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', 07:53:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:03 INFO - '_': '/tools/buildbot/bin/python'} 07:53:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:53:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:53:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:53:06 INFO - Installing collected packages: mozsystemmonitor 07:53:06 INFO - Running setup.py install for mozsystemmonitor 07:53:06 INFO - Successfully installed mozsystemmonitor 07:53:06 INFO - Cleaning up... 07:53:06 INFO - Return code: 0 07:53:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:53:06 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')]} 07:53:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:06 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')]} 07:53:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:06 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 0x7f384efd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967f60>, '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 0x2968d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29691d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', '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 07:53:06 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 07:53:06 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 07:53:06 INFO - Using env: {'DISPLAY': ':0', 07:53:06 INFO - 'HOME': '/home/cltbld', 07:53:06 INFO - 'LANG': 'en_US.UTF-8', 07:53:06 INFO - 'LANGUAGE': 'en_US:en', 07:53:06 INFO - 'LOGNAME': 'cltbld', 07:53:06 INFO - 'MAIL': '/var/mail/cltbld', 07:53:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:06 INFO - 'MOZ_NO_REMOTE': '1', 07:53:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:06 INFO - 'NO_EM_RESTART': '1', 07:53:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:06 INFO - 'PWD': '/builds/slave/test', 07:53:06 INFO - 'SHELL': '/bin/bash', 07:53:06 INFO - 'SHLVL': '1', 07:53:06 INFO - 'TERM': 'linux', 07:53:06 INFO - 'TMOUT': '86400', 07:53:06 INFO - 'USER': 'cltbld', 07:53:06 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', 07:53:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:06 INFO - '_': '/tools/buildbot/bin/python'} 07:53:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:06 INFO - Downloading/unpacking jsonschema==2.5.1 07:53:06 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 07:53:06 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 07:53:06 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 07:53:06 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 07:53:06 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 07:53:06 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 07:53:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:53:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:53:08 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 07:53:08 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 07:53:08 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 07:53:08 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 07:53:08 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 07:53:08 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 07:53:08 INFO - Downloading functools32-3.2.3-2.tar.gz 07:53:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:53:08 INFO - warning: no files found matching '*.txt' 07:53:08 INFO - no previously-included directories found matching 'build' 07:53:08 INFO - no previously-included directories found matching 'dist' 07:53:08 INFO - no previously-included directories found matching '.git*' 07:53:08 INFO - Installing collected packages: jsonschema, functools32 07:53:08 INFO - Running setup.py install for functools32 07:53:08 INFO - warning: no files found matching '*.txt' 07:53:08 INFO - no previously-included directories found matching 'build' 07:53:08 INFO - no previously-included directories found matching 'dist' 07:53:08 INFO - no previously-included directories found matching '.git*' 07:53:08 INFO - Successfully installed jsonschema functools32 07:53:08 INFO - Cleaning up... 07:53:08 INFO - Return code: 0 07:53:08 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:08 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 0x7f384efd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967f60>, '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 0x2968d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29691d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', '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 07:53:08 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 07:53:08 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 07:53:08 INFO - Using env: {'DISPLAY': ':0', 07:53:08 INFO - 'HOME': '/home/cltbld', 07:53:08 INFO - 'LANG': 'en_US.UTF-8', 07:53:08 INFO - 'LANGUAGE': 'en_US:en', 07:53:08 INFO - 'LOGNAME': 'cltbld', 07:53:08 INFO - 'MAIL': '/var/mail/cltbld', 07:53:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:08 INFO - 'MOZ_NO_REMOTE': '1', 07:53:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:08 INFO - 'NO_EM_RESTART': '1', 07:53:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:08 INFO - 'PWD': '/builds/slave/test', 07:53:08 INFO - 'SHELL': '/bin/bash', 07:53:08 INFO - 'SHLVL': '1', 07:53:08 INFO - 'TERM': 'linux', 07:53:08 INFO - 'TMOUT': '86400', 07:53:08 INFO - 'USER': 'cltbld', 07:53:08 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', 07:53:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:08 INFO - '_': '/tools/buildbot/bin/python'} 07:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:53:09 INFO - Cleaning up... 07:53:09 INFO - Return code: 0 07:53:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:09 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 0x7f384efd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967f60>, '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 0x2968d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29691d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', '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 07:53:09 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 07:53:09 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 07:53:09 INFO - Using env: {'DISPLAY': ':0', 07:53:09 INFO - 'HOME': '/home/cltbld', 07:53:09 INFO - 'LANG': 'en_US.UTF-8', 07:53:09 INFO - 'LANGUAGE': 'en_US:en', 07:53:09 INFO - 'LOGNAME': 'cltbld', 07:53:09 INFO - 'MAIL': '/var/mail/cltbld', 07:53:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:09 INFO - 'MOZ_NO_REMOTE': '1', 07:53:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:09 INFO - 'NO_EM_RESTART': '1', 07:53:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:09 INFO - 'PWD': '/builds/slave/test', 07:53:09 INFO - 'SHELL': '/bin/bash', 07:53:09 INFO - 'SHLVL': '1', 07:53:09 INFO - 'TERM': 'linux', 07:53:09 INFO - 'TMOUT': '86400', 07:53:09 INFO - 'USER': 'cltbld', 07:53:09 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', 07:53:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:09 INFO - '_': '/tools/buildbot/bin/python'} 07:53:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:09 INFO - Downloading/unpacking blobuploader==1.2.4 07:53:09 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 07:53:09 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 07:53:09 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 07:53:09 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 07:53:09 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 07:53:09 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 07:53:11 INFO - Downloading blobuploader-1.2.4.tar.gz 07:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:53:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:53:11 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:53:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:53:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:53:12 INFO - Downloading docopt-0.6.1.tar.gz 07:53:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:53:12 INFO - Installing collected packages: blobuploader, requests, docopt 07:53:12 INFO - Running setup.py install for blobuploader 07:53:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:53:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:53:12 INFO - Running setup.py install for requests 07:53:12 INFO - Running setup.py install for docopt 07:53:12 INFO - Successfully installed blobuploader requests docopt 07:53:12 INFO - Cleaning up... 07:53:12 INFO - Return code: 0 07:53:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:12 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 0x7f384efd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967f60>, '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 0x2968d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29691d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', '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 07:53:12 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 07:53:12 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 07:53:12 INFO - Using env: {'DISPLAY': ':0', 07:53:12 INFO - 'HOME': '/home/cltbld', 07:53:12 INFO - 'LANG': 'en_US.UTF-8', 07:53:12 INFO - 'LANGUAGE': 'en_US:en', 07:53:12 INFO - 'LOGNAME': 'cltbld', 07:53:12 INFO - 'MAIL': '/var/mail/cltbld', 07:53:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:12 INFO - 'MOZ_NO_REMOTE': '1', 07:53:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:12 INFO - 'NO_EM_RESTART': '1', 07:53:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:12 INFO - 'PWD': '/builds/slave/test', 07:53:12 INFO - 'SHELL': '/bin/bash', 07:53:12 INFO - 'SHLVL': '1', 07:53:12 INFO - 'TERM': 'linux', 07:53:12 INFO - 'TMOUT': '86400', 07:53:12 INFO - 'USER': 'cltbld', 07:53:12 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', 07:53:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:12 INFO - '_': '/tools/buildbot/bin/python'} 07:53:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:13 INFO - Running setup.py (path:/tmp/pip-KEcsmI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:13 INFO - Running setup.py (path:/tmp/pip-0gTHFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:13 INFO - Running setup.py (path:/tmp/pip-g8avfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:13 INFO - Running setup.py (path:/tmp/pip-ClkqYW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:13 INFO - Running setup.py (path:/tmp/pip-zXV29M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:13 INFO - Running setup.py (path:/tmp/pip-QhzkdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:13 INFO - Running setup.py (path:/tmp/pip-oDzscQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:13 INFO - Running setup.py (path:/tmp/pip-EH3rBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:13 INFO - Running setup.py (path:/tmp/pip-5KRtQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:13 INFO - Running setup.py (path:/tmp/pip-XhgkrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:13 INFO - Running setup.py (path:/tmp/pip-AZ7PYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:13 INFO - Running setup.py (path:/tmp/pip-uqZiud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:13 INFO - Running setup.py (path:/tmp/pip-krKjiD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:13 INFO - Running setup.py (path:/tmp/pip-AP6K_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:14 INFO - Running setup.py (path:/tmp/pip-83LyEp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:14 INFO - Running setup.py (path:/tmp/pip-GV7TRA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:14 INFO - Running setup.py (path:/tmp/pip-oZA7LH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:53:14 INFO - Running setup.py install for manifestparser 07:53:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:53:14 INFO - Running setup.py install for mozcrash 07:53:14 INFO - Running setup.py install for mozdebug 07:53:14 INFO - Running setup.py install for mozdevice 07:53:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:53:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:53:14 INFO - Running setup.py install for mozfile 07:53:14 INFO - Running setup.py install for mozhttpd 07:53:14 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:53:14 INFO - Running setup.py install for mozinfo 07:53:14 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:53:14 INFO - Running setup.py install for mozInstall 07:53:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:53:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:53:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:53:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:53:15 INFO - Running setup.py install for mozleak 07:53:15 INFO - Running setup.py install for mozlog 07:53:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:53:15 INFO - Running setup.py install for moznetwork 07:53:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:53:15 INFO - Running setup.py install for mozprocess 07:53:15 INFO - Running setup.py install for mozprofile 07:53:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:53:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:53:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:53:15 INFO - Running setup.py install for mozrunner 07:53:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:53:15 INFO - Running setup.py install for mozscreenshot 07:53:15 INFO - Running setup.py install for moztest 07:53:15 INFO - Running setup.py install for mozversion 07:53:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:53:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:53:15 INFO - Cleaning up... 07:53:16 INFO - Return code: 0 07:53:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53: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')]} 07:53:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53: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')]} 07:53:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:16 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 0x7f384efd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967f60>, '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 0x2968d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29691d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', '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 07:53:16 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 07:53:16 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 07:53:16 INFO - Using env: {'DISPLAY': ':0', 07:53:16 INFO - 'HOME': '/home/cltbld', 07:53:16 INFO - 'LANG': 'en_US.UTF-8', 07:53:16 INFO - 'LANGUAGE': 'en_US:en', 07:53:16 INFO - 'LOGNAME': 'cltbld', 07:53:16 INFO - 'MAIL': '/var/mail/cltbld', 07:53:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:16 INFO - 'MOZ_NO_REMOTE': '1', 07:53:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:16 INFO - 'NO_EM_RESTART': '1', 07:53:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:16 INFO - 'PWD': '/builds/slave/test', 07:53:16 INFO - 'SHELL': '/bin/bash', 07:53:16 INFO - 'SHLVL': '1', 07:53:16 INFO - 'TERM': 'linux', 07:53:16 INFO - 'TMOUT': '86400', 07:53:16 INFO - 'USER': 'cltbld', 07:53:16 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', 07:53:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:16 INFO - '_': '/tools/buildbot/bin/python'} 07:53:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:53:16 INFO - Running setup.py (path:/tmp/pip-C_m1g6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:53:16 INFO - Running setup.py (path:/tmp/pip-09ZOsc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:53:16 INFO - Running setup.py (path:/tmp/pip-0CIPzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:53:16 INFO - Running setup.py (path:/tmp/pip-R7gUXV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:53:16 INFO - Running setup.py (path:/tmp/pip-iX5H82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:53:16 INFO - Running setup.py (path:/tmp/pip-_ZisQw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:53:16 INFO - Running setup.py (path:/tmp/pip-Rbd3S9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:53:16 INFO - Running setup.py (path:/tmp/pip-n4_TNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:53:16 INFO - Running setup.py (path:/tmp/pip-pBzI9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:53:16 INFO - Running setup.py (path:/tmp/pip-DalkB6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:53:16 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)) 07:53:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:53:16 INFO - Running setup.py (path:/tmp/pip-zVUv3t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:53:17 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)) 07:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:53:17 INFO - Running setup.py (path:/tmp/pip-SzWD5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:53:17 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)) 07:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:53:17 INFO - Running setup.py (path:/tmp/pip-cFkuon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:53:17 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)) 07:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:53:17 INFO - Running setup.py (path:/tmp/pip-aISoPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:53:17 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)) 07:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:17 INFO - Running setup.py (path:/tmp/pip-lOitKp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:53:17 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)) 07:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:53:17 INFO - Running setup.py (path:/tmp/pip-5lIqFA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:53:17 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)) 07:53:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:53:17 INFO - Running setup.py (path:/tmp/pip-TwoDd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:53:17 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)) 07:53:17 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)) 07:53:17 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)) 07:53:17 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)) 07:53:17 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)) 07:53:17 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)) 07:53:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:53:17 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 07:53:17 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 07:53:17 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 07:53:17 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 07:53:17 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 07:53:17 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 07:53:19 INFO - Downloading blessings-1.6.tar.gz 07:53:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:53:19 INFO - Installing collected packages: blessings 07:53:19 INFO - Running setup.py install for blessings 07:53:19 INFO - Successfully installed blessings 07:53:19 INFO - Cleaning up... 07:53:19 INFO - Return code: 0 07:53:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:53:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:19 INFO - Reading from file tmpfile_stdout 07:53:19 INFO - Current package versions: 07:53:19 INFO - argparse == 1.2.1 07:53:19 INFO - blessings == 1.6 07:53:19 INFO - blobuploader == 1.2.4 07:53:19 INFO - docopt == 0.6.1 07:53:19 INFO - functools32 == 3.2.3-2 07:53:19 INFO - jsonschema == 2.5.1 07:53:19 INFO - manifestparser == 1.1 07:53:19 INFO - mozInstall == 1.12 07:53:19 INFO - mozcrash == 1.0 07:53:19 INFO - mozdebug == 0.1 07:53:19 INFO - mozdevice == 0.48 07:53:19 INFO - mozfile == 1.2 07:53:19 INFO - mozhttpd == 0.7 07:53:19 INFO - mozinfo == 0.9 07:53:19 INFO - mozleak == 0.1 07:53:19 INFO - mozlog == 3.4 07:53:19 INFO - moznetwork == 0.27 07:53:19 INFO - mozprocess == 0.23 07:53:19 INFO - mozprofile == 0.28 07:53:19 INFO - mozrunner == 6.13 07:53:19 INFO - mozscreenshot == 0.1 07:53:19 INFO - mozsystemmonitor == 0.3 07:53:19 INFO - moztest == 0.7 07:53:19 INFO - mozversion == 1.4 07:53:19 INFO - psutil == 3.1.1 07:53:19 INFO - requests == 1.2.3 07:53:19 INFO - wsgiref == 0.1.2 07:53:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:53:19 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')]} 07:53:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:19 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')]} 07:53:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:19 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 0x7f384efd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967f60>, '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 0x2968d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29691d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', '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 07:53:19 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 07:53:19 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 07:53:19 INFO - Using env: {'DISPLAY': ':0', 07:53:19 INFO - 'HOME': '/home/cltbld', 07:53:19 INFO - 'LANG': 'en_US.UTF-8', 07:53:19 INFO - 'LANGUAGE': 'en_US:en', 07:53:19 INFO - 'LOGNAME': 'cltbld', 07:53:19 INFO - 'MAIL': '/var/mail/cltbld', 07:53:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:19 INFO - 'MOZ_NO_REMOTE': '1', 07:53:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:19 INFO - 'NO_EM_RESTART': '1', 07:53:19 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:19 INFO - 'PWD': '/builds/slave/test', 07:53:19 INFO - 'SHELL': '/bin/bash', 07:53:19 INFO - 'SHLVL': '1', 07:53:19 INFO - 'TERM': 'linux', 07:53:19 INFO - 'TMOUT': '86400', 07:53:19 INFO - 'USER': 'cltbld', 07:53:19 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', 07:53:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:19 INFO - '_': '/tools/buildbot/bin/python'} 07:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:20 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)) 07:53:20 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)) 07:53:20 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)) 07:53:20 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)) 07:53:20 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)) 07:53:20 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)) 07:53:20 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)) 07:53:20 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)) 07:53:20 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)) 07:53:20 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)) 07:53:20 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)) 07:53:20 INFO - Cleaning up... 07:53:20 INFO - Return code: 0 07:53:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:53:20 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')]} 07:53:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:53:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:20 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')]} 07:53:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:53:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:53:20 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 0x7f384efd8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x296aca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2967f60>, '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 0x2968d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29691d0>, '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': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', '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 07:53:20 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 07:53:20 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 07:53:20 INFO - Using env: {'DISPLAY': ':0', 07:53:20 INFO - 'HOME': '/home/cltbld', 07:53:20 INFO - 'LANG': 'en_US.UTF-8', 07:53:20 INFO - 'LANGUAGE': 'en_US:en', 07:53:20 INFO - 'LOGNAME': 'cltbld', 07:53:20 INFO - 'MAIL': '/var/mail/cltbld', 07:53:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:20 INFO - 'MOZ_NO_REMOTE': '1', 07:53:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:20 INFO - 'NO_EM_RESTART': '1', 07:53:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:20 INFO - 'PWD': '/builds/slave/test', 07:53:20 INFO - 'SHELL': '/bin/bash', 07:53:20 INFO - 'SHLVL': '1', 07:53:20 INFO - 'TERM': 'linux', 07:53:20 INFO - 'TMOUT': '86400', 07:53:20 INFO - 'USER': 'cltbld', 07:53:20 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', 07:53:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:20 INFO - '_': '/tools/buildbot/bin/python'} 07:53:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:53:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:53:20 INFO - Cleaning up... 07:53:20 INFO - Return code: 0 07:53:20 INFO - Running post-action listener: _resource_record_post_action 07:53:20 INFO - Running post-action listener: _start_resource_monitoring 07:53:20 INFO - Starting resource monitoring. 07:53:20 INFO - [mozharness: 2016-12-09 15:53:20.461522Z] Finished create-virtualenv step (success) 07:53:20 INFO - [mozharness: 2016-12-09 15:53:20.462025Z] Running install step. 07:53:20 INFO - Running pre-action listener: _resource_record_pre_action 07:53:20 INFO - Running main action method: install 07:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:53:20 INFO - Reading from file tmpfile_stdout 07:53:20 INFO - Detecting whether we're running mozinstall >=1.0... 07:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:53:20 INFO - Reading from file tmpfile_stdout 07:53:20 INFO - Output received: 07:53:20 INFO - Usage: mozinstall [options] installer 07:53:20 INFO - Options: 07:53:20 INFO - -h, --help show this help message and exit 07:53:20 INFO - -d DEST, --destination=DEST 07:53:20 INFO - Directory to install application into. [default: 07:53:20 INFO - "/builds/slave/test"] 07:53:20 INFO - --app=APP Application being installed. [default: firefox] 07:53:20 INFO - mkdir: /builds/slave/test/build/application 07:53:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 07:53:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 07:53:36 INFO - Reading from file tmpfile_stdout 07:53:36 INFO - Output received: 07:53:36 INFO - /builds/slave/test/build/application/firefox/firefox 07:53:36 INFO - Running post-action listener: _resource_record_post_action 07:53:36 INFO - [mozharness: 2016-12-09 15:53:36.668603Z] Finished install step (success) 07:53:36 INFO - [mozharness: 2016-12-09 15:53:36.668844Z] Running run-tests step. 07:53:36 INFO - Running pre-action listener: _resource_record_pre_action 07:53:36 INFO - Running main action method: run_tests 07:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:53:36 INFO - Python 2.7.3 07:53:36 INFO - Return code: 0 07:53:36 INFO - grabbing minidump binary from tooltool 07:53:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:53:36 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 0x2967f60>, '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 0x2968d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29691d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:53:36 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 07:53:36 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 07:53:36 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 07:53:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:53:36 INFO - Return code: 0 07:53:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:53:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:53:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:53:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:53:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:53:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:53:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-035 --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 07:53:36 INFO - Using env: {'DISPLAY': ':0', 07:53:36 INFO - 'HOME': '/home/cltbld', 07:53:36 INFO - 'LANG': 'en_US.UTF-8', 07:53:36 INFO - 'LANGUAGE': 'en_US:en', 07:53:36 INFO - 'LOGNAME': 'cltbld', 07:53:36 INFO - 'MAIL': '/var/mail/cltbld', 07:53:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:53:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:53:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:53:36 INFO - 'MOZ_NO_REMOTE': '1', 07:53:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:53:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:53:36 INFO - 'NO_EM_RESTART': '1', 07:53:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:53:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:53:36 INFO - 'PWD': '/builds/slave/test', 07:53:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:53:36 INFO - 'SHELL': '/bin/bash', 07:53:36 INFO - 'SHLVL': '1', 07:53:36 INFO - 'TERM': 'linux', 07:53:36 INFO - 'TMOUT': '86400', 07:53:36 INFO - 'USER': 'cltbld', 07:53:36 INFO - 'XDG_SESSION_COOKIE': 'ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240', 07:53:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:53:36 INFO - '_': '/tools/buildbot/bin/python'} 07:53:36 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-035', '--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 07:53:36 INFO - mozversion application_buildid: 20161209060650 07:53:36 INFO - mozversion application_changeset: f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 07:53:36 INFO - mozversion application_display_name: FirefoxDeveloperEdition 07:53:36 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:53:36 INFO - mozversion application_name: Firefox 07:53:36 INFO - mozversion application_remotingname: firefox-dev 07:53:36 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:53:36 INFO - mozversion application_vendor: Mozilla 07:53:36 INFO - mozversion application_version: 52.0a2 07:53:36 INFO - mozversion platform_buildid: 20161209060650 07:53:36 INFO - mozversion platform_changeset: f6f2e2b9fa87a1cf454dec44bcf52cd4f96288a0 07:53:36 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 07:53:36 INFO - mozversion platform_version: 52.0a2 07:53:36 INFO - using testdate: 1481298816 07:53:36 INFO - actual date: 1481298816 07:53:36 INFO - starting webserver on 'localhost:41870' 07:53:36 INFO - SUITE-START | Running 2 tests 07:53:36 INFO - TEST-START | dromaeo_css 07:53:36 INFO - operating with platform_type : linux_ 07:53:36 INFO - Initialising browser for dromaeo_css test... 07:53:36 INFO - TEST-INFO | started process 27316 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpny4QqO/profile http://localhost:41870/getInfo.html) 07:53:40 INFO - PROCESS | 27316 | __metrics Screen width/height:1600/1200 07:53:40 INFO - PROCESS | 27316 | colorDepth:24 07:53:40 INFO - PROCESS | 27316 | Browser inner width/height: 1024/697 07:53:40 INFO - PROCESS | 27316 | __metrics 07:53:41 INFO - PROCESS | 27316 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:53:41 INFO - PROCESS | 27316 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:53:41 INFO - PROCESS | 27316 | console.error: PushService: 07:53:41 INFO - PROCESS | 27316 | stateChangeProcessEnqueue: Error transitioning state 07:53:41 INFO - PROCESS | 27316 | UnknownError 07:53:42 INFO - TEST-INFO | 27316: exit 0 07:53:42 INFO - Browser initialized. 07:53:42 INFO - Running cycle 1/1 for dromaeo_css test... 07:53:42 INFO - TEST-INFO | started process 27410 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpny4QqO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:53:54 INFO - PROCESS | 27410 | RSS: Main: 144814080 07:53:54 INFO - PROCESS | 27410 | 07:54:45 INFO - PROCESS | 27410 | 1481298885708 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] 07:56:55 INFO - PROCESS | 27410 | Cycle 1(1): loaded http://localhost:41870/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41870/tests/dromaeo/cssquery-ext.html) 07:56:57 INFO - PROCESS | 27410 | RSS: Main: 249651200 07:56:57 INFO - PROCESS | 27410 | 07:59:59 INFO - PROCESS | 27410 | Cycle 1(1): loaded http://localhost:41870/tests/dromaeo/cssquery-ext.html (next: http://localhost:41870/tests/dromaeo/cssquery-jquery.html) 08:00:00 INFO - PROCESS | 27410 | RSS: Main: 228192256 08:00:00 INFO - PROCESS | 27410 | 08:03:02 INFO - PROCESS | 27410 | Cycle 1(1): loaded http://localhost:41870/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41870/tests/dromaeo/cssquery-mootools.html) 08:03:02 INFO - PROCESS | 27410 | RSS: Main: 210509824 08:03:02 INFO - PROCESS | 27410 | 08:06:04 INFO - PROCESS | 27410 | Cycle 1(1): loaded http://localhost:41870/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41870/tests/dromaeo/cssquery-prototype.html) 08:06:05 INFO - PROCESS | 27410 | RSS: Main: 215052288 08:06:05 INFO - PROCESS | 27410 | 08:09:07 INFO - PROCESS | 27410 | Cycle 1(1): loaded http://localhost:41870/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41870/tests/dromaeo/cssquery-yui.html) 08:09:08 INFO - PROCESS | 27410 | RSS: Main: 172441600 08:09:08 INFO - PROCESS | 27410 | 08:12:10 INFO - PROCESS | 27410 | Cycle 1(1): loaded http://localhost:41870/tests/dromaeo/cssquery-yui.html (next: http://localhost:41870/tests/dromaeo/cssquery-dojo.html) 08:12:11 INFO - PROCESS | 27410 | RSS: Main: 263815168 08:12:11 INFO - PROCESS | 27410 | 08:12:11 INFO - PROCESS | 27410 | __start_tp_report 08:12:11 INFO - PROCESS | 27410 | _x_x_mozilla_page_load 08:12:11 INFO - PROCESS | 27410 | _x_x_mozilla_page_load_details 08:12:11 INFO - PROCESS | 27410 | |i|pagename|runs| 08:12:11 INFO - PROCESS | 27410 | |0;dojo.html;3203.4714272145097;3228.8062716237027;3241.335526217126;3262.1192278084905;3277.8361081945895;5412.918806217905;5476.178573214015;5477.096279113952;5486.259354987075;5498.422665620113;5514.172874068881;5572.164175373696;5573.442655734424;5585.944140558603;5598.524125449342;5005.249212618109;5023.146065168912;5046.84859454217;5085.262636917645;5125.923111153335;4875.219964805632;4901.852944411673;5049.873753156164;5107.668001579904;5113.284140220372;4971.950280497203;4990.8003679852945;4997.175466048097;5012.298278241049;5044.243363495469;5013.924791128136;5082.186850103965;5100.183970564692;5115.2071428928575;5130.692158470466;4761.952380476186;4778.235482322846;4997.525235102659;5000.42495113063;5057.797688092472;5399.7030163341;5465.890682186374;5476.17857321405;5496.697681627509;5512.476314750133;5867.706614669292;5930.495907847838;5930.673812940287;5933.110033495011;5936.22829032223;5650.6892120933335;5813.157092221646;5954.523638108941;5970.194023806774;5970.761169553212;5492.313460817398;5515.172724091378;5539.612227144102;5591.41290164535;5625.071863142535;6063.6664983426335;6076.483498902643;6085.421884920926;6088.391160883876;6089.786857459968;5557.083081291623;5863.941360586339;5864.208331875142;5868.149118377897;5873.794417195463;5580.19087232349;5889.793857215062;5894.941050589439;5936.020556608198;6043;5955.642661440327;5980.22257106582;5999.850003749854;6005.279366476051;6037.184980027728;6003.849903752441;6006.489448396847;6015.608985415934;6018.759249629966;6019.097135429633;4417.977910110493;4440.977795111004;4506.977465112654;4518.2319005769095;4526.683132180781;4047.4131250968444;4054.3715724062818;4071.1043570414463;4078.2659121357847;4087.2234275487563;5565.721713914288;5570.025245582088;5573.749181286852;5576;5604;5553;5600.551955843523;5811.012127938261;5885.293764748258;5904.881902361929;5667.1782591524;5683.54531637468;5711.543076553949;5728.255326807488;5744.195812586241;5100.974495127575;5110.616703747234;5113.386393632788;5115.693058416507;5145.948540514547;5839.124131380242;5904.173415721888;6039.728212230372;6233.532485063638;6246.15676883624;5799.652020878761;5873.676947767914;5875.529957603467;5892.204552385373;5904.291485021653;6116.418940200674;6124.295705993868;6127.632342059491;6127.662978536223;6132.601380910227;5550.833474995757;5579.46995035471;5791.102379131242;5795.420457954171;5797.956367853827;5902.940970590411;6001.4298641628975;6011.308699499614;6034.974054410673;6035.215421995113;5838.532917366516;5856.531477481876;5860.38465961068;5873.676947767914;5879.382664820132;5494.697791621499;5552.500274975271;5796.507296879812;5873.9412605873395;5879.029960056714;5680.545556355399;5745.8563535911935;5751.1373294006235;5801.738921748447;5830.067189249699;5821.621594596338;5834;5854.356020837619;5854.385289544707;5856.59003869725;5432.782688692408;5456.890862182813;5456.972715136399;5717.885642287048;5749.913751293818 08:12:11 INFO - PROCESS | 27410 | |1;ext.html;576.7635269539489;599.9580029397943;638.1958731997681;639.4564620072939;667.1127400557259;33451.83274083629;44452.3332150018;44979.77510112445;45018.77490612551;45100.77449612747;45332.320015199715;45830.541694583044;45850.77074614622;45925.540744592545;45932.311015334715;8183.345332373426;8804.779880502974;8949.105089491031;8950;8961.238294744922;8220.671173153067;8437.789055273606;8441.746747597583;10752.408617526033;11036.227464077518;10858.837117443245;10945.179111566624;10945.616903408381;10949.671509854717;10956.233063685546;10611.681649550486;10645.680629581126;10663.466826658674;10667.626633067805;10671.519781609846;10639.255252132354;10697.572097116106;10699.358038517636;10701.250912436133;10705.197110216764;43180.136397272196;43476.34785478189;43569.56430435687;43577.12845743068;43625.78187109076;3449.5170676105367;3563.5901871284614;3563.964360356389;3575.5888072871694;3691.667749902522;32425.51361729576;32580;32871.83564082164;32928.17679558006;33206.67668602311;4193.811278492475;4206.621404073648;4210.221109094828;4228.1966426379195;4240.08838099807;253714;254783.72608137026;256187;256448;256520;62106.37893621006;62446.37553624497;62509.68745156336;62560.37439625637;62593.68703156546;39989;40789.18421631551;40918.590814091476;42831.143377132285;42879.35680964788;17175.484735457707;17317.307307707804;17331.65336693259;17339.306427742747;17340.47978560645;12149.635510934686;12805.039622028386;12822.294773787531;12829.807552886714;12838.16551924122;18319.54201144982;19488.220471181277;19851.60296794085;19899.502512437306;20544.897275513526;7257.782266532013;7320.853582928312;7375.704971801175;7527.059117610299;7613.352865006536;1037.3775734559356;1070.8768491623407;1103.7516558774212;1108.1024370260116;1114.1922106472905;33506;33942.32115357679;34019.82990085034;34026.48960265598;34597.654023459945;1098.5770478365728;1156.3351073132983;1168.462507246659;1225.5159212111344;1243.7450322683828;16912.238949247312;17501.212445439985;17724.734128988075;17755.112244387987;17814.91092544529;538996;551765;552288;552838;554134;61781.69109154426;62273.37726622766;62410;62450;62612.68693656503;1291.380137533989;1347.5755137131773;1354.5123755448228;1417.3196865504615;1421.8364888038009;30292.54561181628;33860.492092619126;34364.48453273153;36201;36550.45174322334;57904.4209557899;58177.70911145417;58415.12377314429;58420;58483.4151658478;460193;464142;466119;472664;473834;30463.847680761453;30647.2338191547;38779;38857.80571097126;39307;43889.561104388544;45794.542054579026;50495.49504504908;52319.215211772615;53081.73459132679;41139.794301028305;41697.58302416937;41808.79095604503;41829;43885.78057109694;42174.78912605417;42922;43522.78238608914;44165.558344416146;44723;42588.36117458178;43713;43839.56160438482;44468.55531444644;44721;36361.63638363582;38235.80882095572;38634.22731545297;39241.6075839238;39340;29140.417191656474;29399.235607930532;29513;29586.408271834873;29705.5544166842 08:12:11 INFO - PROCESS | 27410 | |2;jquery.html;419.20351332468323;422.9386738922858;430.0689008297037;431.12696789002274;443.4656239231726;18557;18840.34058807942;20099.29652462164;20197.798022019775;20273.898630506847;19519.804801951977;19523.535734819874;19538.706919396183;20419.081141348637;20520.794792052075;1897.7722673279227;1900.37287695061;1904.2954106980437;1905.9428217153506;2076.6573515369982;5755.194272801811;5859.44335288147;5860.619059761123;5864.853378665525;5869.530437564985;5679.062954612505;5759.366469688331;5770.249867517216;5830.271216097988;5864;5807.2450581424355;5842.824715258549;5852.56105792063;5854.941450585482;5860.384659610765;5083.771230294646;5275.57795376369;5307.65500242483;5312.043832110218;5314.043472175007;23697.170599028952;23958.880205599035;24176.395590110213;24258.636120458206;24370;2424.4787370715203;2635.2094371688418;2656.588228824516;3118.2516196112997;3268.313654132635;10625;11190.776184476264;11206.103511719042;11288.266262692981;11323.773524529463;1973.15154483572;1988.8408927285782;2016.667249903764;2038.6941958706163;2040.7245021922;80537.59731201307;82441.58779206185;83641.58179209125;86836.56581717114;90482.90341931574;11540.538378464767;11764.705882352839;11807.940960295144;11882.277069824828;12104.515819367127;17216.655666886592;17219.052952087506;17228.569285767957;17246.65506689859;17263.74104388435;8289.626966786509;8360.498370097814;8406.781016752537;8424.957875210584;8527;7918.881216781753;7964.761057168294;8034.919650803534;8125.3499720022255;8131.227533384319;5038.420581633086;5097.6941383517105;5128.897422051538;5142.948570514322;5269.894602108013;2125.171183238538;2128.17001369466;2130.754963179223;2158.2230397057047;2166.2418153646413;952.9237660987104;962.4465932089076;1031.4481752262504;1044.2481413382352;1060.5863713151878;20391.89804051;20695.689564656543;20998;21152.298347789074;21329.146834126772;985.1675334342469;1009.6112996496255;1026.8049070676548;1036.1296510930854;1079.093561408405;10593.682189534326;11164.776704466027;11292.491837867316;11468.54125834974;11509.53961841517;454641;458340;461127;497363;497621;73069.6346518264;73472.99999999894;92390;99903;99958;956.2350119904049;1011.9949400252951;1016.1718199667396;1063.994680026595;1069.8395240713799;17996.280148793903;18008.639827203122;18484.537886552946;18809.623807524047;18984.240630374632;43523.55955505562;43710.56289437065;43765.56234437615;44971.550284496734;45948.310775337726;60363.698181508815;61229.69385153046;61232.69383653053;61512.38487615067;61642.383576163666;8785.472871627722;8861;8949.776255593402;9016.323775716717;9023.684171053981;12804;13118.803217951547;13328.600141995756;13874.236916969663;14255.215963121713;11819.940900295443;11841.822372664245;11940.223885447418;11967.820482692592;12699.682507937376;11087.390193539433;11165.72085697864;11436.313821170756;11589.130815188726;11659.067274618179;11496.310221386744;11577.594784182513;11753.706157345792;11924.880751192377;12928.547500837425;8816.118388161132;9036.23192028685;9186.678466253648;9243.2143267823;9283.164515193665;9181.126574948627;11823.70440738954;11962.162648614514;11983.64049078529;12645.367731613567 08:12:11 INFO - PROCESS | 27410 | |3;mootools.html;1333.3466601365335;1496.214487394118;1498.0337682194984;1664.2178176257155;1823.3527097880244;7455.478116531838;8353.665853365866;8724.258438032759;8746.956265218672;9002.414843035198;8801.339899507531;8870.556472176399;8876.911230887688;8879.644814207424;8902.599383027764;2234.597772400967;2259.559385919746;2260.389694782408;2261.378121016717;2266.1048885690143;2399.7240317363553;2413.4811015631635;2460.938476538083;2467.3584867934287;2478.628205769131;2359.4691194481275;2363.7045369328835;2377.203636781672;2388.4984153327823;2390.8924098415614;2333.2067097187037;2336.3107883174503;2353.2704861492994;2379.0245999140357;2380.4643955110137;2345.882705864717;2349.189529612281;2396.5206958608173;2397.6643269942224;2397.700287464067;8557.315414766867;8678.566071696454;8835.77910552235;8849.513276769776;8850.468971861708;5329.680219186861;5482.424345443711;5485.945140548583;5492.725363731797;5495.230667706524;3306.718928891047;3400.506926495669;3418.4017796885696;3439.2949445363893;3454.9481757773656;1066.935983840972;1082.1991726122692;1082.588616325799;1133.8412622232895;1135.154310039018;12060.276383416935;12100.576479823252;12175.756484870342;12179.756404871941;12203.633890983196;4419.7348159109915;4544.7500387479;4645.86062418128;4696.788644511005;4718.363020992191;9570.138687518156;9632.084951929555;9660.95169524148;9668.178204852526;9674.806503869882;5444.428335024765;5446.128619420953;5451.046066938349;5460.726963651801;5464.016477034172;4109.773962432095;4237.766922819213;4433.179861725526;5063.772130254148;5133.101707201225;3611.422172452395;3679.1170119171206;3764.604716504782;3765.548134223856;3840.615938406193;1207.088648070701;1235.5119727707506;1237.5359240284893;1242.4222736427423;1260.5021016698536;925.0841666749869;937.9296552758434;960.2558017536466;960.3949511807656;992.0674565908023;5895.322037965603;5949.82150535476;6012.579119461683;6030.6080104793045;6120.846978825565;486.5280677742655;491.9729414882216;498.3471652135714;501.2155975897708;501.33072348414544;4107.732997355162;4163.375493675912;4171.728837625545;4188.8324467020975;4221;10486.580536778443;10832.295900766425;10887.183461240438;10936.507857146447;10938.453077346101;10109.140723038478;10536.473176341153;10877.782444351069;10883.945580272048;10899.83650245247;8200.384971127189;8400.957995209985;8422.24199822019;8429.199226073391;8429.578521074045;5926.140709596998;5936.5844390892225;6075.574709770273;6095.725692343766;6173.876522469435;9932.155766759906;9958.402495850272;9978.550965206729;9982.151517121127;10179.03299186576;8774.254188394058;8989.55052247398;10327.431991240554;10479.790404192026;10480.10919071857;7622.771316860503;7794.766157015299;7846.293833555007;7942.64258108375;8022.478538894953;8671.176238257607;8689.044205137303;8704.825903481767;8705.303575714055;8709.651613935372;7637.847243054996;7658.540487570764;7715.537067775726;7731.95618591483;7852.685892564462;7513.699452021858;7707.845843082995;7738.574378409242;7791.181925897699;7930.841383172419;7000.789976300719;7106.040684507525;7110.253423390676;7113.0753002109395;7117.501774875709;5067.746612669425;5158.200478925773;5268.446813084571;5291.788328466972;5475.808346707846;4965.1311020571975;5080.161773307363;5095.974520127375;5156.484351564814;5310.814121505883 08:12:11 INFO - PROCESS | 27410 | |4;prototype.html;338.2237764330862;344.39902370363717;349.6119307568599;350.1700968704171;352.42554635943407;5386.865328366793;5393.460653934604;5406.675599464025;5410.188471729242;5423.186522021694;5027.497250274971;5190.480951904808;5196.298499702539;5254.710990895499;5316.813911513098;4191.937120943188;4207.842843218116;4211.010412553048;4211.936820947688;4218.641415479688;4225.577442255781;4229.492460904696;4235.195312890556;4239.936400953989;4246.447961764966;3898;3938.1532970411354;4087.7751723655188;4123.340265557511;4134.772587507686;4120.6195924365375;4120.876373708794;4121.690873184523;4125.731827431237;4138.213739389522;3668.413053911361;3671.1556342041213;3671.6511931366476;3672.2839046385966;3672.797996110213;4964.702117872939;5190.636655434121;5192.688438693653;5194.636570201511;5246.501582349671;4801.51984801517;4807.11068452334;4814.063421312996;4815.422149342066;4830.710157390533;5590.357108932443;5597.860053498654;5602.327720673505;5616.241807356037;5617.606767526275;3990.1620659661507;4052.4124002019835;4058.370952502367;4096.242195193899;4116.958830411718;5791.594588378815;5803;5807.767689292381;5811.4790948599;5817.360090390053;4155.210510003089;4157.376393540932;4159.7745206315085;4166.895827604334;4177.791110444466;3997;4101.159262351271;4117.053077792125;4217.957820421818;4224.366345048267;4715.599174070174;4724.976375118103;4725.36207611968;4739.265413860857;4746.691465054761;5606.747696353592;5607.49532542065;5611.765411609439;5617.241672374177;5626.240457538262;1305.8694130586866;1371.8833899118686;1407.35965135865;1418.3688258724974;1429.5282556756245;880.7933131609735;1012.5443550402348;1029.6859457865273;1038.774246389268;1039.6828967164936;5228.61441717945;5253.238280449314;5254.894902102013;5260.237265596544;5268.710220937808;5463.344398672185;5488.506034456918;5502.642328248651;5506.944930550723;5512.531434828004;5172.8965420691375;5474.835754927359;5481.835544933659;5484.862878428071;5496.653319936561;2881.1788640237432;2905;2924.4151169766133;2932.3841993181245;2940.6324209473814;5591.412901645269;5647.830565083054;5703.572232082527;5790.334111577138;5794.435502414324;5625.718714064362;5630.4369563043365;5652.802151924663;5656.575756818255;5662.009148399096;5781.653100813965;5786.566007549366;5796.884062318814;5802.4197580241635;5803.216565763568;5394.462578165204;5495.807646732345;5519.530839878656;5530.5022547970875;5531.8893622126525;5505.752241149238;5510.476504732044;5525.392206857323;5530.751116199861;5538.363088244742;5545.698535107885;5740.971295143498;5772;5790.39200883918;5793.11861053087;4014.87583476627;4054.533728621246;4054.8986275343354;4059.939100913548;4060.5939406059156;5542.695151766691;5545.778168873361;5557.749901254372;5561.386148510193;5562.749676264497;5284.981306180929;5379.542738867083;5411.161270003156;5446.618736688552;5464.262324586289;5370.167624018283;5378.623496355218;5437.238786569963;5437.700926449083;5480.588955828249;5224.582033437392;5325;5424.403315635198;5431.9803345524815;5463.180522921434;5602.831915042555;5619.134241536927;5635.239242702182;5646.35066967304;5649.231876380626;5531.1426728857095;5541.5289700375915;5543.1685247213245;5567.415421380859;5572.665640061609 08:12:11 INFO - PROCESS | 27410 | |5;yui.html;675.2032601530192;740.2560426771095;744.757953665059;756.6254703921558;810.2990912860374;12863.935680321585;12912.741745165104;13541.390637421315;13569.321533923314;13591.048626596155;13068.085234033622;13299.734005319888;13421.328933553332;13476.52832150875;13521.188728676287;724.6811402982684;746.6005686957479;831.1148626712531;851.2806678356809;863.4819108534891;852.5481494807761;853.8804567360575;855.2388374346805;855.4909828651973;855.6491838346279;724.9456290778186;773.0452890680006;889.4929889962724;890.3100097424483;890.781758469176;824.7360844529753;887.9600417981175;890.7862113092876;891.5052146058935;895.2211575928983;659.650385295794;659.8449364399362;659.9835004124935;660.4221306356937;660.6696651674163;12346.876531234662;12360.567380141652;12413.379331033502;12420;12420.503179872794;12773.744525109445;12924.483020679161;13068.281244531547;13145.474181032747;13154.144980576231;12119.39403029845;12247.265164090093;12319.260844349277;12484.375781210903;12573.748525029449;4332.133573285324;4388.846390376353;4398.120375924827;4425.845095421645;4489.21438748221;61465.07802382968;62120;64928.350716492234;65732;66255.3374466254;10202.744931376626;10412.479376031168;10504.317219380715;10628.893711062945;10702.143828493701;18014.189361478766;18044.639107217783;18230.270789168284;18404;18443.26226950907;7181.291185651228;7252.709891604382;7429.62851857405;7520.360769334668;7746.651400686983;4604.447466304065;4659.603933665609;4682.719036857799;4756.738379389167;4809.158397280462;3069.8772049117783;3152.621685397721;3189.9043028709175;3190.952135717966;3223.693749093832;542.5984771269311;603.5232166588434;604.2265899648457;643.6073994863129;655.7508146904241;672.630053470599;681.3356976947437;690.4648897104784;700.5901547594613;701.6491754122939;8971.50656713887;9252.722418327461;9258.444493330288;9414.576344064533;9601.183899368492;657.3163909534127;668.7859884836805;670.396643021275;682.1711620381261;683.1870074611197;4472.837092208166;4780.689255198401;4792.600201469831;4798.352222449925;4827.637927155407;90247;92490.53754731317;93011.53494232486;93727.53136234412;96658;59118.40881591215;59221;81903;83998;85888;72731;75154;75918;76882.23117768862;77996;9082.727518174466;9188.448693078437;9334.346595738232;9390.342676012613;9448.196903263024;49923;49994;50664.49335506598;51006;52451.475485246185;65312.346876530624;67660;68043.65978170077;70711.29288707253;71082.6445867788;11074.5570177192;11167.274127181707;11229.4115011871;11360.091192704398;11376.089912807121;12940.611781646565;12951.287679177736;13037.608871733863;13092.803607945698;13138.080334376502;10701.785964280827;12474;12716.364181790688;12973.351332433529;13624.727505450033;12435.69939561184;12602.432890520133;12689.175203611736;12971.935140324238;13064.150830196388;11891.345975971404;12083.275003499819;12159.331236782062;12191.695207619881;12394.876051239373;10729.678109656723;10829.47586612392;11129.276597021168;11332.773344533229;11574.537018519164;10607.310524815863;11243.491043176922;11368.886311136783;11393.373364465035;11436 08:12:11 INFO - PROCESS | 27410 | __end_tp_report 08:12:11 INFO - PROCESS | 27410 | __start_cc_report 08:12:11 INFO - PROCESS | 27410 | _x_x_mozilla_cycle_collect,1058 08:12:11 INFO - PROCESS | 27410 | __end_cc_report 08:12:11 INFO - PROCESS | 27410 | __startTimestamp1481299931234__endTimestamp 08:12:11 INFO - PROCESS | 27410 | 08:12:11 INFO - PROCESS | 27410 | ------- Summary: start ------- 08:12:11 INFO - PROCESS | 27410 | Number of tests: 6 08:12:11 INFO - PROCESS | 27410 | 08:12:11 INFO - PROCESS | 27410 | [#0] dojo.html Cycles:165 Average:5489.02 Median:5667.18 stddev:622.94 (11.0%) stddev-sans-first:598.49 08:12:11 INFO - PROCESS | 27410 | Values: 3203.5 3228.8 3241.3 3262.1 3277.8 5412.9 5476.2 5477.1 5486.3 5498.4 5514.2 5572.2 5573.4 5585.9 5598.5 5005.2 5023.1 5046.8 5085.3 5125.9 4875.2 4901.9 5049.9 5107.7 5113.3 4972.0 4990.8 4997.2 5012.3 5044.2 5013.9 5082.2 5100.2 5115.2 5130.7 4762.0 4778.2 4997.5 5000.4 5057.8 5399.7 5465.9 5476.2 5496.7 5512.5 5867.7 5930.5 5930.7 5933.1 5936.2 5650.7 5813.2 5954.5 5970.2 5970.8 5492.3 5515.2 5539.6 5591.4 5625.1 6063.7 6076.5 6085.4 6088.4 6089.8 5557.1 5863.9 5864.2 5868.1 5873.8 5580.2 5889.8 5894.9 5936.0 6043.0 5955.6 5980.2 5999.9 6005.3 6037.2 6003.8 6006.5 6015.6 6018.8 6019.1 4418.0 4441.0 4507.0 4518.2 4526.7 4047.4 4054.4 4071.1 4078.3 4087.2 5565.7 5570.0 5573.7 5576.0 5604.0 5553.0 5600.6 5811.0 5885.3 5904.9 5667.2 5683.5 5711.5 5728.3 5744.2 5101.0 5110.6 5113.4 5115.7 5145.9 5839.1 5904.2 6039.7 6233.5 6246.2 5799.7 5873.7 5875.5 5892.2 5904.3 6116.4 6124.3 6127.6 6127.7 6132.6 5550.8 5579.5 5791.1 5795.4 5798.0 5902.9 6001.4 6011.3 6035.0 6035.2 5838.5 5856.5 5860.4 5873.7 5879.4 5494.7 5552.5 5796.5 5873.9 5879.0 5680.5 5745.9 5751.1 5801.7 5830.1 5821.6 5834.0 5854.4 5854.4 5856.6 5432.8 5456.9 5457.0 5717.9 5749.9 08:12:11 INFO - PROCESS | 27410 | 08:12:11 INFO - PROCESS | 27410 | [#1] ext.html Cycles:180 Average:59705.58 Median:39274.30 stddev:117410.93 (299.0%) stddev-sans-first:117656.37 08:12:11 INFO - PROCESS | 27410 | Values: 576.8 600.0 638.2 639.5 667.1 33451.8 44452.3 44979.8 45018.8 45100.8 45332.3 45830.5 45850.8 45925.5 45932.3 8183.3 8804.8 8949.1 8950.0 8961.2 8220.7 8437.8 8441.7 10752.4 11036.2 10858.8 10945.2 10945.6 10949.7 10956.2 10611.7 10645.7 10663.5 10667.6 10671.5 10639.3 10697.6 10699.4 10701.3 10705.2 43180.1 43476.3 43569.6 43577.1 43625.8 3449.5 3563.6 3564.0 3575.6 3691.7 32425.5 32580.0 32871.8 32928.2 33206.7 4193.8 4206.6 4210.2 4228.2 4240.1 253714.0 254783.7 256187.0 256448.0 256520.0 62106.4 62446.4 62509.7 62560.4 62593.7 39989.0 40789.2 40918.6 42831.1 42879.4 17175.5 17317.3 17331.7 17339.3 17340.5 12149.6 12805.0 12822.3 12829.8 12838.2 18319.5 19488.2 19851.6 19899.5 20544.9 7257.8 7320.9 7375.7 7527.1 7613.4 1037.4 1070.9 1103.8 1108.1 1114.2 33506.0 33942.3 34019.8 34026.5 34597.7 1098.6 1156.3 1168.5 1225.5 1243.7 16912.2 17501.2 17724.7 17755.1 17814.9 538996.0 551765.0 552288.0 552838.0 554134.0 61781.7 62273.4 62410.0 62450.0 62612.7 1291.4 1347.6 1354.5 1417.3 1421.8 30292.5 33860.5 34364.5 36201.0 36550.5 57904.4 58177.7 58415.1 58420.0 58483.4 460193.0 464142.0 466119.0 472664.0 473834.0 30463.8 30647.2 38779.0 38857.8 39307.0 43889.6 45794.5 50495.5 52319.2 53081.7 41139.8 41697.6 41808.8 41829.0 43885.8 42174.8 42922.0 43522.8 44165.6 44723.0 42588.4 43713.0 43839.6 44468.6 44721.0 36361.6 38235.8 38634.2 39241.6 39340.0 29140.4 29399.2 29513.0 29586.4 29705.6 08:12:11 INFO - PROCESS | 27410 | 08:12:11 INFO - PROCESS | 27410 | [#2] jquery.html Cycles:180 Average:28927.92 Median:23828.03 stddev:78313.18 (328.7%) stddev-sans-first:78503.62 08:12:11 INFO - PROCESS | 27410 | Values: 419.2 422.9 430.1 431.1 443.5 18557.0 18840.3 20099.3 20197.8 20273.9 19519.8 19523.5 19538.7 20419.1 20520.8 1897.8 1900.4 1904.3 1905.9 2076.7 5755.2 5859.4 5860.6 5864.9 5869.5 5679.1 5759.4 5770.2 5830.3 5864.0 5807.2 5842.8 5852.6 5854.9 5860.4 5083.8 5275.6 5307.7 5312.0 5314.0 23697.2 23958.9 24176.4 24258.6 24370.0 2424.5 2635.2 2656.6 3118.3 3268.3 10625.0 11190.8 11206.1 11288.3 11323.8 1973.2 1988.8 2016.7 2038.7 2040.7 80537.6 82441.6 83641.6 86836.6 90482.9 11540.5 11764.7 11807.9 11882.3 12104.5 17216.7 17219.1 17228.6 17246.7 17263.7 8289.6 8360.5 8406.8 8425.0 8527.0 7918.9 7964.8 8034.9 8125.3 8131.2 5038.4 5097.7 5128.9 5142.9 5269.9 2125.2 2128.2 2130.8 2158.2 2166.2 952.9 962.4 1031.4 1044.2 1060.6 20391.9 20695.7 20998.0 21152.3 21329.1 985.2 1009.6 1026.8 1036.1 1079.1 10593.7 11164.8 11292.5 11468.5 11509.5 454641.0 458340.0 461127.0 497363.0 497621.0 73069.6 73473.0 92390.0 99903.0 99958.0 956.2 1012.0 1016.2 1064.0 1069.8 17996.3 18008.6 18484.5 18809.6 18984.2 43523.6 43710.6 43765.6 44971.6 45948.3 60363.7 61229.7 61232.7 61512.4 61642.4 8785.5 8861.0 8949.8 9016.3 9023.7 12804.0 13118.8 13328.6 13874.2 14255.2 11819.9 11841.8 11940.2 11967.8 12699.7 11087.4 11165.7 11436.3 11589.1 11659.1 11496.3 11577.6 11753.7 11924.9 12928.5 8816.1 9036.2 9186.7 9243.2 9283.2 9181.1 11823.7 11962.2 11983.6 12645.4 08:12:11 INFO - PROCESS | 27410 | 08:12:11 INFO - PROCESS | 27410 | [#3] mootools.html Cycles:180 Average:5767.12 Median:5088.07 stddev:3260.66 (64.1%) stddev-sans-first:3252.78 08:12:11 INFO - PROCESS | 27410 | Values: 1333.3 1496.2 1498.0 1664.2 1823.4 7455.5 8353.7 8724.3 8747.0 9002.4 8801.3 8870.6 8876.9 8879.6 8902.6 2234.6 2259.6 2260.4 2261.4 2266.1 2399.7 2413.5 2460.9 2467.4 2478.6 2359.5 2363.7 2377.2 2388.5 2390.9 2333.2 2336.3 2353.3 2379.0 2380.5 2345.9 2349.2 2396.5 2397.7 2397.7 8557.3 8678.6 8835.8 8849.5 8850.5 5329.7 5482.4 5485.9 5492.7 5495.2 3306.7 3400.5 3418.4 3439.3 3454.9 1066.9 1082.2 1082.6 1133.8 1135.2 12060.3 12100.6 12175.8 12179.8 12203.6 4419.7 4544.8 4645.9 4696.8 4718.4 9570.1 9632.1 9661.0 9668.2 9674.8 5444.4 5446.1 5451.0 5460.7 5464.0 4109.8 4237.8 4433.2 5063.8 5133.1 3611.4 3679.1 3764.6 3765.5 3840.6 1207.1 1235.5 1237.5 1242.4 1260.5 925.1 937.9 960.3 960.4 992.1 5895.3 5949.8 6012.6 6030.6 6120.8 486.5 492.0 498.3 501.2 501.3 4107.7 4163.4 4171.7 4188.8 4221.0 10486.6 10832.3 10887.2 10936.5 10938.5 10109.1 10536.5 10877.8 10883.9 10899.8 8200.4 8401.0 8422.2 8429.2 8429.6 5926.1 5936.6 6075.6 6095.7 6173.9 9932.2 9958.4 9978.6 9982.2 10179.0 8774.3 8989.6 10327.4 10479.8 10480.1 7622.8 7794.8 7846.3 7942.6 8022.5 8671.2 8689.0 8704.8 8705.3 8709.7 7637.8 7658.5 7715.5 7732.0 7852.7 7513.7 7707.8 7738.6 7791.2 7930.8 7000.8 7106.0 7110.3 7113.1 7117.5 5067.7 5158.2 5268.4 5291.8 5475.8 4965.1 5080.2 5096.0 5156.5 5310.8 08:12:11 INFO - PROCESS | 27410 | 08:12:11 INFO - PROCESS | 27410 | [#4] prototype.html Cycles:180 Average:4656.96 Median:5300.90 stddev:1348.49 (25.4%) stddev-sans-first:1312.73 08:12:11 INFO - PROCESS | 27410 | Values: 338.2 344.4 349.6 350.2 352.4 5386.9 5393.5 5406.7 5410.2 5423.2 5027.5 5190.5 5196.3 5254.7 5316.8 4191.9 4207.8 4211.0 4211.9 4218.6 4225.6 4229.5 4235.2 4239.9 4246.4 3898.0 3938.2 4087.8 4123.3 4134.8 4120.6 4120.9 4121.7 4125.7 4138.2 3668.4 3671.2 3671.7 3672.3 3672.8 4964.7 5190.6 5192.7 5194.6 5246.5 4801.5 4807.1 4814.1 4815.4 4830.7 5590.4 5597.9 5602.3 5616.2 5617.6 3990.2 4052.4 4058.4 4096.2 4117.0 5791.6 5803.0 5807.8 5811.5 5817.4 4155.2 4157.4 4159.8 4166.9 4177.8 3997.0 4101.2 4117.1 4218.0 4224.4 4715.6 4725.0 4725.4 4739.3 4746.7 5606.7 5607.5 5611.8 5617.2 5626.2 1305.9 1371.9 1407.4 1418.4 1429.5 880.8 1012.5 1029.7 1038.8 1039.7 5228.6 5253.2 5254.9 5260.2 5268.7 5463.3 5488.5 5502.6 5506.9 5512.5 5172.9 5474.8 5481.8 5484.9 5496.7 2881.2 2905.0 2924.4 2932.4 2940.6 5591.4 5647.8 5703.6 5790.3 5794.4 5625.7 5630.4 5652.8 5656.6 5662.0 5781.7 5786.6 5796.9 5802.4 5803.2 5394.5 5495.8 5519.5 5530.5 5531.9 5505.8 5510.5 5525.4 5530.8 5538.4 5545.7 5741.0 5772.0 5790.4 5793.1 4014.9 4054.5 4054.9 4059.9 4060.6 5542.7 5545.8 5557.7 5561.4 5562.7 5285.0 5379.5 5411.2 5446.6 5464.3 5370.2 5378.6 5437.2 5437.7 5480.6 5224.6 5325.0 5424.4 5432.0 5463.2 5602.8 5619.1 5635.2 5646.4 5649.2 5531.1 5541.5 5543.2 5567.4 5572.7 08:12:11 INFO - PROCESS | 27410 | 08:12:11 INFO - PROCESS | 27410 | [#5] yui.html Cycles:180 Average:18148.66 Median:49958.50 stddev:24901.63 (49.8%) stddev-sans-first:24936.91 08:12:11 INFO - PROCESS | 27410 | Values: 675.2 740.3 744.8 756.6 810.3 12863.9 12912.7 13541.4 13569.3 13591.0 13068.1 13299.7 13421.3 13476.5 13521.2 724.7 746.6 831.1 851.3 863.5 852.5 853.9 855.2 855.5 855.6 724.9 773.0 889.5 890.3 890.8 824.7 888.0 890.8 891.5 895.2 659.7 659.8 660.0 660.4 660.7 12346.9 12360.6 12413.4 12420.0 12420.5 12773.7 12924.5 13068.3 13145.5 13154.1 12119.4 12247.3 12319.3 12484.4 12573.7 4332.1 4388.8 4398.1 4425.8 4489.2 61465.1 62120.0 64928.4 65732.0 66255.3 10202.7 10412.5 10504.3 10628.9 10702.1 18014.2 18044.6 18230.3 18404.0 18443.3 7181.3 7252.7 7429.6 7520.4 7746.7 4604.4 4659.6 4682.7 4756.7 4809.2 3069.9 3152.6 3189.9 3191.0 3223.7 542.6 603.5 604.2 643.6 655.8 672.6 681.3 690.5 700.6 701.6 8971.5 9252.7 9258.4 9414.6 9601.2 657.3 668.8 670.4 682.2 683.2 4472.8 4780.7 4792.6 4798.4 4827.6 90247.0 92490.5 93011.5 93727.5 96658.0 59118.4 59221.0 81903.0 83998.0 85888.0 72731.0 75154.0 75918.0 76882.2 77996.0 9082.7 9188.4 9334.3 9390.3 9448.2 49923.0 49994.0 50664.5 51006.0 52451.5 65312.3 67660.0 68043.7 70711.3 71082.6 11074.6 11167.3 11229.4 11360.1 11376.1 12940.6 12951.3 13037.6 13092.8 13138.1 10701.8 12474.0 12716.4 12973.4 13624.7 12435.7 12602.4 12689.2 12971.9 13064.2 11891.3 12083.3 12159.3 12191.7 12394.9 10729.7 10829.5 11129.3 11332.8 11574.5 10607.3 11243.5 11368.9 11393.4 11436.0 08:12:11 INFO - PROCESS | 27410 | -------- Summary: end -------- 08:12:11 INFO - PROCESS | 27410 | 08:12:12 INFO - TEST-INFO | 27410: exit 0 08:12:12 INFO - TEST-OK | dromaeo_css | took 1115083ms 08:12:12 INFO - TEST-START | kraken 08:12:12 INFO - operating with platform_type : linux_ 08:12:12 INFO - Initialising browser for kraken test... 08:12:12 INFO - TEST-INFO | started process 27728 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGxhyLK/profile http://localhost:41870/getInfo.html) 08:12:15 INFO - PROCESS | 27728 | __metrics Screen width/height:1600/1200 08:12:15 INFO - PROCESS | 27728 | colorDepth:24 08:12:15 INFO - PROCESS | 27728 | Browser inner width/height: 1024/697 08:12:15 INFO - PROCESS | 27728 | __metrics 08:12:16 INFO - PROCESS | 27728 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:12:16 INFO - PROCESS | 27728 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:12:16 INFO - PROCESS | 27728 | console.error: PushService: 08:12:16 INFO - PROCESS | 27728 | stateChangeProcessEnqueue: Error transitioning state 08:12:16 INFO - PROCESS | 27728 | UnknownError 08:12:17 INFO - TEST-INFO | 27728: exit 0 08:12:17 INFO - Browser initialized. 08:12:17 INFO - Running cycle 1/1 for kraken test... 08:12:17 INFO - TEST-INFO | started process 27822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGxhyLK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:12:29 INFO - PROCESS | 27822 | RSS: Main: 144904192 08:12:29 INFO - PROCESS | 27822 | 08:12:31 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41870/tests/kraken/driver.html?testName=audio-beat-detection) 08:12:32 INFO - PROCESS | 27822 | RSS: Main: 186253312 08:12:32 INFO - PROCESS | 27822 | 08:12:35 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41870/tests/kraken/driver.html?testName=audio-dft) 08:12:35 INFO - PROCESS | 27822 | RSS: Main: 176386048 08:12:35 INFO - PROCESS | 27822 | 08:12:38 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41870/tests/kraken/driver.html?testName=audio-fft) 08:12:39 INFO - PROCESS | 27822 | RSS: Main: 266776576 08:12:39 INFO - PROCESS | 27822 | 08:12:41 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41870/tests/kraken/driver.html?testName=audio-oscillator) 08:12:41 INFO - PROCESS | 27822 | RSS: Main: 173137920 08:12:41 INFO - PROCESS | 27822 | 08:12:43 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41870/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:12:44 INFO - PROCESS | 27822 | RSS: Main: 175767552 08:12:44 INFO - PROCESS | 27822 | 08:12:47 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41870/tests/kraken/driver.html?testName=imaging-darkroom) 08:12:48 INFO - PROCESS | 27822 | RSS: Main: 214802432 08:12:48 INFO - PROCESS | 27822 | 08:12:51 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41870/tests/kraken/driver.html?testName=imaging-desaturate) 08:12:51 INFO - PROCESS | 27822 | RSS: Main: 213204992 08:12:51 INFO - PROCESS | 27822 | 08:12:54 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41870/tests/kraken/driver.html?testName=json-parse-financial) 08:12:55 INFO - PROCESS | 27822 | RSS: Main: 211865600 08:12:55 INFO - PROCESS | 27822 | 08:12:56 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41870/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:12:57 INFO - PROCESS | 27822 | RSS: Main: 174153728 08:12:57 INFO - PROCESS | 27822 | 08:12:58 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41870/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:12:59 INFO - PROCESS | 27822 | RSS: Main: 180731904 08:12:59 INFO - PROCESS | 27822 | 08:13:01 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41870/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:13:02 INFO - PROCESS | 27822 | RSS: Main: 190164992 08:13:02 INFO - PROCESS | 27822 | 08:13:04 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:13:05 INFO - PROCESS | 27822 | RSS: Main: 199110656 08:13:05 INFO - PROCESS | 27822 | 08:13:08 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:13:08 INFO - PROCESS | 27822 | RSS: Main: 195145728 08:13:08 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | Cycle 1(1): loaded http://localhost:41870/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41870/tests/kraken/driver.html?testName=ai-astar) 08:13:10 INFO - PROCESS | 27822 | RSS: Main: 247377920 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | __start_tp_report 08:13:10 INFO - PROCESS | 27822 | _x_x_mozilla_page_load 08:13:10 INFO - PROCESS | 27822 | _x_x_mozilla_page_load_details 08:13:10 INFO - PROCESS | 27822 | |i|pagename|runs| 08:13:10 INFO - PROCESS | 27822 | |0;ai-astar;102;113;110;109;110;111;110;112;110;109 08:13:10 INFO - PROCESS | 27822 | |1;audio-beat-detection;157;120;121;157;122;121;126;125;153;121 08:13:10 INFO - PROCESS | 27822 | |2;audio-dft;162;165;160;160;160;161;161;161;159;161 08:13:10 INFO - PROCESS | 27822 | |3;audio-fft;76;75;75;106;74;76;76;75;101;75 08:13:10 INFO - PROCESS | 27822 | |4;audio-oscillator;82;81;125;82;81;81;99;82;81;122 08:13:10 INFO - PROCESS | 27822 | |5;imaging-gaussian-blur;117;117;116;117;117;117;116;117;117;116 08:13:10 INFO - PROCESS | 27822 | |6;imaging-darkroom;146;146;146;146;147;146;147;146;147;146 08:13:10 INFO - PROCESS | 27822 | |7;imaging-desaturate;85;85;84;84;84;85;85;84;84;84 08:13:10 INFO - PROCESS | 27822 | |8;json-parse-financial;53;52;51;51;51;52;62;52;52;51 08:13:10 INFO - PROCESS | 27822 | |9;json-stringify-tinderbox;58;59;60;58;59;60;59;59;60;59 08:13:10 INFO - PROCESS | 27822 | |10;stanford-crypto-aes;78;75;74;75;76;87;75;74;81;75 08:13:10 INFO - PROCESS | 27822 | |11;stanford-crypto-ccm;138;136;143;126;127;130;124;128;167;136 08:13:10 INFO - PROCESS | 27822 | |12;stanford-crypto-pbkdf2;160;161;161;165;159;162;161;162;160;159 08:13:10 INFO - PROCESS | 27822 | |13;stanford-crypto-sha256-iterative;63;62;64;63;63;65;63;64;62;62 08:13:10 INFO - PROCESS | 27822 | __end_tp_report 08:13:10 INFO - PROCESS | 27822 | __start_cc_report 08:13:10 INFO - PROCESS | 27822 | _x_x_mozilla_cycle_collect,1624 08:13:10 INFO - PROCESS | 27822 | __end_cc_report 08:13:10 INFO - PROCESS | 27822 | __startTimestamp1481299990720__endTimestamp 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | ------- Summary: start ------- 08:13:10 INFO - PROCESS | 27822 | Number of tests: 14 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#0] ai-astar Cycles:10 Average:109.60 Median:110.00 stddev:2.95 (2.7%) stddev-sans-first:1.33 08:13:10 INFO - PROCESS | 27822 | Values: 102.0 113.0 110.0 109.0 110.0 111.0 110.0 112.0 110.0 109.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#1] audio-beat-detection Cycles:10 Average:132.30 Median:125.50 stddev:16.27 (13.0%) stddev-sans-first:14.60 08:13:10 INFO - PROCESS | 27822 | Values: 157.0 120.0 121.0 157.0 122.0 121.0 126.0 125.0 153.0 121.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.63 (1.0%) stddev-sans-first:1.69 08:13:10 INFO - PROCESS | 27822 | Values: 162.0 165.0 160.0 160.0 160.0 161.0 161.0 161.0 159.0 161.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#3] audio-fft Cycles:10 Average:80.90 Median:75.00 stddev:11.99 (16.0%) stddev-sans-first:12.58 08:13:10 INFO - PROCESS | 27822 | Values: 76.0 75.0 75.0 106.0 74.0 76.0 76.0 75.0 101.0 75.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#4] audio-oscillator Cycles:10 Average:91.60 Median:81.50 stddev:17.70 (21.7%) stddev-sans-first:18.43 08:13:10 INFO - PROCESS | 27822 | Values: 82.0 81.0 125.0 82.0 81.0 81.0 99.0 82.0 81.0 122.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 08:13:10 INFO - PROCESS | 27822 | Values: 117.0 117.0 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 08:13:10 INFO - PROCESS | 27822 | Values: 146.0 146.0 146.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:84.50 stddev:0.52 (0.6%) stddev-sans-first:0.50 08:13:10 INFO - PROCESS | 27822 | Values: 85.0 85.0 84.0 84.0 84.0 85.0 85.0 84.0 84.0 84.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.00 stddev:3.33 (6.4%) stddev-sans-first:3.54 08:13:10 INFO - PROCESS | 27822 | Values: 53.0 52.0 51.0 51.0 51.0 52.0 62.0 52.0 52.0 51.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#9] json-stringify-tinderbox Cycles:10 Average:59.10 Median:59.00 stddev:0.74 (1.3%) stddev-sans-first:0.67 08:13:10 INFO - PROCESS | 27822 | Values: 58.0 59.0 60.0 58.0 59.0 60.0 59.0 59.0 60.0 59.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#10] stanford-crypto-aes Cycles:10 Average:77.00 Median:75.50 stddev:4.11 (5.4%) stddev-sans-first:4.34 08:13:10 INFO - PROCESS | 27822 | Values: 78.0 75.0 74.0 75.0 76.0 87.0 75.0 74.0 81.0 75.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:136.00 stddev:12.63 (9.3%) stddev-sans-first:13.37 08:13:10 INFO - PROCESS | 27822 | Values: 138.0 136.0 143.0 126.0 127.0 130.0 124.0 128.0 167.0 136.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:161.00 Median:161.00 stddev:1.76 (1.1%) stddev-sans-first:1.83 08:13:10 INFO - PROCESS | 27822 | Values: 160.0 161.0 161.0 165.0 159.0 162.0 161.0 162.0 160.0 159.0 08:13:10 INFO - PROCESS | 27822 | 08:13:10 INFO - PROCESS | 27822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:0.99 (1.6%) stddev-sans-first:1.05 08:13:10 INFO - PROCESS | 27822 | Values: 63.0 62.0 64.0 63.0 63.0 65.0 63.0 64.0 62.0 62.0 08:13:10 INFO - PROCESS | 27822 | -------- Summary: end -------- 08:13:10 INFO - PROCESS | 27822 | 08:13:11 INFO - TEST-INFO | 27822: exit 0 08:13:11 INFO - TEST-OK | kraken | took 59928ms 08:13:11 INFO - SUITE-END | took 1175s 08:13:12 INFO - Completed test suite (00:19:35) 08:13:12 INFO - javascript benchmark 08:13:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3203.4714272145097, 3228.8062716237027, 3241.335526217126, 3262.1192278084905, 3277.8361081945895, 5412.918806217905, 5476.178573214015, 5477.096279113952, 5486.259354987075, 5498.422665620113, 5514.172874068881, 5572.164175373696, 5573.442655734424, 5585.944140558603, 5598.524125449342, 5005.249212618109, 5023.146065168912, 5046.84859454217, 5085.262636917645, 5125.923111153335, 4875.219964805632, 4901.852944411673, 5049.873753156164, 5107.668001579904, 5113.284140220372, 4971.950280497203, 4990.8003679852945, 4997.175466048097, 5012.298278241049, 5044.243363495469, 5013.924791128136, 5082.186850103965, 5100.183970564692, 5115.2071428928575, 5130.692158470466, 4761.952380476186, 4778.235482322846, 4997.525235102659, 5000.42495113063, 5057.797688092472, 5399.7030163341, 5465.890682186374, 5476.17857321405, 5496.697681627509, 5512.476314750133, 5867.706614669292, 5930.495907847838, 5930.673812940287, 5933.110033495011, 5936.22829032223, 5650.6892120933335, 5813.157092221646, 5954.523638108941, 5970.194023806774, 5970.761169553212, 5492.313460817398, 5515.172724091378, 5539.612227144102, 5591.41290164535, 5625.071863142535, 6063.6664983426335, 6076.483498902643, 6085.421884920926, 6088.391160883876, 6089.786857459968, 5557.083081291623, 5863.941360586339, 5864.208331875142, 5868.149118377897, 5873.794417195463, 5580.19087232349, 5889.793857215062, 5894.941050589439, 5936.020556608198, 6043.0, 5955.642661440327, 5980.22257106582, 5999.850003749854, 6005.279366476051, 6037.184980027728, 6003.849903752441, 6006.489448396847, 6015.608985415934, 6018.759249629966, 6019.097135429633, 4417.977910110493, 4440.977795111004, 4506.977465112654, 4518.2319005769095, 4526.683132180781, 4047.4131250968444, 4054.3715724062818, 4071.1043570414463, 4078.2659121357847, 4087.2234275487563, 5565.721713914288, 5570.025245582088, 5573.749181286852, 5576.0, 5604.0, 5553.0, 5600.551955843523, 5811.012127938261, 5885.293764748258, 5904.881902361929, 5667.1782591524, 5683.54531637468, 5711.543076553949, 5728.255326807488, 5744.195812586241, 5100.974495127575, 5110.616703747234, 5113.386393632788, 5115.693058416507, 5145.948540514547, 5839.124131380242, 5904.173415721888, 6039.728212230372, 6233.532485063638, 6246.15676883624, 5799.652020878761, 5873.676947767914, 5875.529957603467, 5892.204552385373, 5904.291485021653, 6116.418940200674, 6124.295705993868, 6127.632342059491, 6127.662978536223, 6132.601380910227, 5550.833474995757, 5579.46995035471, 5791.102379131242, 5795.420457954171, 5797.956367853827, 5902.940970590411, 6001.4298641628975, 6011.308699499614, 6034.974054410673, 6035.215421995113, 5838.532917366516, 5856.531477481876, 5860.38465961068, 5873.676947767914, 5879.382664820132, 5494.697791621499, 5552.500274975271, 5796.507296879812, 5873.9412605873395, 5879.029960056714, 5680.545556355399, 5745.8563535911935, 5751.1373294006235, 5801.738921748447, 5830.067189249699, 5821.621594596338, 5834.0, 5854.356020837619, 5854.385289544707, 5856.59003869725, 5432.782688692408, 5456.890862182813, 5456.972715136399, 5717.885642287048, 5749.913751293818], "value": 5447.740405343515, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.7635269539489, 599.9580029397943, 638.1958731997681, 639.4564620072939, 667.1127400557259, 33451.83274083629, 44452.3332150018, 44979.77510112445, 45018.77490612551, 45100.77449612747, 45332.320015199715, 45830.541694583044, 45850.77074614622, 45925.540744592545, 45932.311015334715, 8183.345332373426, 8804.779880502974, 8949.105089491031, 8950.0, 8961.238294744922, 8220.671173153067, 8437.789055273606, 8441.746747597583, 10752.408617526033, 11036.227464077518, 10858.837117443245, 10945.179111566624, 10945.616903408381, 10949.671509854717, 10956.233063685546, 10611.681649550486, 10645.680629581126, 10663.466826658674, 10667.626633067805, 10671.519781609846, 10639.255252132354, 10697.572097116106, 10699.358038517636, 10701.250912436133, 10705.197110216764, 43180.136397272196, 43476.34785478189, 43569.56430435687, 43577.12845743068, 43625.78187109076, 3449.5170676105367, 3563.5901871284614, 3563.964360356389, 3575.5888072871694, 3691.667749902522, 32425.51361729576, 32580.0, 32871.83564082164, 32928.17679558006, 33206.67668602311, 4193.811278492475, 4206.621404073648, 4210.221109094828, 4228.1966426379195, 4240.08838099807, 253714.0, 254783.72608137026, 256187.0, 256448.0, 256520.0, 62106.37893621006, 62446.37553624497, 62509.68745156336, 62560.37439625637, 62593.68703156546, 39989.0, 40789.18421631551, 40918.590814091476, 42831.143377132285, 42879.35680964788, 17175.484735457707, 17317.307307707804, 17331.65336693259, 17339.306427742747, 17340.47978560645, 12149.635510934686, 12805.039622028386, 12822.294773787531, 12829.807552886714, 12838.16551924122, 18319.54201144982, 19488.220471181277, 19851.60296794085, 19899.502512437306, 20544.897275513526, 7257.782266532013, 7320.853582928312, 7375.704971801175, 7527.059117610299, 7613.352865006536, 1037.3775734559356, 1070.8768491623407, 1103.7516558774212, 1108.1024370260116, 1114.1922106472905, 33506.0, 33942.32115357679, 34019.82990085034, 34026.48960265598, 34597.654023459945, 1098.5770478365728, 1156.3351073132983, 1168.462507246659, 1225.5159212111344, 1243.7450322683828, 16912.238949247312, 17501.212445439985, 17724.734128988075, 17755.112244387987, 17814.91092544529, 538996.0, 551765.0, 552288.0, 552838.0, 554134.0, 61781.69109154426, 62273.37726622766, 62410.0, 62450.0, 62612.68693656503, 1291.380137533989, 1347.5755137131773, 1354.5123755448228, 1417.3196865504615, 1421.8364888038009, 30292.54561181628, 33860.492092619126, 34364.48453273153, 36201.0, 36550.45174322334, 57904.4209557899, 58177.70911145417, 58415.12377314429, 58420.0, 58483.4151658478, 460193.0, 464142.0, 466119.0, 472664.0, 473834.0, 30463.847680761453, 30647.2338191547, 38779.0, 38857.80571097126, 39307.0, 43889.561104388544, 45794.542054579026, 50495.49504504908, 52319.215211772615, 53081.73459132679, 41139.794301028305, 41697.58302416937, 41808.79095604503, 41829.0, 43885.78057109694, 42174.78912605417, 42922.0, 43522.78238608914, 44165.558344416146, 44723.0, 42588.36117458178, 43713.0, 43839.56160438482, 44468.55531444644, 44721.0, 36361.63638363582, 38235.80882095572, 38634.22731545297, 39241.6075839238, 39340.0, 29140.417191656474, 29399.235607930532, 29513.0, 29586.408271834873, 29705.5544166842], "value": 20837.936771229248, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [419.20351332468323, 422.9386738922858, 430.0689008297037, 431.12696789002274, 443.4656239231726, 18557.0, 18840.34058807942, 20099.29652462164, 20197.798022019775, 20273.898630506847, 19519.804801951977, 19523.535734819874, 19538.706919396183, 20419.081141348637, 20520.794792052075, 1897.7722673279227, 1900.37287695061, 1904.2954106980437, 1905.9428217153506, 2076.6573515369982, 5755.194272801811, 5859.44335288147, 5860.619059761123, 5864.853378665525, 5869.530437564985, 5679.062954612505, 5759.366469688331, 5770.249867517216, 5830.271216097988, 5864.0, 5807.2450581424355, 5842.824715258549, 5852.56105792063, 5854.941450585482, 5860.384659610765, 5083.771230294646, 5275.57795376369, 5307.65500242483, 5312.043832110218, 5314.043472175007, 23697.170599028952, 23958.880205599035, 24176.395590110213, 24258.636120458206, 24370.0, 2424.4787370715203, 2635.2094371688418, 2656.588228824516, 3118.2516196112997, 3268.313654132635, 10625.0, 11190.776184476264, 11206.103511719042, 11288.266262692981, 11323.773524529463, 1973.15154483572, 1988.8408927285782, 2016.667249903764, 2038.6941958706163, 2040.7245021922, 80537.59731201307, 82441.58779206185, 83641.58179209125, 86836.56581717114, 90482.90341931574, 11540.538378464767, 11764.705882352839, 11807.940960295144, 11882.277069824828, 12104.515819367127, 17216.655666886592, 17219.052952087506, 17228.569285767957, 17246.65506689859, 17263.74104388435, 8289.626966786509, 8360.498370097814, 8406.781016752537, 8424.957875210584, 8527.0, 7918.881216781753, 7964.761057168294, 8034.919650803534, 8125.3499720022255, 8131.227533384319, 5038.420581633086, 5097.6941383517105, 5128.897422051538, 5142.948570514322, 5269.894602108013, 2125.171183238538, 2128.17001369466, 2130.754963179223, 2158.2230397057047, 2166.2418153646413, 952.9237660987104, 962.4465932089076, 1031.4481752262504, 1044.2481413382352, 1060.5863713151878, 20391.89804051, 20695.689564656543, 20998.0, 21152.298347789074, 21329.146834126772, 985.1675334342469, 1009.6112996496255, 1026.8049070676548, 1036.1296510930854, 1079.093561408405, 10593.682189534326, 11164.776704466027, 11292.491837867316, 11468.54125834974, 11509.53961841517, 454641.0, 458340.0, 461127.0, 497363.0, 497621.0, 73069.6346518264, 73472.99999999894, 92390.0, 99903.0, 99958.0, 956.2350119904049, 1011.9949400252951, 1016.1718199667396, 1063.994680026595, 1069.8395240713799, 17996.280148793903, 18008.639827203122, 18484.537886552946, 18809.623807524047, 18984.240630374632, 43523.55955505562, 43710.56289437065, 43765.56234437615, 44971.550284496734, 45948.310775337726, 60363.698181508815, 61229.69385153046, 61232.69383653053, 61512.38487615067, 61642.383576163666, 8785.472871627722, 8861.0, 8949.776255593402, 9016.323775716717, 9023.684171053981, 12804.0, 13118.803217951547, 13328.600141995756, 13874.236916969663, 14255.215963121713, 11819.940900295443, 11841.822372664245, 11940.223885447418, 11967.820482692592, 12699.682507937376, 11087.390193539433, 11165.72085697864, 11436.313821170756, 11589.130815188726, 11659.067274618179, 11496.310221386744, 11577.594784182513, 11753.706157345792, 11924.880751192377, 12928.547500837425, 8816.118388161132, 9036.23192028685, 9186.678466253648, 9243.2143267823, 9283.164515193665, 9181.126574948627, 11823.70440738954, 11962.162648614514, 11983.64049078529, 12645.367731613567], "value": 9291.297462367478, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1333.3466601365335, 1496.214487394118, 1498.0337682194984, 1664.2178176257155, 1823.3527097880244, 7455.478116531838, 8353.665853365866, 8724.258438032759, 8746.956265218672, 9002.414843035198, 8801.339899507531, 8870.556472176399, 8876.911230887688, 8879.644814207424, 8902.599383027764, 2234.597772400967, 2259.559385919746, 2260.389694782408, 2261.378121016717, 2266.1048885690143, 2399.7240317363553, 2413.4811015631635, 2460.938476538083, 2467.3584867934287, 2478.628205769131, 2359.4691194481275, 2363.7045369328835, 2377.203636781672, 2388.4984153327823, 2390.8924098415614, 2333.2067097187037, 2336.3107883174503, 2353.2704861492994, 2379.0245999140357, 2380.4643955110137, 2345.882705864717, 2349.189529612281, 2396.5206958608173, 2397.6643269942224, 2397.700287464067, 8557.315414766867, 8678.566071696454, 8835.77910552235, 8849.513276769776, 8850.468971861708, 5329.680219186861, 5482.424345443711, 5485.945140548583, 5492.725363731797, 5495.230667706524, 3306.718928891047, 3400.506926495669, 3418.4017796885696, 3439.2949445363893, 3454.9481757773656, 1066.935983840972, 1082.1991726122692, 1082.588616325799, 1133.8412622232895, 1135.154310039018, 12060.276383416935, 12100.576479823252, 12175.756484870342, 12179.756404871941, 12203.633890983196, 4419.7348159109915, 4544.7500387479, 4645.86062418128, 4696.788644511005, 4718.363020992191, 9570.138687518156, 9632.084951929555, 9660.95169524148, 9668.178204852526, 9674.806503869882, 5444.428335024765, 5446.128619420953, 5451.046066938349, 5460.726963651801, 5464.016477034172, 4109.773962432095, 4237.766922819213, 4433.179861725526, 5063.772130254148, 5133.101707201225, 3611.422172452395, 3679.1170119171206, 3764.604716504782, 3765.548134223856, 3840.615938406193, 1207.088648070701, 1235.5119727707506, 1237.5359240284893, 1242.4222736427423, 1260.5021016698536, 925.0841666749869, 937.9296552758434, 960.2558017536466, 960.3949511807656, 992.0674565908023, 5895.322037965603, 5949.82150535476, 6012.579119461683, 6030.6080104793045, 6120.846978825565, 486.5280677742655, 491.9729414882216, 498.3471652135714, 501.2155975897708, 501.33072348414544, 4107.732997355162, 4163.375493675912, 4171.728837625545, 4188.8324467020975, 4221.0, 10486.580536778443, 10832.295900766425, 10887.183461240438, 10936.507857146447, 10938.453077346101, 10109.140723038478, 10536.473176341153, 10877.782444351069, 10883.945580272048, 10899.83650245247, 8200.384971127189, 8400.957995209985, 8422.24199822019, 8429.199226073391, 8429.578521074045, 5926.140709596998, 5936.5844390892225, 6075.574709770273, 6095.725692343766, 6173.876522469435, 9932.155766759906, 9958.402495850272, 9978.550965206729, 9982.151517121127, 10179.03299186576, 8774.254188394058, 8989.55052247398, 10327.431991240554, 10479.790404192026, 10480.10919071857, 7622.771316860503, 7794.766157015299, 7846.293833555007, 7942.64258108375, 8022.478538894953, 8671.176238257607, 8689.044205137303, 8704.825903481767, 8705.303575714055, 8709.651613935372, 7637.847243054996, 7658.540487570764, 7715.537067775726, 7731.95618591483, 7852.685892564462, 7513.699452021858, 7707.845843082995, 7738.574378409242, 7791.181925897699, 7930.841383172419, 7000.789976300719, 7106.040684507525, 7110.253423390676, 7113.0753002109395, 7117.501774875709, 5067.746612669425, 5158.200478925773, 5268.446813084571, 5291.788328466972, 5475.808346707846, 4965.1311020571975, 5080.161773307363, 5095.974520127375, 5156.484351564814, 5310.814121505883], "value": 4555.177116557132, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.2237764330862, 344.39902370363717, 349.6119307568599, 350.1700968704171, 352.42554635943407, 5386.865328366793, 5393.460653934604, 5406.675599464025, 5410.188471729242, 5423.186522021694, 5027.497250274971, 5190.480951904808, 5196.298499702539, 5254.710990895499, 5316.813911513098, 4191.937120943188, 4207.842843218116, 4211.010412553048, 4211.936820947688, 4218.641415479688, 4225.577442255781, 4229.492460904696, 4235.195312890556, 4239.936400953989, 4246.447961764966, 3898.0, 3938.1532970411354, 4087.7751723655188, 4123.340265557511, 4134.772587507686, 4120.6195924365375, 4120.876373708794, 4121.690873184523, 4125.731827431237, 4138.213739389522, 3668.413053911361, 3671.1556342041213, 3671.6511931366476, 3672.2839046385966, 3672.797996110213, 4964.702117872939, 5190.636655434121, 5192.688438693653, 5194.636570201511, 5246.501582349671, 4801.51984801517, 4807.11068452334, 4814.063421312996, 4815.422149342066, 4830.710157390533, 5590.357108932443, 5597.860053498654, 5602.327720673505, 5616.241807356037, 5617.606767526275, 3990.1620659661507, 4052.4124002019835, 4058.370952502367, 4096.242195193899, 4116.958830411718, 5791.594588378815, 5803.0, 5807.767689292381, 5811.4790948599, 5817.360090390053, 4155.210510003089, 4157.376393540932, 4159.7745206315085, 4166.895827604334, 4177.791110444466, 3997.0, 4101.159262351271, 4117.053077792125, 4217.957820421818, 4224.366345048267, 4715.599174070174, 4724.976375118103, 4725.36207611968, 4739.265413860857, 4746.691465054761, 5606.747696353592, 5607.49532542065, 5611.765411609439, 5617.241672374177, 5626.240457538262, 1305.8694130586866, 1371.8833899118686, 1407.35965135865, 1418.3688258724974, 1429.5282556756245, 880.7933131609735, 1012.5443550402348, 1029.6859457865273, 1038.774246389268, 1039.6828967164936, 5228.61441717945, 5253.238280449314, 5254.894902102013, 5260.237265596544, 5268.710220937808, 5463.344398672185, 5488.506034456918, 5502.642328248651, 5506.944930550723, 5512.531434828004, 5172.8965420691375, 5474.835754927359, 5481.835544933659, 5484.862878428071, 5496.653319936561, 2881.1788640237432, 2905.0, 2924.4151169766133, 2932.3841993181245, 2940.6324209473814, 5591.412901645269, 5647.830565083054, 5703.572232082527, 5790.334111577138, 5794.435502414324, 5625.718714064362, 5630.4369563043365, 5652.802151924663, 5656.575756818255, 5662.009148399096, 5781.653100813965, 5786.566007549366, 5796.884062318814, 5802.4197580241635, 5803.216565763568, 5394.462578165204, 5495.807646732345, 5519.530839878656, 5530.5022547970875, 5531.8893622126525, 5505.752241149238, 5510.476504732044, 5525.392206857323, 5530.751116199861, 5538.363088244742, 5545.698535107885, 5740.971295143498, 5772.0, 5790.39200883918, 5793.11861053087, 4014.87583476627, 4054.533728621246, 4054.8986275343354, 4059.939100913548, 4060.5939406059156, 5542.695151766691, 5545.778168873361, 5557.749901254372, 5561.386148510193, 5562.749676264497, 5284.981306180929, 5379.542738867083, 5411.161270003156, 5446.618736688552, 5464.262324586289, 5370.167624018283, 5378.623496355218, 5437.238786569963, 5437.700926449083, 5480.588955828249, 5224.582033437392, 5325.0, 5424.403315635198, 5431.9803345524815, 5463.180522921434, 5602.831915042555, 5619.134241536927, 5635.239242702182, 5646.35066967304, 5649.231876380626, 5531.1426728857095, 5541.5289700375915, 5543.1685247213245, 5567.415421380859, 5572.665640061609], "value": 4232.9780277456575, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.2032601530192, 740.2560426771095, 744.757953665059, 756.6254703921558, 810.2990912860374, 12863.935680321585, 12912.741745165104, 13541.390637421315, 13569.321533923314, 13591.048626596155, 13068.085234033622, 13299.734005319888, 13421.328933553332, 13476.52832150875, 13521.188728676287, 724.6811402982684, 746.6005686957479, 831.1148626712531, 851.2806678356809, 863.4819108534891, 852.5481494807761, 853.8804567360575, 855.2388374346805, 855.4909828651973, 855.6491838346279, 724.9456290778186, 773.0452890680006, 889.4929889962724, 890.3100097424483, 890.781758469176, 824.7360844529753, 887.9600417981175, 890.7862113092876, 891.5052146058935, 895.2211575928983, 659.650385295794, 659.8449364399362, 659.9835004124935, 660.4221306356937, 660.6696651674163, 12346.876531234662, 12360.567380141652, 12413.379331033502, 12420.0, 12420.503179872794, 12773.744525109445, 12924.483020679161, 13068.281244531547, 13145.474181032747, 13154.144980576231, 12119.39403029845, 12247.265164090093, 12319.260844349277, 12484.375781210903, 12573.748525029449, 4332.133573285324, 4388.846390376353, 4398.120375924827, 4425.845095421645, 4489.21438748221, 61465.07802382968, 62120.0, 64928.350716492234, 65732.0, 66255.3374466254, 10202.744931376626, 10412.479376031168, 10504.317219380715, 10628.893711062945, 10702.143828493701, 18014.189361478766, 18044.639107217783, 18230.270789168284, 18404.0, 18443.26226950907, 7181.291185651228, 7252.709891604382, 7429.62851857405, 7520.360769334668, 7746.651400686983, 4604.447466304065, 4659.603933665609, 4682.719036857799, 4756.738379389167, 4809.158397280462, 3069.8772049117783, 3152.621685397721, 3189.9043028709175, 3190.952135717966, 3223.693749093832, 542.5984771269311, 603.5232166588434, 604.2265899648457, 643.6073994863129, 655.7508146904241, 672.630053470599, 681.3356976947437, 690.4648897104784, 700.5901547594613, 701.6491754122939, 8971.50656713887, 9252.722418327461, 9258.444493330288, 9414.576344064533, 9601.183899368492, 657.3163909534127, 668.7859884836805, 670.396643021275, 682.1711620381261, 683.1870074611197, 4472.837092208166, 4780.689255198401, 4792.600201469831, 4798.352222449925, 4827.637927155407, 90247.0, 92490.53754731317, 93011.53494232486, 93727.53136234412, 96658.0, 59118.40881591215, 59221.0, 81903.0, 83998.0, 85888.0, 72731.0, 75154.0, 75918.0, 76882.23117768862, 77996.0, 9082.727518174466, 9188.448693078437, 9334.346595738232, 9390.342676012613, 9448.196903263024, 49923.0, 49994.0, 50664.49335506598, 51006.0, 52451.475485246185, 65312.346876530624, 67660.0, 68043.65978170077, 70711.29288707253, 71082.6445867788, 11074.5570177192, 11167.274127181707, 11229.4115011871, 11360.091192704398, 11376.089912807121, 12940.611781646565, 12951.287679177736, 13037.608871733863, 13092.803607945698, 13138.080334376502, 10701.785964280827, 12474.0, 12716.364181790688, 12973.351332433529, 13624.727505450033, 12435.69939561184, 12602.432890520133, 12689.175203611736, 12971.935140324238, 13064.150830196388, 11891.345975971404, 12083.275003499819, 12159.331236782062, 12191.695207619881, 12394.876051239373, 10729.678109656723, 10829.47586612392, 11129.276597021168, 11332.773344533229, 11574.537018519164, 10607.310524815863, 11243.491043176922, 11368.886311136783, 11393.373364465035, 11436.0], "value": 7076.566149687896, "unit": "score"}], "name": "dromaeo_css", "value": 7239.268171299634, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 113.0, 110.0, 109.0, 110.0, 111.0, 110.0, 112.0, 110.0, 109.0], "value": 109.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [157.0, 120.0, 121.0, 157.0, 122.0, 121.0, 126.0, 125.0, 153.0, 121.0], "value": 132.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 165.0, 160.0, 160.0, 160.0, 161.0, 161.0, 161.0, 159.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 106.0, 74.0, 76.0, 76.0, 75.0, 101.0, 75.0], "value": 80.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 125.0, 82.0, 81.0, 81.0, 99.0, 82.0, 81.0, 122.0], "value": 91.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 84.0, 84.0, 84.0, 85.0, 85.0, 84.0, 84.0, 84.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 52.0, 51.0, 51.0, 51.0, 52.0, 62.0, 52.0, 52.0, 51.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 59.0, 60.0, 58.0, 59.0, 60.0, 59.0, 59.0, 60.0, 59.0], "value": 59.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 74.0, 75.0, 76.0, 87.0, 75.0, 74.0, 81.0, 75.0], "value": 77.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 136.0, 143.0, 126.0, 127.0, 130.0, 124.0, 128.0, 167.0, 136.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 161.0, 165.0, 159.0, 162.0, 161.0, 162.0, 160.0, 159.0], "value": 161.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 64.0, 63.0, 63.0, 65.0, 63.0, 64.0, 62.0, 62.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1471.2, "alertThreshold": 2.0}]} 08:13:12 INFO - Return code: 0 08:13:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:13:12 INFO - # TBPL SUCCESS # 08:13:12 INFO - Running post-action listener: _resource_record_post_action 08:13:12 INFO - [mozharness: 2016-12-09 16:13:12.544968Z] Finished run-tests step (success) 08:13:12 INFO - Running post-run listener: _resource_record_post_run 08:13:12 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 266240; Write bytes: 357715968; Read time: 28; Write time: 257260 08:13:12 INFO - TinderboxPrint: CPU usage
13.0% 08:13:12 INFO - TinderboxPrint: I/O read bytes / time
266,240 / 28 08:13:12 INFO - TinderboxPrint: I/O write bytes / time
357,715,968 / 257,260 08:13:12 INFO - TinderboxPrint: CPU idle
8,276.5 (87.0%) 08:13:12 INFO - TinderboxPrint: CPU user
1,192.9 (12.5%) 08:13:12 INFO - TinderboxPrint: Swap in / out
0 / 0 08:13:12 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 108150784; Read time: 0; Write time: 122644 08:13:12 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 262144; Write bytes: 249225216; Read time: 20; Write time: 134572 08:13:13 INFO - Running post-run listener: _upload_blobber_files 08:13:13 INFO - Blob upload gear active. 08:13:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:13:13 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 08:13:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:13:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:13:13 INFO - (blobuploader) - INFO - Open directory for files ... 08:13:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:13:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:13:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:14 INFO - (blobuploader) - INFO - Done attempting. 08:13:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:13:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:17 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:13:17 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:17 INFO - (blobuploader) - INFO - Done attempting. 08:13:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:13:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:13:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:13:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:13:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:13:18 INFO - (blobuploader) - INFO - Done attempting. 08:13:18 INFO - (blobuploader) - INFO - Iteration through files over. 08:13:18 INFO - Return code: 0 08:13:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:13:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:13:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b38b3bacf9d6a8c4d2f080a84182dc75fd43654da2ab7681e834b0484466939a21e75bb77571d232f9853df2cf0481df097555bd14fe810c0fe7267d6f7ad19e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce34921ab5833660287b960ef9181ec76fee1ce9d91037a4ea79a721eba7ed84127639c3e78c65885562509366621512ce6c03ac3348dbe6465e5150875e2c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6d551a1b0f1de6773b3ca5810f6e002a60d64bcf5ccfc16cf2f321ed661e4fcd09f4cf057930e3558ddb2835685a9fa2324cede065c009318ea172c03a2f18b"} 08:13:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:13:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:13:18 INFO - Contents: 08:13:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b38b3bacf9d6a8c4d2f080a84182dc75fd43654da2ab7681e834b0484466939a21e75bb77571d232f9853df2cf0481df097555bd14fe810c0fe7267d6f7ad19e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce34921ab5833660287b960ef9181ec76fee1ce9d91037a4ea79a721eba7ed84127639c3e78c65885562509366621512ce6c03ac3348dbe6465e5150875e2c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6d551a1b0f1de6773b3ca5810f6e002a60d64bcf5ccfc16cf2f321ed661e4fcd09f4cf057930e3558ddb2835685a9fa2324cede065c009318ea172c03a2f18b"} 08:13:18 INFO - Running post-run listener: copy_logs_to_upload_dir 08:13:18 INFO - Copying logs to upload dir... 08:13:18 INFO - mkdir: /builds/slave/test/build/upload/logs 08:13:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.901605 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-12-09 08:13:18.726836) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 08:13:18.730529) ========= 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=ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240 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-Aurora/sha512/b38b3bacf9d6a8c4d2f080a84182dc75fd43654da2ab7681e834b0484466939a21e75bb77571d232f9853df2cf0481df097555bd14fe810c0fe7267d6f7ad19e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce34921ab5833660287b960ef9181ec76fee1ce9d91037a4ea79a721eba7ed84127639c3e78c65885562509366621512ce6c03ac3348dbe6465e5150875e2c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6d551a1b0f1de6773b3ca5810f6e002a60d64bcf5ccfc16cf2f321ed661e4fcd09f4cf057930e3558ddb2835685a9fa2324cede065c009318ea172c03a2f18b"} build_url:https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011694 build_url: 'https://queue.taskcluster.net/v1/task/PyBn5j45Q7SlfDPggOT0_A/artifacts/public/build/firefox-52.0a2.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/b38b3bacf9d6a8c4d2f080a84182dc75fd43654da2ab7681e834b0484466939a21e75bb77571d232f9853df2cf0481df097555bd14fe810c0fe7267d6f7ad19e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/ce34921ab5833660287b960ef9181ec76fee1ce9d91037a4ea79a721eba7ed84127639c3e78c65885562509366621512ce6c03ac3348dbe6465e5150875e2c6f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/d6d551a1b0f1de6773b3ca5810f6e002a60d64bcf5ccfc16cf2f321ed661e4fcd09f4cf057930e3558ddb2835685a9fa2324cede065c009318ea172c03a2f18b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-12-09 08:13:18.756978) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 08:13:18.757298) ========= 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=ed14279e38b05397cf4aa391000001a4-1481298761.384949-1215772240 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004504 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-12-09 08:13:18.839359) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 08:13:18.839682) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-12-09 08:13:18.840025) ========= ========= Total master_lag: 0.17 =========