builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-061 starttime: 1474111869.25 results: success (0) buildid: 20160917031317 builduid: b32ad5235f3c43f896d03672b03156e3 revision: 42fd3f718fdc630d75b21776c1b18df399ed925f ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:09.249871) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:09.250311) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:09.250641) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:09.273341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:09.273671) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-17 04:31:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 103M=0s 2016-09-17 04:31:10 (103 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177695 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:09.466709) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:09.467099) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018376 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:09.521351) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:09.522079) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 42fd3f718fdc630d75b21776c1b18df399ed925f --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 42fd3f718fdc630d75b21776c1b18df399ed925f --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-17 04:31:10,951 truncating revision to first 12 chars 2016-09-17 04:31:10,951 Setting DEBUG logging. 2016-09-17 04:31:10,951 attempt 1/10 2016-09-17 04:31:10,951 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/42fd3f718fdc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-17 04:31:11,510 unpacking tar archive at: autoland-42fd3f718fdc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.889351 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:10.428991) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:10.429354) ========= script_repo_revision: 42fd3f718fdc630d75b21776c1b18df399ed925f ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:10.429826) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:10.430167) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-17 04:31:10.461406) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-09-17 04:31:10.461719) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:31:11 INFO - MultiFileLogger online at 20160917 04:31:11 in /builds/slave/test 04:31:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 04:31:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:31:11 INFO - {'append_to_log': False, 04:31:11 INFO - 'base_work_dir': '/builds/slave/test', 04:31:11 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 04:31:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:31:11 INFO - 'branch': 'Autoland-Non-PGO', 04:31:11 INFO - 'buildbot_json_path': 'buildprops.json', 04:31:11 INFO - 'config_files': ('talos/linux_config.py',), 04:31:11 INFO - 'default_actions': ('clobber', 04:31:11 INFO - 'read-buildbot-config', 04:31:11 INFO - 'download-and-extract', 04:31:11 INFO - 'populate-webroot', 04:31:11 INFO - 'create-virtualenv', 04:31:11 INFO - 'install', 04:31:11 INFO - 'run-tests'), 04:31:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:31:11 INFO - 'download_minidump_stackwalk': True, 04:31:11 INFO - 'download_symbols': 'ondemand', 04:31:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:31:11 INFO - 'tooltool.py': '/tools/tooltool.py', 04:31:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:31:11 INFO - '/tools/misc-python/virtualenv.py')}, 04:31:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:31:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:31:11 INFO - 'installer_path': 'installer.exe', 04:31:11 INFO - 'log_level': 'info', 04:31:11 INFO - 'log_name': 'talos', 04:31:11 INFO - 'log_to_console': True, 04:31:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:31:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:31:11 INFO - 'opt_config_files': (), 04:31:11 INFO - 'pip_index': False, 04:31:11 INFO - 'sps_profile': False, 04:31:11 INFO - 'sps_profile_interval': 0, 04:31:11 INFO - 'suite': 'dromaeojs', 04:31:11 INFO - 'system_bits': '32', 04:31:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:31:11 INFO - 'title': 'talos-linux64-ix-061', 04:31:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:31:11 INFO - 'use_talos_json': True, 04:31:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:31:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:31:11 INFO - 'work_dir': 'build'} 04:31:11 INFO - [mozharness: 2016-09-17 11:31:11.986405Z] Running clobber step. 04:31:11 INFO - Running pre-action listener: _resource_record_pre_action 04:31:11 INFO - Running main action method: clobber 04:31:11 INFO - rmtree: /builds/slave/test/build 04:31:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:31:12 INFO - Running post-action listener: _resource_record_post_action 04:31:12 INFO - [mozharness: 2016-09-17 11:31:12.451170Z] Finished clobber step (success) 04:31:12 INFO - [mozharness: 2016-09-17 11:31:12.451271Z] Running read-buildbot-config step. 04:31:12 INFO - Running pre-action listener: _resource_record_pre_action 04:31:12 INFO - Running main action method: read_buildbot_config 04:31:12 INFO - Using buildbot properties: 04:31:12 INFO - { 04:31:12 INFO - "project": "", 04:31:12 INFO - "product": "firefox", 04:31:12 INFO - "script_repo_revision": "production", 04:31:12 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 04:31:12 INFO - "repository": "", 04:31:12 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 04:31:12 INFO - "buildid": "20160917031317", 04:31:12 INFO - "pgo_build": "False", 04:31:12 INFO - "basedir": "/builds/slave/test", 04:31:12 INFO - "buildnumber": 587, 04:31:12 INFO - "slavename": "talos-linux64-ix-061", 04:31:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:31:12 INFO - "platform": "ubuntu64_hw", 04:31:12 INFO - "scheduler": "tests-autoland-linux64-talos", 04:31:12 INFO - "branch": "autoland", 04:31:12 INFO - "repo_path": "integration/autoland", 04:31:12 INFO - "revision": "42fd3f718fdc630d75b21776c1b18df399ed925f", 04:31:12 INFO - "stage_platform": "linux64", 04:31:12 INFO - "builduid": "b32ad5235f3c43f896d03672b03156e3", 04:31:12 INFO - "slavebuilddir": "test" 04:31:12 INFO - } 04:31:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:31:12 INFO - Running post-action listener: _resource_record_post_action 04:31:12 INFO - [mozharness: 2016-09-17 11:31:12.453739Z] Finished read-buildbot-config step (success) 04:31:12 INFO - [mozharness: 2016-09-17 11:31:12.453828Z] Running download-and-extract step. 04:31:12 INFO - Running pre-action listener: _resource_record_pre_action 04:31:12 INFO - Running main action method: download_and_extract 04:31:12 INFO - mkdir: /builds/slave/test/build/tests 04:31:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:12 INFO - trying https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:31:12 INFO - Downloading https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:31:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:31:13 INFO - Downloaded 1361 bytes. 04:31:13 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:31:13 INFO - Using the following test package requirements: 04:31:13 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:13 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:31:13 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:31:13 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:13 INFO - u'jsshell-linux-x86_64.zip'], 04:31:13 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:31:13 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:31:13 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:31:13 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:31:13 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:31:13 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:31:13 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:31:13 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:31:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:31:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:13 INFO - Fetch https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:31:14 INFO - Expected file size: 20365601 04:31:19 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:31:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:31:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:31:19 INFO - Fetch https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip into memory 04:31:19 INFO - Expected file size: 20365601 04:31:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:31:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:31:24 INFO - Fetch https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip into memory 04:31:24 INFO - Expected file size: 14414048 04:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:26 INFO - trying https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:31:26 INFO - Downloading https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:31:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:31:28 INFO - Downloaded 55593118 bytes. 04:31:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:31:28 INFO - mkdir: /builds/slave/test/properties 04:31:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:31:28 INFO - Writing to file /builds/slave/test/properties/build_url 04:31:28 INFO - Contents: 04:31:28 INFO - build_url:https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:31:28 INFO - Running post-action listener: _resource_record_post_action 04:31:28 INFO - Running post-action listener: set_extra_try_arguments 04:31:28 INFO - [mozharness: 2016-09-17 11:31:28.889340Z] Finished download-and-extract step (success) 04:31:28 INFO - [mozharness: 2016-09-17 11:31:28.889568Z] Running populate-webroot step. 04:31:28 INFO - Running pre-action listener: _resource_record_pre_action 04:31:28 INFO - Running main action method: populate_webroot 04:31:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:31:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:31:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:31:28 INFO - '--tppagecycles', 04:31:28 INFO - '7'], 04:31:28 INFO - 'tests': ['tsvgm']}}, 04:31:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:31:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:31:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:31:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:31:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:31:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:31:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:28 INFO - 'talos_options': ['--disable-e10s'], 04:31:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:31:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:28 INFO - 'talos_options': ['--disable-e10s'], 04:31:28 INFO - 'tests': ['damp', 'tps']}, 04:31:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:28 INFO - 'tests': ['damp', 'tps']}, 04:31:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:31:28 INFO - 'tests': ['dromaeo_dom']}, 04:31:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:31:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:31:28 INFO - 'tests': ['basic_compositor_video']}, 04:31:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:31:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:31:28 INFO - 'tests': ['a11yr', 04:31:28 INFO - 'ts_paint', 04:31:28 INFO - 'tpaint', 04:31:28 INFO - 'sessionrestore', 04:31:28 INFO - 'sessionrestore_no_auto_restore', 04:31:28 INFO - 'tabpaint']}, 04:31:28 INFO - 'other-e10s': {'tests': ['a11yr', 04:31:28 INFO - 'ts_paint', 04:31:28 INFO - 'tpaint', 04:31:28 INFO - 'sessionrestore', 04:31:28 INFO - 'sessionrestore_no_auto_restore', 04:31:28 INFO - 'tabpaint']}, 04:31:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:31:28 INFO - 'ts_paint', 04:31:28 INFO - 'tpaint', 04:31:28 INFO - 'sessionrestore', 04:31:28 INFO - 'sessionrestore_no_auto_restore', 04:31:28 INFO - 'tabpaint']}, 04:31:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:31:28 INFO - 'ts_paint', 04:31:28 INFO - 'tpaint', 04:31:28 INFO - 'sessionrestore', 04:31:28 INFO - 'sessionrestore_no_auto_restore', 04:31:28 INFO - 'tabpaint']}, 04:31:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:31:28 INFO - 'tests': ['a11yr', 04:31:28 INFO - 'ts_paint', 04:31:28 INFO - 'tpaint', 04:31:28 INFO - 'sessionrestore', 04:31:28 INFO - 'sessionrestore_no_auto_restore', 04:31:28 INFO - 'tabpaint']}, 04:31:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:31:28 INFO - 'tests': ['a11yr', 04:31:28 INFO - 'ts_paint', 04:31:28 INFO - 'tpaint', 04:31:28 INFO - 'sessionrestore', 04:31:28 INFO - 'sessionrestore_no_auto_restore', 04:31:28 INFO - 'tabpaint']}, 04:31:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:31:28 INFO - 'tests': ['tsvgx', 04:31:28 INFO - 'tsvgr_opacity', 04:31:28 INFO - 'tart', 04:31:28 INFO - 'tscrollx', 04:31:28 INFO - 'cart']}, 04:31:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:31:28 INFO - 'tsvgr_opacity', 04:31:28 INFO - 'tart', 04:31:28 INFO - 'tscrollx', 04:31:28 INFO - 'cart']}, 04:31:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:28 INFO - 'talos_options': ['--disable-e10s'], 04:31:28 INFO - 'tests': ['tp5o']}, 04:31:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:28 INFO - 'tests': ['tp5o']}, 04:31:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:28 INFO - 'talos_options': ['--disable-e10s', 04:31:28 INFO - '--xperf_path', 04:31:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:28 INFO - 'tests': ['tp5n']}, 04:31:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:31:28 INFO - 'talos_options': ['--xperf_path', 04:31:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:31:28 INFO - 'tests': ['tp5n']}}, 04:31:28 INFO - 'talos.zip': {'path': '', 04:31:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:31:28 INFO - Running post-action listener: _resource_record_post_action 04:31:28 INFO - [mozharness: 2016-09-17 11:31:28.905375Z] Finished populate-webroot step (success) 04:31:28 INFO - [mozharness: 2016-09-17 11:31:28.905465Z] Running create-virtualenv step. 04:31:28 INFO - Running pre-action listener: _resource_record_pre_action 04:31:28 INFO - Running main action method: create_virtualenv 04:31:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:31:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:31:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:31:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:31:28 INFO - Using real prefix '/usr' 04:31:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:31:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:31:31 INFO - Installing pip.................done. 04:31:31 INFO - Return code: 0 04:31:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3799af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c34f60>, '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 0x2c35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c361d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:31:31 INFO - Using env: {'DISPLAY': ':0', 04:31:31 INFO - 'HOME': '/home/cltbld', 04:31:31 INFO - 'LANG': 'en_US.UTF-8', 04:31:31 INFO - 'LANGUAGE': 'en_US:en', 04:31:31 INFO - 'LOGNAME': 'cltbld', 04:31:31 INFO - 'MAIL': '/var/mail/cltbld', 04:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:31 INFO - 'MOZ_NO_REMOTE': '1', 04:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:31 INFO - 'NO_EM_RESTART': '1', 04:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:31 INFO - 'PWD': '/builds/slave/test', 04:31:31 INFO - 'SHELL': '/bin/bash', 04:31:31 INFO - 'SHLVL': '1', 04:31:31 INFO - 'TERM': 'linux', 04:31:31 INFO - 'TMOUT': '86400', 04:31:31 INFO - 'USER': 'cltbld', 04:31:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 04:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:31 INFO - '_': '/tools/buildbot/bin/python'} 04:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:31:31 INFO - Cleaning up... 04:31:31 INFO - Return code: 0 04:31:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faf3799af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c34f60>, '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 0x2c35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c361d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:31:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:31:31 INFO - Using env: {'DISPLAY': ':0', 04:31:31 INFO - 'HOME': '/home/cltbld', 04:31:31 INFO - 'LANG': 'en_US.UTF-8', 04:31:31 INFO - 'LANGUAGE': 'en_US:en', 04:31:31 INFO - 'LOGNAME': 'cltbld', 04:31:31 INFO - 'MAIL': '/var/mail/cltbld', 04:31:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:31 INFO - 'MOZ_NO_REMOTE': '1', 04:31:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:31 INFO - 'NO_EM_RESTART': '1', 04:31:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:31 INFO - 'PWD': '/builds/slave/test', 04:31:31 INFO - 'SHELL': '/bin/bash', 04:31:31 INFO - 'SHLVL': '1', 04:31:31 INFO - 'TERM': 'linux', 04:31:31 INFO - 'TMOUT': '86400', 04:31:31 INFO - 'USER': 'cltbld', 04:31:31 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 04:31:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:31 INFO - '_': '/tools/buildbot/bin/python'} 04:31:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:31 INFO - Downloading/unpacking psutil>=3.1.1 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:31:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:33 INFO - Installing collected packages: psutil 04:31:33 INFO - Running setup.py install for psutil 04:31:33 INFO - building 'psutil._psutil_linux' extension 04:31:33 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:31:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:31:34 INFO - building 'psutil._psutil_posix' extension 04:31:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:31:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:31:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:31:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:31:34 INFO - Successfully installed psutil 04:31:34 INFO - Cleaning up... 04:31:34 INFO - Return code: 0 04:31:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3799af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c34f60>, '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 0x2c35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c361d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:31:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:31:34 INFO - Using env: {'DISPLAY': ':0', 04:31:34 INFO - 'HOME': '/home/cltbld', 04:31:34 INFO - 'LANG': 'en_US.UTF-8', 04:31:34 INFO - 'LANGUAGE': 'en_US:en', 04:31:34 INFO - 'LOGNAME': 'cltbld', 04:31:34 INFO - 'MAIL': '/var/mail/cltbld', 04:31:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:34 INFO - 'MOZ_NO_REMOTE': '1', 04:31:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:34 INFO - 'NO_EM_RESTART': '1', 04:31:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:34 INFO - 'PWD': '/builds/slave/test', 04:31:34 INFO - 'SHELL': '/bin/bash', 04:31:34 INFO - 'SHLVL': '1', 04:31:34 INFO - 'TERM': 'linux', 04:31:34 INFO - 'TMOUT': '86400', 04:31:34 INFO - 'USER': 'cltbld', 04:31:34 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 04:31:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:34 INFO - '_': '/tools/buildbot/bin/python'} 04:31:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:31:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:31:36 INFO - Installing collected packages: mozsystemmonitor 04:31:36 INFO - Running setup.py install for mozsystemmonitor 04:31:36 INFO - Successfully installed mozsystemmonitor 04:31:36 INFO - Cleaning up... 04:31:36 INFO - Return code: 0 04:31:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faf3799af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c34f60>, '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 0x2c35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c361d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:31:36 INFO - Using env: {'DISPLAY': ':0', 04:31:36 INFO - 'HOME': '/home/cltbld', 04:31:36 INFO - 'LANG': 'en_US.UTF-8', 04:31:36 INFO - 'LANGUAGE': 'en_US:en', 04:31:36 INFO - 'LOGNAME': 'cltbld', 04:31:36 INFO - 'MAIL': '/var/mail/cltbld', 04:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:36 INFO - 'MOZ_NO_REMOTE': '1', 04:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:36 INFO - 'NO_EM_RESTART': '1', 04:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:36 INFO - 'PWD': '/builds/slave/test', 04:31:36 INFO - 'SHELL': '/bin/bash', 04:31:36 INFO - 'SHLVL': '1', 04:31:36 INFO - 'TERM': 'linux', 04:31:36 INFO - 'TMOUT': '86400', 04:31:36 INFO - 'USER': 'cltbld', 04:31:36 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 04:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:36 INFO - '_': '/tools/buildbot/bin/python'} 04:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:36 INFO - Downloading/unpacking jsonschema==2.5.1 04:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:31:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:39 INFO - Downloading functools32-3.2.3-2.tar.gz 04:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:31:39 INFO - warning: no files found matching '*.txt' 04:31:39 INFO - no previously-included directories found matching 'build' 04:31:39 INFO - no previously-included directories found matching 'dist' 04:31:39 INFO - no previously-included directories found matching '.git*' 04:31:39 INFO - Installing collected packages: jsonschema, functools32 04:31:39 INFO - Running setup.py install for functools32 04:31:39 INFO - warning: no files found matching '*.txt' 04:31:39 INFO - no previously-included directories found matching 'build' 04:31:39 INFO - no previously-included directories found matching 'dist' 04:31:39 INFO - no previously-included directories found matching '.git*' 04:31:39 INFO - Successfully installed jsonschema functools32 04:31:39 INFO - Cleaning up... 04:31:39 INFO - Return code: 0 04:31:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3799af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c34f60>, '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 0x2c35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c361d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:31:39 INFO - Using env: {'DISPLAY': ':0', 04:31:39 INFO - 'HOME': '/home/cltbld', 04:31:39 INFO - 'LANG': 'en_US.UTF-8', 04:31:39 INFO - 'LANGUAGE': 'en_US:en', 04:31:39 INFO - 'LOGNAME': 'cltbld', 04:31:39 INFO - 'MAIL': '/var/mail/cltbld', 04:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:39 INFO - 'MOZ_NO_REMOTE': '1', 04:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:39 INFO - 'NO_EM_RESTART': '1', 04:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:39 INFO - 'PWD': '/builds/slave/test', 04:31:39 INFO - 'SHELL': '/bin/bash', 04:31:39 INFO - 'SHLVL': '1', 04:31:39 INFO - 'TERM': 'linux', 04:31:39 INFO - 'TMOUT': '86400', 04:31:39 INFO - 'USER': 'cltbld', 04:31:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 04:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:39 INFO - '_': '/tools/buildbot/bin/python'} 04:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:31:39 INFO - Cleaning up... 04:31:39 INFO - Return code: 0 04:31:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7faf3799af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c34f60>, '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 0x2c35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c361d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:31:39 INFO - Using env: {'DISPLAY': ':0', 04:31:39 INFO - 'HOME': '/home/cltbld', 04:31:39 INFO - 'LANG': 'en_US.UTF-8', 04:31:39 INFO - 'LANGUAGE': 'en_US:en', 04:31:39 INFO - 'LOGNAME': 'cltbld', 04:31:39 INFO - 'MAIL': '/var/mail/cltbld', 04:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:39 INFO - 'MOZ_NO_REMOTE': '1', 04:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:39 INFO - 'NO_EM_RESTART': '1', 04:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:39 INFO - 'PWD': '/builds/slave/test', 04:31:39 INFO - 'SHELL': '/bin/bash', 04:31:39 INFO - 'SHLVL': '1', 04:31:39 INFO - 'TERM': 'linux', 04:31:39 INFO - 'TMOUT': '86400', 04:31:39 INFO - 'USER': 'cltbld', 04:31:39 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 04:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:39 INFO - '_': '/tools/buildbot/bin/python'} 04:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:39 INFO - Downloading/unpacking blobuploader==1.2.4 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:41 INFO - Downloading blobuploader-1.2.4.tar.gz 04:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:31:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:31:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:42 INFO - Downloading docopt-0.6.1.tar.gz 04:31:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:31:42 INFO - Installing collected packages: blobuploader, requests, docopt 04:31:42 INFO - Running setup.py install for blobuploader 04:31:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:31:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:31:42 INFO - Running setup.py install for requests 04:31:42 INFO - Running setup.py install for docopt 04:31:42 INFO - Successfully installed blobuploader requests docopt 04:31:42 INFO - Cleaning up... 04:31:43 INFO - Return code: 0 04:31:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3799af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c34f60>, '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 0x2c35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c361d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:43 INFO - Using env: {'DISPLAY': ':0', 04:31:43 INFO - 'HOME': '/home/cltbld', 04:31:43 INFO - 'LANG': 'en_US.UTF-8', 04:31:43 INFO - 'LANGUAGE': 'en_US:en', 04:31:43 INFO - 'LOGNAME': 'cltbld', 04:31:43 INFO - 'MAIL': '/var/mail/cltbld', 04:31:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:43 INFO - 'MOZ_NO_REMOTE': '1', 04:31:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:43 INFO - 'NO_EM_RESTART': '1', 04:31:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:43 INFO - 'PWD': '/builds/slave/test', 04:31:43 INFO - 'SHELL': '/bin/bash', 04:31:43 INFO - 'SHLVL': '1', 04:31:43 INFO - 'TERM': 'linux', 04:31:43 INFO - 'TMOUT': '86400', 04:31:43 INFO - 'USER': 'cltbld', 04:31:43 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 04:31:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:43 INFO - '_': '/tools/buildbot/bin/python'} 04:31:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:43 INFO - Running setup.py (path:/tmp/pip-xVYDjI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:43 INFO - Running setup.py (path:/tmp/pip-SvW2Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:43 INFO - Running setup.py (path:/tmp/pip-cMbHL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:43 INFO - Running setup.py (path:/tmp/pip-g7CU7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:43 INFO - Running setup.py (path:/tmp/pip-dtuzgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:43 INFO - Running setup.py (path:/tmp/pip-2r2bzq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:43 INFO - Running setup.py (path:/tmp/pip-iv_x8p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:43 INFO - Running setup.py (path:/tmp/pip-84pXCf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:43 INFO - Running setup.py (path:/tmp/pip-84Dslr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:43 INFO - Running setup.py (path:/tmp/pip-YwEwfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:43 INFO - Running setup.py (path:/tmp/pip-MOPN7y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:44 INFO - Running setup.py (path:/tmp/pip-oBNNoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:44 INFO - Running setup.py (path:/tmp/pip-kzVuXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:44 INFO - Running setup.py (path:/tmp/pip-N7oEnJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:44 INFO - Running setup.py (path:/tmp/pip-mbjcBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:44 INFO - Running setup.py (path:/tmp/pip-Suxllx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:44 INFO - Running setup.py (path:/tmp/pip-Ma7IQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:31:44 INFO - Running setup.py install for manifestparser 04:31:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:31:44 INFO - Running setup.py install for mozcrash 04:31:44 INFO - Running setup.py install for mozdebug 04:31:44 INFO - Running setup.py install for mozdevice 04:31:44 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:31:44 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:31:44 INFO - Running setup.py install for mozfile 04:31:44 INFO - Running setup.py install for mozhttpd 04:31:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozinfo 04:31:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozInstall 04:31:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozleak 04:31:45 INFO - Running setup.py install for mozlog 04:31:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for moznetwork 04:31:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozprocess 04:31:45 INFO - Running setup.py install for mozprofile 04:31:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozrunner 04:31:45 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:31:45 INFO - Running setup.py install for mozscreenshot 04:31:46 INFO - Running setup.py install for moztest 04:31:46 INFO - Running setup.py install for mozversion 04:31:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:31:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:31:46 INFO - Cleaning up... 04:31:46 INFO - Return code: 0 04:31:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3799af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c34f60>, '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 0x2c35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c361d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:46 INFO - Using env: {'DISPLAY': ':0', 04:31:46 INFO - 'HOME': '/home/cltbld', 04:31:46 INFO - 'LANG': 'en_US.UTF-8', 04:31:46 INFO - 'LANGUAGE': 'en_US:en', 04:31:46 INFO - 'LOGNAME': 'cltbld', 04:31:46 INFO - 'MAIL': '/var/mail/cltbld', 04:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:46 INFO - 'MOZ_NO_REMOTE': '1', 04:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:46 INFO - 'NO_EM_RESTART': '1', 04:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:46 INFO - 'PWD': '/builds/slave/test', 04:31:46 INFO - 'SHELL': '/bin/bash', 04:31:46 INFO - 'SHLVL': '1', 04:31:46 INFO - 'TERM': 'linux', 04:31:46 INFO - 'TMOUT': '86400', 04:31:46 INFO - 'USER': 'cltbld', 04:31:46 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 04:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:46 INFO - '_': '/tools/buildbot/bin/python'} 04:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:31:46 INFO - Running setup.py (path:/tmp/pip-616Zzn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:31:46 INFO - Running setup.py (path:/tmp/pip-7jRIIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:31:46 INFO - Running setup.py (path:/tmp/pip-re4nNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:31:46 INFO - Running setup.py (path:/tmp/pip-tBA7GM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:31:46 INFO - Running setup.py (path:/tmp/pip-eY9oP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:31:46 INFO - Running setup.py (path:/tmp/pip-PFyQIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:31:46 INFO - Running setup.py (path:/tmp/pip-V6htkP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:31:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:31:46 INFO - Running setup.py (path:/tmp/pip-_A8X_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:31:47 INFO - Running setup.py (path:/tmp/pip-GZycTM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:31:47 INFO - Running setup.py (path:/tmp/pip-sxqoxS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:31:47 INFO - Running setup.py (path:/tmp/pip-CFMINi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:31:47 INFO - Running setup.py (path:/tmp/pip-5B4JVK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:31:47 INFO - Running setup.py (path:/tmp/pip-c0uVTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:31:47 INFO - Running setup.py (path:/tmp/pip-RyQNGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:47 INFO - Running setup.py (path:/tmp/pip-81UM7Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:31:47 INFO - Running setup.py (path:/tmp/pip-n5yei8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:31:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:31:47 INFO - Running setup.py (path:/tmp/pip-5zS53f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:31:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:31:49 INFO - Downloading blessings-1.6.tar.gz 04:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:31:49 INFO - Installing collected packages: blessings 04:31:49 INFO - Running setup.py install for blessings 04:31:49 INFO - Successfully installed blessings 04:31:49 INFO - Cleaning up... 04:31:49 INFO - Return code: 0 04:31:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:31:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:50 INFO - Reading from file tmpfile_stdout 04:31:50 INFO - Current package versions: 04:31:50 INFO - argparse == 1.2.1 04:31:50 INFO - blessings == 1.6 04:31:50 INFO - blobuploader == 1.2.4 04:31:50 INFO - docopt == 0.6.1 04:31:50 INFO - functools32 == 3.2.3-2 04:31:50 INFO - jsonschema == 2.5.1 04:31:50 INFO - manifestparser == 1.1 04:31:50 INFO - mozInstall == 1.12 04:31:50 INFO - mozcrash == 0.17 04:31:50 INFO - mozdebug == 0.1 04:31:50 INFO - mozdevice == 0.48 04:31:50 INFO - mozfile == 1.2 04:31:50 INFO - mozhttpd == 0.7 04:31:50 INFO - mozinfo == 0.9 04:31:50 INFO - mozleak == 0.1 04:31:50 INFO - mozlog == 3.4 04:31:50 INFO - moznetwork == 0.27 04:31:50 INFO - mozprocess == 0.23 04:31:50 INFO - mozprofile == 0.28 04:31:50 INFO - mozrunner == 6.12 04:31:50 INFO - mozscreenshot == 0.1 04:31:50 INFO - mozsystemmonitor == 0.3 04:31:50 INFO - moztest == 0.7 04:31:50 INFO - mozversion == 1.4 04:31:50 INFO - psutil == 3.1.1 04:31:50 INFO - requests == 1.2.3 04:31:50 INFO - wsgiref == 0.1.2 04:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3799af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c34f60>, '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 0x2c35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c361d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:31:50 INFO - Using env: {'DISPLAY': ':0', 04:31:50 INFO - 'HOME': '/home/cltbld', 04:31:50 INFO - 'LANG': 'en_US.UTF-8', 04:31:50 INFO - 'LANGUAGE': 'en_US:en', 04:31:50 INFO - 'LOGNAME': 'cltbld', 04:31:50 INFO - 'MAIL': '/var/mail/cltbld', 04:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:50 INFO - 'MOZ_NO_REMOTE': '1', 04:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:50 INFO - 'NO_EM_RESTART': '1', 04:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:50 INFO - 'PWD': '/builds/slave/test', 04:31:50 INFO - 'SHELL': '/bin/bash', 04:31:50 INFO - 'SHLVL': '1', 04:31:50 INFO - 'TERM': 'linux', 04:31:50 INFO - 'TMOUT': '86400', 04:31:50 INFO - 'USER': 'cltbld', 04:31:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 04:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:50 INFO - '_': '/tools/buildbot/bin/python'} 04:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:31:50 INFO - Cleaning up... 04:31:50 INFO - Return code: 0 04:31:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:31:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faf3799af10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b6a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c37ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c34f60>, '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 0x2c35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c361d0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:31:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:31:50 INFO - Using env: {'DISPLAY': ':0', 04:31:50 INFO - 'HOME': '/home/cltbld', 04:31:50 INFO - 'LANG': 'en_US.UTF-8', 04:31:50 INFO - 'LANGUAGE': 'en_US:en', 04:31:50 INFO - 'LOGNAME': 'cltbld', 04:31:50 INFO - 'MAIL': '/var/mail/cltbld', 04:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:31:50 INFO - 'MOZ_NO_REMOTE': '1', 04:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:31:50 INFO - 'NO_EM_RESTART': '1', 04:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:31:50 INFO - 'PWD': '/builds/slave/test', 04:31:50 INFO - 'SHELL': '/bin/bash', 04:31:50 INFO - 'SHLVL': '1', 04:31:50 INFO - 'TERM': 'linux', 04:31:50 INFO - 'TMOUT': '86400', 04:31:50 INFO - 'USER': 'cltbld', 04:31:50 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 04:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:31:50 INFO - '_': '/tools/buildbot/bin/python'} 04:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:31:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:31:50 INFO - Cleaning up... 04:31:50 INFO - Return code: 0 04:31:50 INFO - Running post-action listener: _resource_record_post_action 04:31:50 INFO - Running post-action listener: _start_resource_monitoring 04:31:50 INFO - Starting resource monitoring. 04:31:50 INFO - [mozharness: 2016-09-17 11:31:50.510386Z] Finished create-virtualenv step (success) 04:31:50 INFO - [mozharness: 2016-09-17 11:31:50.510883Z] Running install step. 04:31:50 INFO - Running pre-action listener: _resource_record_pre_action 04:31:50 INFO - Running main action method: install 04:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:31:50 INFO - Reading from file tmpfile_stdout 04:31:50 INFO - Detecting whether we're running mozinstall >=1.0... 04:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:31:50 INFO - Reading from file tmpfile_stdout 04:31:50 INFO - Output received: 04:31:50 INFO - Usage: mozinstall [options] installer 04:31:50 INFO - Options: 04:31:50 INFO - -h, --help show this help message and exit 04:31:50 INFO - -d DEST, --destination=DEST 04:31:50 INFO - Directory to install application into. [default: 04:31:50 INFO - "/builds/slave/test"] 04:31:50 INFO - --app=APP Application being installed. [default: firefox] 04:31:50 INFO - mkdir: /builds/slave/test/build/application 04:31:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:31:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:32:06 INFO - Reading from file tmpfile_stdout 04:32:06 INFO - Output received: 04:32:06 INFO - /builds/slave/test/build/application/firefox/firefox 04:32:06 INFO - Running post-action listener: _resource_record_post_action 04:32:06 INFO - [mozharness: 2016-09-17 11:32:06.849443Z] Finished install step (success) 04:32:06 INFO - [mozharness: 2016-09-17 11:32:06.849690Z] Running run-tests step. 04:32:06 INFO - Running pre-action listener: _resource_record_pre_action 04:32:06 INFO - Running main action method: run_tests 04:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:32:06 INFO - Python 2.7.3 04:32:06 INFO - Return code: 0 04:32:06 INFO - grabbing minidump binary from tooltool 04:32: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')]} 04:32:06 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 0x2c34f60>, '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 0x2c35d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c361d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:32:06 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:32:06 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:32:06 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:32:06 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:32:06 INFO - Return code: 0 04:32:06 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:32:06 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:32:06 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:32:06 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:32:06 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:32:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:32:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-061 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:32:06 INFO - Using env: {'DISPLAY': ':0', 04:32:06 INFO - 'HOME': '/home/cltbld', 04:32:06 INFO - 'LANG': 'en_US.UTF-8', 04:32:06 INFO - 'LANGUAGE': 'en_US:en', 04:32:06 INFO - 'LOGNAME': 'cltbld', 04:32:06 INFO - 'MAIL': '/var/mail/cltbld', 04:32:06 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:32:06 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:32:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:06 INFO - 'MOZ_NO_REMOTE': '1', 04:32:06 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:32:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:32:06 INFO - 'NO_EM_RESTART': '1', 04:32:06 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:32:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:06 INFO - 'PWD': '/builds/slave/test', 04:32:06 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:32:06 INFO - 'SHELL': '/bin/bash', 04:32:06 INFO - 'SHLVL': '1', 04:32:06 INFO - 'TERM': 'linux', 04:32:06 INFO - 'TMOUT': '86400', 04:32:06 INFO - 'USER': 'cltbld', 04:32:06 INFO - 'XDG_SESSION_COOKIE': '516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084', 04:32:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:06 INFO - '_': '/tools/buildbot/bin/python'} 04:32:06 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-061', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:32:07 INFO - mozversion application_buildid: 20160917031317 04:32:07 INFO - mozversion application_changeset: 42fd3f718fdc630d75b21776c1b18df399ed925f 04:32:07 INFO - mozversion application_display_name: Nightly 04:32:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:32:07 INFO - mozversion application_name: Firefox 04:32:07 INFO - mozversion application_remotingname: firefox 04:32:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 04:32:07 INFO - mozversion application_vendor: Mozilla 04:32:07 INFO - mozversion application_version: 51.0a1 04:32:07 INFO - mozversion platform_buildid: 20160917031317 04:32:07 INFO - mozversion platform_changeset: 42fd3f718fdc630d75b21776c1b18df399ed925f 04:32:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 04:32:07 INFO - mozversion platform_version: 51.0a1 04:32:07 INFO - using testdate: 1474111927 04:32:07 INFO - actual date: 1474111927 04:32:07 INFO - starting webserver on 'localhost:59294' 04:32:07 INFO - SUITE-START | Running 2 tests 04:32:07 INFO - TEST-START | dromaeo_css 04:32:07 INFO - operating with platform_type : linux_ 04:32:07 INFO - Initialising browser for dromaeo_css test... 04:32:07 INFO - TEST-INFO | started process 23674 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2FelNw/profile http://localhost:59294/getInfo.html) 04:32:12 INFO - PROCESS | 23674 | __metrics Screen width/height:1600/1200 04:32:12 INFO - PROCESS | 23674 | colorDepth:24 04:32:12 INFO - PROCESS | 23674 | Browser inner width/height: 1024/697 04:32:12 INFO - PROCESS | 23674 | __metrics 04:32:12 INFO - PROCESS | 23674 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:32:12 INFO - PROCESS | 23674 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:32:13 INFO - PROCESS | 23674 | console.error: PushService: 04:32:13 INFO - PROCESS | 23674 | stateChangeProcessEnqueue: Error transitioning state 04:32:13 INFO - PROCESS | 23674 | UnknownError 04:32:14 INFO - TEST-INFO | 23674: exit 0 04:32:14 INFO - Browser initialized. 04:32:14 INFO - Running cycle 1/1 for dromaeo_css test... 04:32:14 INFO - TEST-INFO | started process 23757 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2FelNw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:32:26 INFO - PROCESS | 23757 | RSS: Main: 174632960 04:32:26 INFO - PROCESS | 23757 | 04:32:33 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:32:36 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0334 seconds. 04:32:43 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:33:02 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 04:33:08 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 04:33:10 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:33:12 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:33:17 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.15001 seconds. 04:33:18 INFO - PROCESS | 23757 | 1474111998119 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] 04:33:51 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:33:56 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 04:34:00 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:34:02 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 04:34:04 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 04:34:06 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:34:08 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.16673 seconds. 04:34:12 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.06671 seconds. 04:34:21 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:34:23 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 04:34:25 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:34:41 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:34:42 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 2.00006 seconds. 04:34:43 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:35:15 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:35:21 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.16671 seconds. 04:35:25 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 04:35:29 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 04:35:30 INFO - PROCESS | 23757 | Cycle 1(1): loaded http://localhost:59294/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59294/tests/dromaeo/cssquery-ext.html) 04:35:31 INFO - PROCESS | 23757 | RSS: Main: 306171904 04:35:31 INFO - PROCESS | 23757 | 04:35:37 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.06671 seconds. 04:35:42 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 04:35:50 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 04:35:52 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:36:00 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:36:03 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 04:36:04 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:36:12 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 04:36:14 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:36:21 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 04:36:32 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:36:43 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:36:55 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:36:57 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 04:37:05 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:37:07 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 04:37:09 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:37:19 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:37:21 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.03342 seconds. 04:37:23 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:37:27 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:37:29 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:37:40 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:38:02 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:38:10 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 04:38:12 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:38:16 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:38:26 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:38:28 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 04:38:34 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01676 seconds. 04:38:34 INFO - PROCESS | 23757 | Cycle 1(1): loaded http://localhost:59294/tests/dromaeo/cssquery-ext.html (next: http://localhost:59294/tests/dromaeo/cssquery-jquery.html) 04:38:35 INFO - PROCESS | 23757 | RSS: Main: 270225408 04:38:35 INFO - PROCESS | 23757 | 04:38:38 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.03332 seconds. 04:38:49 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 04:39:02 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:39:05 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:39:06 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 04:39:08 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 04:39:14 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 04:39:16 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:39:18 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 04:39:32 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00913 seconds. 04:39:42 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:39:46 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 04:39:48 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:39:56 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:40:06 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:40:11 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:40:14 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 04:40:35 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:40:37 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:40:41 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 04:40:47 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:40:50 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 04:40:53 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:40:55 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:40:57 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:40:59 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:41:03 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:41:05 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:41:15 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:41:19 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:41:29 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:41:33 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 04:41:37 INFO - PROCESS | 23757 | Cycle 1(1): loaded http://localhost:59294/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59294/tests/dromaeo/cssquery-mootools.html) 04:41:38 INFO - PROCESS | 23757 | RSS: Main: 251514880 04:41:38 INFO - PROCESS | 23757 | 04:41:41 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 04:41:44 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 04:41:54 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:41:56 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:42:00 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 04:42:09 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:42:11 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 04:42:13 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:42:15 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 04:42:17 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:42:25 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 04:42:27 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:42:33 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:42:40 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:42:43 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:43:01 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 04:43:25 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:43:46 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 04:43:58 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:44:00 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 04:44:02 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:44:06 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:44:10 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:44:12 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:44:14 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:44:20 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 04:44:30 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:44:34 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:44:38 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:44:40 INFO - PROCESS | 23757 | Cycle 1(1): loaded http://localhost:59294/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59294/tests/dromaeo/cssquery-prototype.html) 04:44:41 INFO - PROCESS | 23757 | RSS: Main: 219136000 04:44:41 INFO - PROCESS | 23757 | 04:44:46 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.05003 seconds. 04:44:49 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:44:59 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:45:12 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:45:26 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:45:28 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 04:45:34 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 04:45:39 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:45:44 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:45:52 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:45:55 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 04:45:56 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:46:13 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:46:15 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01666 seconds. 04:46:29 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:46:34 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:46:42 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:46:53 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:46:56 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:47:01 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:47:05 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:47:07 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:47:10 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 04:47:16 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 04:47:26 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0001 seconds. 04:47:34 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 04:47:38 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 04:47:44 INFO - PROCESS | 23757 | Cycle 1(1): loaded http://localhost:59294/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59294/tests/dromaeo/cssquery-yui.html) 04:47:44 INFO - PROCESS | 23757 | RSS: Main: 220676096 04:47:44 INFO - PROCESS | 23757 | 04:48:01 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:48:04 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 04:48:13 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:48:22 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:48:31 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:49:02 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:49:05 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 04:49:11 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:49:12 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 04:49:18 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 04:49:36 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 04:49:42 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 04:49:58 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:50:00 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 04:50:02 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 04:50:05 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0168 seconds. 04:50:08 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 04:50:19 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 04:50:33 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 04:50:43 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 04:50:47 INFO - PROCESS | 23757 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 04:50:47 INFO - PROCESS | 23757 | Cycle 1(1): loaded http://localhost:59294/tests/dromaeo/cssquery-yui.html (next: http://localhost:59294/tests/dromaeo/cssquery-dojo.html) 04:50:48 INFO - PROCESS | 23757 | RSS: Main: 308506624 04:50:48 INFO - PROCESS | 23757 | 04:50:48 INFO - PROCESS | 23757 | __start_tp_report 04:50:48 INFO - PROCESS | 23757 | _x_x_mozilla_page_load 04:50:48 INFO - PROCESS | 23757 | _x_x_mozilla_page_load_details 04:50:48 INFO - PROCESS | 23757 | |i|pagename|runs| 04:50:48 INFO - PROCESS | 23757 | |0;dojo.html;2560.92317230483;2604.960925586118;2636.090548760677;2641.6301717759516;2662.227953893371;4613.123506533756;4673.532646735325;4688.554587314204;4690.413698287714;4717.834875779348;4671.369365135705;4675.4155730533685;4683.063387322532;4712.976435117819;4731.4795372509;4255.957440425587;4295.656347492193;4299.4195783569285;4301.827926882921;4363.389125522413;4390.912181756363;4422.447194100738;4465.598096171344;4470.463544374679;4516.36770852081;4226.4716910386205;4255.744655320691;4298.78506074695;4349.652027837766;4419.602235798761;4220.936685949713;4287.099709061101;4330.826766929319;4338.240807858612;4351.412559304516;4244.61798438139;4314.676399270036;4315.633171180453;4317.373980772771;4373.169097871426;4688.601468875116;4702.741349225791;4715.41057367829;4720.905581888377;4733.976330118362;4878.756062196911;4912.435069966964;4960.082384758795;4962.05720913029;4969.602431805447;5035.1188542005;5035.697858128524;5036.697798132123;5047.697138171685;5077.898442031139;4776.355192049029;4777.856664300077;4785.210440277316;4808.2787581863;4823.734694591796;4970.353853998957;5012.04771093491;5157.329547158845;5216.295800067019;5271.578273738091;4967.4784147664695;4999.600031997432;5011.348524691767;5012.724300163453;5063.949360506422;5094.923576146361;5097.923531147036;5098.286239926413;5101;5149.6910185389;4953.157963146274;4968.30443737877;4990.975045124824;5011.599072074226;5015.197568389113;4967.428745694219;4989.201727723546;4989.226669866177;5036.143855544567;5043.87390315245;4298.398224248608;4300;4302;4339.9783001085425;4354.10740798142;3726.6273372662517;3737.6449237322413;3743.9251214975548;3745.3632882410056;3811.7712937223855;3985.442038114666;4343.478782546052;4399.274119770266;4438.023634800339;4444.622207112367;5118;5123.7438128093445;5126.2054381570915;5132.076226279306;5142.61430392722;4376.321670141133;4389.385486031958;4393.1872603568445;4395.164918665443;4448.043670610834;4457.064016556495;4485.820567177277;4496.527864574238;4535.523770004102;4610;4826.179549476527;4827.831025914076;4829.106615276185;4860.659753817199;4870.975645121823;5055.494450554915;5094.1849304111165;5096.745162741774;5103.157978933435;5158.432572416956;4617.746023968714;4659;4800.231962885921;4800.35195248637;4871.19625261842;5041.495850414929;5070.746462676778;5076.670016448919;5132.820351287687;5140.7429628517675;5136.922946155736;5145.485451454824;5155.046316431472;5156.767945442539;5171;4834.444038935427;4886.53577910098;5001.749912504288;5015.724135172601;5021.397432308147;4866.780994855169;4914.385701787277;4915.459299476983;4932.186189278872;4981.750912454435;4817.0365926814075;4837.37114175155;4848.296996935354;4849.224124140121;4911.607071434348;4876.585490233228;4929.802807887788;4938.975305123451;4942;5012.3233363495465;4828.8792780180775;4847.903041939071;4892.633052521004;4893.730844803427;4900.8774780630765 04:50:48 INFO - PROCESS | 23757 | |1;ext.html;561.1890817768325;563.4450066684318;572.9197912292279;573.7561536347052;576.1559315602641;27387.589186162222;27964.86017569912;37861.81069094654;38988.22023559527;39128.21743565127;40695;41069;41082.7945860271;41142.794286028606;41145.17709645805;7406.925930740691;7562.886556701654;7569.129550101754;7569.318761311481;7569.432292578051;7425.1832298447125;7505.812354691149;7505.887411688829;7509.324160825525;7510.474266801326;7522.774316770506;7563.810904727398;7566.4325175611775;7568.281013303727;7571.545707257582;7490.3633191178815;7547.773566793005;7553.357964573018;7559.206283340225;7562.13035500919;5520.227168196456;5560.77756889724;5571;5572.331320241597;5574.46702156906;36718.26563468716;37064.444033339525;37083.814580927195;37085;37110.44334334987;2651.8541480218582;2864.255293623652;2901.1586639874413;2997.4454725875785;3256.3161736035463;26697.46605067907;27641;27998.720012799815;28146.296342591395;28697.426051478855;3042.9543556846666;3183.71346578809;3185.6336521300113;3239.659835717263;3295.6210035845943;260073;260098.9999999981;261979;262378;262949;26721.599176012376;27030.5945410819;43068.353974690406;43635.563644363785;43660.345094823606;32291.19272018218;32397.676023239936;32415.189620259684;32419.675803241666;32421.18947026343;11581.710457238469;11683.649490515298;11683.766324673628;11686.532538698357;11707.531698732126;9612.903870961341;9678.56446459911;9690.612375504901;9694.563744631509;9695.369800962915;7469.663865126083;7554.206808285161;7610.9238907610215;7611.885821712679;7615.885761713579;2984.582158497812;3038.134131772434;3040.7567394608377;3055.92360190997;3056.480398332289;797.4856217739525;803.2409373142324;826.6486743134144;828.5608627427473;831.7754206364368;24923;26190.738092619213;26886;27261;27305.180844574694;758.6737702787855;885.4062687163081;888.5512816027993;894;907.7957459571544;11663.941680291544;13847.792283115761;14084.788728169086;14210.431582736781;14293.356798943865;375516;425752;432507;433627;628936;46794;46883.29675054877;47407.525924741;47506;47564;1006.3157053203745;1069.7432616172218;1077.6659235636978;1100.4827730966433;1120.8486854274568;23988.95147957121;26578.46843063089;27907.44185116327;28189.859050705436;28357.291067723472;39272.41091383689;39925;39958.40062399124;39969.80015099906;39970.40044399278;303495;305949;306158;306585;307506;38166;38486.2302753949;38727.80636096802;41418.58581414147;41650.58349416467;39223.80388098041;39368.40947385849;42813.14373712446;42932.57067429286;43127;35790.46314305235;36191.095222619646;36220.456693150154;36499.452508212926;36662.8166859164;35756.46365304574;35859.64140358563;36632;37033;37600.247995040496;35372;35421.64578354183;35583.82208088943;36058.45912311265;36452.63547364492;30418.54372184463;32791.34417311688;32964.50553241655;33056.51245693902;33168.33663326768;24441.633375499026;24850;25106.74893251044;25516.48967020612;25517.489650207262 04:50:48 INFO - PROCESS | 23757 | |2;jquery.html;329.6620963512401;348.95812502499706;352.53641461478156;357.92304654499276;378.9829457674404;12003.819942700855;15472.38110475581;15592.610184745387;16073.83926160738;16511.66976660466;15727.213639318046;16134.435294764686;16219.351225950977;16268;16529.25618347174;3616.855325786972;3661.7253705972025;3719.2003719200366;3722.4788529605876;4529.252673308916;4354.172707185625;4448.599626033656;4458.79935402906;4462.263726485126;4464.464264288274;3256.788308759923;3401.523786669868;4991.800327986876;5215.895682086356;5235.55497782689;5099.4390617032095;5262.368515778093;5268.6575372600655;5279.472052794709;5286.101362768339;5077.796888124471;5111.795528178868;5117.513836185593;5118.513741194581;5119.308893299394;11098.44507774608;11195;11220.214584979054;11285.435728213557;11434.885651143548;1578.5658943790434;1725.8964462132312;1754.5262779049713;1773.627538216976;1813.3109418421047;8437.156284371575;8508.829823403497;8573.699920502815;8956.149165829236;9013.233875120623;1673.2888522377941;1678.3873886031633;1681.4199101310028;1692.9238184281737;1738.0614468187164;62308.68845655788;68207;68602;69221.65389173022;70595.64702176457;9808.803823923481;9838.16375608067;9916.752081198028;10149;10279.331843430153;13788.448462061606;13818.581748194027;13825.861741382458;13829.51596694111;13831.515896943558;6679.86640267192;6789.321067893171;6892.345227203407;6932.757353492603;7072.878136559012;6360.745570177141;6385.904211436832;6566.638834864033;6590.670466476657;6596.769113081019;4106.322456794595;4205.095904380573;4227.32362821947;4281.2293787118;4356.08522210333;1728.4900954218535;1774.609585891102;1790.1138936226391;1803.9098045097955;1857.6841936870494;767.1331395523134;810.8054067023871;835.1022650650575;849.8682704180738;880.4453194487432;16070.116143612213;16221.188940552925;16303.673926521404;16412.425565105405;17026.659466810594;828.353883970504;856.7815207122144;876.4040452492367;888.7422647432172;902.9390466202186;7422.814429639302;9302.348835581444;9316.254699624014;9477.4787386693;9530.761730956781;407646;411619;414025;414942;420082;79654.20345796584;83011;85070;85260.57369713236;86234.56882715547;890.4301247201796;914.3096961793804;916.0656130746735;916.9587368568431;917.9678711245208;13900.83089782851;14060.226687532284;14107.506237281646;14151.221682807545;14807.25963701789;37770.244595108496;37839;38173;38194;38666.6133338663;50535.49464505308;51195.74402127966;51323.48676513187;51363.48636513587;52119.218211726096;6911.827204319932;6944.37500624926;6984.685689144102;7005.649717514206;7237.203907570269;8321.750347489586;10218.897811021794;10506.212034097625;10648.254622176373;11506.30962142274;9310.162085412345;9566.426014438877;9647.1317581418;10142.239332050274;10400.791984160425;4850.53919877611;9241.537923103953;9337.766555836159;9567.37812042215;9625.278104142077;9413.435193888388;9482.288828337765;9585.089416505421;9649.131578158;10080.596776128872;7093.588259161258;7155.713771449084;7337;7375.852482950419;7571.129320128256;8173.591320433836;9435.716928492157;9488.051194880456;9640.662576809778;9781.902180978384 04:50:48 INFO - PROCESS | 23757 | |3;mootools.html;1191.8391017212684;1320.8150858879756;1369.370089758711;1407.5144075294027;1641.187612131995;6745.561538499994;7459.66431510582;7769.417293702967;7790.532568045915;7917.247861453167;7744.7676569703;7749.457537972344;7768.805779855506;7803.882941755864;7805.063392392906;2067.524469372049;2103.6844473329047;2106.073327735799;2119.5231073008604;2120.6182887080395;2062.0504178286865;2083.7395325584303;2131.5736852629534;2134.7865213478603;2137.903794329251;2061.927832525862;2070.0581235537793;2070.5755320159333;2071.420002399323;2118.4386137673528;2062.6802845558964;2065.9070341834654;2068.048697599106;2069.5860827834417;2075.6990236415786;2035.236786205173;2057.897105144737;2058.8249998750125;2072.1193492765665;2086.2385229391316;7494.400447964204;7634.427417943676;7783.494072885244;7799.883001754978;7800.72697455592;4225.492940847087;4364.934525982113;4369.279068953619;4370.6940514164025;4371.519132895379;2735.4529094181044;2822.379076603144;2901.361700425903;2914.8979785707397;2919.2993681516496;931.6226928094065;938.1041105744066;953.3993584042079;966.5022513405602;975.8975307592742;10553.102986246178;10642.414667193301;10646.095081917969;10657.680269591925;10664.306820056672;3800.6959443245028;3940.605939406094;3958.0896393829003;4079.8368065277054;4271.765052922119;8225.670973161126;8264.752057438287;8344.415890887702;8348.749537513884;8360.665573376997;4221.978890105591;4240.6395456385935;4259.574042595777;4263.978680106642;4266.317389217772;3377.7804442711636;3477.4957631143343;3710.6845918096724;3934.960650393459;3937.074787424953;3060.5562193482265;3360.899173024813;3407.8977630670624;3422.0418282880833;3423.6576342365565;956.6943665765472;977.4379731654185;986.363795351994;1004.9346792458467;1015.1878497202209;683.3576438148125;716.2264754065701;724.8006798130556;730.5689643110591;732.2823632839846;4694.554017368345;4745.1221524018165;4868.95131048692;4899.804007839718;5029.874253143701;363.1502284653923;366.5711117991956;368.28368822640243;375.3169231997738;385.901595093255;3144.779865409445;3238.740900727936;3293.8517766700556;3306.6197387300285;3346.6151392589677;9391.20174785151;9613.807723845484;9694.90305096954;9696.660616878375;9703.369280996712;9604.375715578464;9624.181944534654;9634.373765705206;9651.9034809651;9652.565634546463;7176.856462870818;7249.420046396275;7261.164966028974;7363.889541656772;7378.077740282465;4825.565699087099;4850.345203397496;4960.107180707508;4988;5071.18860982241;8675.696350627697;8679.783005424915;8716.215540601377;8874.822503549763;8922.821543569222;8706.782330441789;9024.729258122266;9061.13919177677;9075;9080.40977336471;6877.862442751217;7091.751788687371;7213.855722885618;7227.819304517429;7227.927720722725;7019.824504387227;7037.507374483942;7079.079719636415;7144.3927266182955;7163.462740294394;6420.390062944013;6438.291787903233;6441.871162576816;6494.837629059311;6556.967215163893;6371.585846919936;6512.3162067982175;6554.213494380705;6628.337166283333;6666.266710661726;5807.0998995155815;5973.522118230618;5996.37038110992;6055.9091613626715;6154.138420621206;4236.512801027921;4393.384926110283;4400.889977750582;4506.59440650343;4656.3946686930485;4460.9107817844115;4464.866054018385;4474.37358769779;4548.3859678944245;4647.837325693719 04:50:48 INFO - PROCESS | 23757 | |4;prototype.html;270.55088553002014;277.99027034053813;283.440205593952;291.4491610855482;292.9179829647699;4572.8399506017295;4681.4616319123315;4779.952200477994;4829.492903245157;4836.830710925118;4601.240795268785;4693.601043911263;4708.717476951385;4719.740414277213;4745;3536.3634545781747;3712.981435092834;3719.7495515213313;3727.58996510383;3757.9060523486996;3579.6062433132333;3648.726345524083;3700.4079347304437;3704.6480584344445;3730.1980074284024;3680.834362453683;3686.705063594906;3699.7595156314887;3712.2761061593;3723.609021052791;3703.8703645372284;3711.3319602471543;3713.6286371362917;3716.126710223082;3719.2189640175598;3232.288896442779;3237.482002879528;3238.740900727936;3331.53358529806;3338.849751761177;4562.74144298571;4589.403377560929;4590.862274131781;4592.402987611623;4631;4201.117765269297;4202.411662367271;4208.537060923296;4211.473565804275;4214.157168566299;4754.168020596382;4914.754262286907;4939.654224204307;4946.653734238605;4950.8267210647455;3404.795712257248;3411.1642647551507;3413.368526822521;3417.5386322846593;3421.863125474978;5170.870728231786;5192.662476938987;5233.633645644768;5238.292830467876;5257.7896884124975;3404.6254911959663;3602.351576716164;3610.909727256787;3616.52985111939;3630.636936306348;3603.6396360363756;3610.530631017951;3621.492990981265;3640.7633503822167;3677.724170687209;4128.039181388816;4142.275101857163;4143.751374917515;4148.407245471581;4162.75023498585;4685.5782979532005;4769.379980602499;4819.337303649182;4947.208446648591;4968;1210.4915935307015;1233.901287896966;1235.9134860559855;1236.7773800715777;1238.68413554543;776.4587294220967;792.4928046050417;795.9641816118288;798.872180451125;802.3661307566957;3947.848422609685;3956.8615098471414;3959.8020098994934;3960.4851369321805;3962.6328916523753;4509.083639453219;4520.841770538015;4523.660725445605;4526.728396296233;4553.430821147356;3929.8231579578414;3935.2129574085297;3940.901477463029;3953.604639536081;3955.7824319662695;2326.895289711967;2358.3278765551736;2393.628987506939;2398.97601023991;2403.663487111806;4288.978555107205;4294.205571969195;4311.223979683625;4326.3510473428605;4328.5455027222315;4599.67802253839;4632.444106707217;4648.442186937522;4663.953360466419;4676.3686902267755;4272.914541709149;4287.641797011631;4305.956940430556;4502.4371953505815;4859.149648811514;5130.820421285237;5136.666116702402;5140.691558506502;5152.407473140487;5153.994970980622;5052.69683818972;5062.341895553554;5064.848054558369;5076.314697515936;5080.644354895122;4665.906681866276;4834.903301934012;4842.58837998774;4848.224284114524;4868.196747536758;3602.2615363850873;3620.6284883401413;3625.1118475973553;3626.238489917147;3639;4925.876853078702;5157.839486115744;5218.217267409919;5219.791208351775;5221.608379371638;4851.466338702669;4898;4959.999200483656;4997.125503037027;5030.346055012825;4985.501449854985;5000.874978125576;5001.674556242671;5007.148784706682;5007.7245751484015;4800.567948884617;4928.260760885896;4934.087193869145;4935.679180853233;4960.801567937242;4988.4762099980435;5007.924881126713;5017.297578339108;5026.698398096126;5030.270610761346;4917.483664215206;4917.975410122926;4924.162892308388;4956.677815941952;4967.180415231446 04:50:48 INFO - PROCESS | 23757 | |5;yui.html;575.7236526467295;618.8329151129197;625.7184267079813;662.129299970539;671.7514519627739;11862.822057669131;12219.327936963464;12595.370231488434;12668.936655316722;12673.556425525108;12057.698557536067;12368.443420046096;12387.380630968439;12388.690282742937;12468.25190488569;592.0911400999445;730.7880714592761;736.3851184261122;737.1927739125649;738.7377480994223;598.3657323237361;723.5080145501057;741.3550211316162;743.3124359967036;749.3031480722925;782.2607635784186;784.3920961255044;784.8194915169514;784.8626490364192;784.8979632647748;607.4897086447361;626.7774939896317;777.9611019449034;778.4628606261718;778.5640041576706;549.7388740348302;564.2185572981409;567.0105665613531;568.088218409451;568.8464114689011;11954.940225298906;11975.520979160823;11980.10149238802;11987.220830646067;12017.699557511045;11539.249948753304;11857.703557411047;11925.40372981356;12113.33376664283;12474.251544907243;11422.771544569145;11568.074554035657;11615.593454229062;11665.24175928562;11803.586874459354;3824.2160357126722;3942.8817135485983;4008.979955100235;4024.577419370953;4073.735207211522;65757.67121164412;65921.340786592;66034.33965660378;66052;66158.3384166157;9881.25890558211;9963.551640176065;10061.094501494901;10123.797524049625;10325.84511232332;18725.25098996025;18739.344122955903;18805.247790088517;18828;18864.434066978014;5761.48146666802;5948.196993405922;6336.936630633727;6360.459360954371;6460.676966151674;3523.489094081344;3653.287608916289;3668.174660701321;3686.64976827201;3758.755680880734;2587.573050446693;2682.5782335362287;2700.243931699127;2705.1613999660167;2724.1418953029734;480.5506851094238;486.3920099875156;493.70624478435275;496.65482489669336;503.39592489012597;417.6863763463889;443.6229205175575;463.1824829176506;471.21777848770876;505.97976080957085;6775.457963362919;6915.676062497447;6916.308369163144;6936.549124307005;7255.419566434673;431.7754767520872;452.9456465224194;455.8131166221833;458.0998338265258;484.9515048495122;3531.841067151984;3635.1820840311248;3720.739548231652;3733.8879833605033;3751.6998640108727;57126.42873571294;57257.42742572521;57281.42718572844;79376.20623793804;105157;55308.44691553033;65000;85376;86137;91304.54347728219;79814.60092699615;80157.59921200357;81142;82037;83104;6969.512134150561;6991.965040174767;7108.786736397917;7184.9640751798;7317.817054573678;38970.805145975224;39397.80301098476;39829.20341593094;47113.764431179;49207.26189107095;38618.42072368973;41614.58385416107;60001.39998600133;60078.39921600728;61093.38906611055;10320.380777153396;10365.481725913523;10504;10606.575736970743;10815.297005694605;10583.241378624829;10801;11174.441277935908;11438.771224575295;11559.942200288944;10336.276460647983;10865.728356790827;10905.945470272598;11645.59240426581;11903;10435.113015393474;10507.94746026265;10916.672499825017;11058.170637202404;11110.722231944266;11223.102151827998;11481.425928703698;11497.137714671266;11955.76088478243;11972.042236620875;8614.18165274298;8863.290936725176;8876.644934202559;8947.821043578962;8948.463092214488;8234.917650823654;8921.643134274556;9143.359964802667;9625.229981601315;9759.316847820584 04:50:48 INFO - PROCESS | 23757 | __end_tp_report 04:50:48 INFO - PROCESS | 23757 | __start_cc_report 04:50:48 INFO - PROCESS | 23757 | _x_x_mozilla_cycle_collect,1176 04:50:48 INFO - PROCESS | 23757 | __end_cc_report 04:50:48 INFO - PROCESS | 23757 | __startTimestamp1474113048120__endTimestamp 04:50:48 INFO - PROCESS | 23757 | 04:50:48 INFO - PROCESS | 23757 | ------- Summary: start ------- 04:50:48 INFO - PROCESS | 23757 | Number of tests: 6 04:50:48 INFO - PROCESS | 23757 | 04:50:48 INFO - PROCESS | 23757 | [#0] dojo.html Cycles:165 Average:4676.52 Median:4828.88 stddev:498.00 (10.3%) stddev-sans-first:471.07 04:50:48 INFO - PROCESS | 23757 | Values: 2560.9 2605.0 2636.1 2641.6 2662.2 4613.1 4673.5 4688.6 4690.4 4717.8 4671.4 4675.4 4683.1 4713.0 4731.5 4256.0 4295.7 4299.4 4301.8 4363.4 4390.9 4422.4 4465.6 4470.5 4516.4 4226.5 4255.7 4298.8 4349.7 4419.6 4220.9 4287.1 4330.8 4338.2 4351.4 4244.6 4314.7 4315.6 4317.4 4373.2 4688.6 4702.7 4715.4 4720.9 4734.0 4878.8 4912.4 4960.1 4962.1 4969.6 5035.1 5035.7 5036.7 5047.7 5077.9 4776.4 4777.9 4785.2 4808.3 4823.7 4970.4 5012.0 5157.3 5216.3 5271.6 4967.5 4999.6 5011.3 5012.7 5063.9 5094.9 5097.9 5098.3 5101.0 5149.7 4953.2 4968.3 4991.0 5011.6 5015.2 4967.4 4989.2 4989.2 5036.1 5043.9 4298.4 4300.0 4302.0 4340.0 4354.1 3726.6 3737.6 3743.9 3745.4 3811.8 3985.4 4343.5 4399.3 4438.0 4444.6 5118.0 5123.7 5126.2 5132.1 5142.6 4376.3 4389.4 4393.2 4395.2 4448.0 4457.1 4485.8 4496.5 4535.5 4610.0 4826.2 4827.8 4829.1 4860.7 4871.0 5055.5 5094.2 5096.7 5103.2 5158.4 4617.7 4659.0 4800.2 4800.4 4871.2 5041.5 5070.7 5076.7 5132.8 5140.7 5136.9 5145.5 5155.0 5156.8 5171.0 4834.4 4886.5 5001.7 5015.7 5021.4 4866.8 4914.4 4915.5 4932.2 4981.8 4817.0 4837.4 4848.3 4849.2 4911.6 4876.6 4929.8 4939.0 4942.0 5012.3 4828.9 4847.9 4892.6 4893.7 4900.9 04:50:48 INFO - PROCESS | 23757 | 04:50:48 INFO - PROCESS | 23757 | [#1] ext.html Cycles:180 Average:47630.85 Median:37084.41 stddev:94740.84 (255.5%) stddev-sans-first:94940.70 04:50:48 INFO - PROCESS | 23757 | Values: 561.2 563.4 572.9 573.8 576.2 27387.6 27964.9 37861.8 38988.2 39128.2 40695.0 41069.0 41082.8 41142.8 41145.2 7406.9 7562.9 7569.1 7569.3 7569.4 7425.2 7505.8 7505.9 7509.3 7510.5 7522.8 7563.8 7566.4 7568.3 7571.5 7490.4 7547.8 7553.4 7559.2 7562.1 5520.2 5560.8 5571.0 5572.3 5574.5 36718.3 37064.4 37083.8 37085.0 37110.4 2651.9 2864.3 2901.2 2997.4 3256.3 26697.5 27641.0 27998.7 28146.3 28697.4 3043.0 3183.7 3185.6 3239.7 3295.6 260073.0 260099.0 261979.0 262378.0 262949.0 26721.6 27030.6 43068.4 43635.6 43660.3 32291.2 32397.7 32415.2 32419.7 32421.2 11581.7 11683.6 11683.8 11686.5 11707.5 9612.9 9678.6 9690.6 9694.6 9695.4 7469.7 7554.2 7610.9 7611.9 7615.9 2984.6 3038.1 3040.8 3055.9 3056.5 797.5 803.2 826.6 828.6 831.8 24923.0 26190.7 26886.0 27261.0 27305.2 758.7 885.4 888.6 894.0 907.8 11663.9 13847.8 14084.8 14210.4 14293.4 375516.0 425752.0 432507.0 433627.0 628936.0 46794.0 46883.3 47407.5 47506.0 47564.0 1006.3 1069.7 1077.7 1100.5 1120.8 23989.0 26578.5 27907.4 28189.9 28357.3 39272.4 39925.0 39958.4 39969.8 39970.4 303495.0 305949.0 306158.0 306585.0 307506.0 38166.0 38486.2 38727.8 41418.6 41650.6 39223.8 39368.4 42813.1 42932.6 43127.0 35790.5 36191.1 36220.5 36499.5 36662.8 35756.5 35859.6 36632.0 37033.0 37600.2 35372.0 35421.6 35583.8 36058.5 36452.6 30418.5 32791.3 32964.5 33056.5 33168.3 24441.6 24850.0 25106.7 25516.5 25517.5 04:50:48 INFO - PROCESS | 23757 | 04:50:48 INFO - PROCESS | 23757 | [#2] jquery.html Cycles:180 Average:24447.55 Median:5105.62 stddev:68436.34 (1340.4%) stddev-sans-first:68604.36 04:50:48 INFO - PROCESS | 23757 | Values: 329.7 349.0 352.5 357.9 379.0 12003.8 15472.4 15592.6 16073.8 16511.7 15727.2 16134.4 16219.4 16268.0 16529.3 3616.9 3661.7 3719.2 3722.5 4529.3 4354.2 4448.6 4458.8 4462.3 4464.5 3256.8 3401.5 4991.8 5215.9 5235.6 5099.4 5262.4 5268.7 5279.5 5286.1 5077.8 5111.8 5117.5 5118.5 5119.3 11098.4 11195.0 11220.2 11285.4 11434.9 1578.6 1725.9 1754.5 1773.6 1813.3 8437.2 8508.8 8573.7 8956.1 9013.2 1673.3 1678.4 1681.4 1692.9 1738.1 62308.7 68207.0 68602.0 69221.7 70595.6 9808.8 9838.2 9916.8 10149.0 10279.3 13788.4 13818.6 13825.9 13829.5 13831.5 6679.9 6789.3 6892.3 6932.8 7072.9 6360.7 6385.9 6566.6 6590.7 6596.8 4106.3 4205.1 4227.3 4281.2 4356.1 1728.5 1774.6 1790.1 1803.9 1857.7 767.1 810.8 835.1 849.9 880.4 16070.1 16221.2 16303.7 16412.4 17026.7 828.4 856.8 876.4 888.7 902.9 7422.8 9302.3 9316.3 9477.5 9530.8 407646.0 411619.0 414025.0 414942.0 420082.0 79654.2 83011.0 85070.0 85260.6 86234.6 890.4 914.3 916.1 917.0 918.0 13900.8 14060.2 14107.5 14151.2 14807.3 37770.2 37839.0 38173.0 38194.0 38666.6 50535.5 51195.7 51323.5 51363.5 52119.2 6911.8 6944.4 6984.7 7005.6 7237.2 8321.8 10218.9 10506.2 10648.3 11506.3 9310.2 9566.4 9647.1 10142.2 10400.8 4850.5 9241.5 9337.8 9567.4 9625.3 9413.4 9482.3 9585.1 9649.1 10080.6 7093.6 7155.7 7337.0 7375.9 7571.1 8173.6 9435.7 9488.1 9640.7 9781.9 04:50:48 INFO - PROCESS | 23757 | 04:50:48 INFO - PROCESS | 23757 | [#3] mootools.html Cycles:180 Average:4967.26 Median:4859.65 stddev:2892.98 (59.5%) stddev-sans-first:2887.18 04:50:48 INFO - PROCESS | 23757 | Values: 1191.8 1320.8 1369.4 1407.5 1641.2 6745.6 7459.7 7769.4 7790.5 7917.2 7744.8 7749.5 7768.8 7803.9 7805.1 2067.5 2103.7 2106.1 2119.5 2120.6 2062.1 2083.7 2131.6 2134.8 2137.9 2061.9 2070.1 2070.6 2071.4 2118.4 2062.7 2065.9 2068.0 2069.6 2075.7 2035.2 2057.9 2058.8 2072.1 2086.2 7494.4 7634.4 7783.5 7799.9 7800.7 4225.5 4364.9 4369.3 4370.7 4371.5 2735.5 2822.4 2901.4 2914.9 2919.3 931.6 938.1 953.4 966.5 975.9 10553.1 10642.4 10646.1 10657.7 10664.3 3800.7 3940.6 3958.1 4079.8 4271.8 8225.7 8264.8 8344.4 8348.7 8360.7 4222.0 4240.6 4259.6 4264.0 4266.3 3377.8 3477.5 3710.7 3935.0 3937.1 3060.6 3360.9 3407.9 3422.0 3423.7 956.7 977.4 986.4 1004.9 1015.2 683.4 716.2 724.8 730.6 732.3 4694.6 4745.1 4869.0 4899.8 5029.9 363.2 366.6 368.3 375.3 385.9 3144.8 3238.7 3293.9 3306.6 3346.6 9391.2 9613.8 9694.9 9696.7 9703.4 9604.4 9624.2 9634.4 9651.9 9652.6 7176.9 7249.4 7261.2 7363.9 7378.1 4825.6 4850.3 4960.1 4988.0 5071.2 8675.7 8679.8 8716.2 8874.8 8922.8 8706.8 9024.7 9061.1 9075.0 9080.4 6877.9 7091.8 7213.9 7227.8 7227.9 7019.8 7037.5 7079.1 7144.4 7163.5 6420.4 6438.3 6441.9 6494.8 6557.0 6371.6 6512.3 6554.2 6628.3 6666.3 5807.1 5973.5 5996.4 6055.9 6154.1 4236.5 4393.4 4400.9 4506.6 4656.4 4460.9 4464.9 4474.4 4548.4 4647.8 04:50:48 INFO - PROCESS | 23757 | 04:50:48 INFO - PROCESS | 23757 | [#4] prototype.html Cycles:180 Average:4031.20 Median:4522.25 stddev:1189.99 (26.3%) stddev-sans-first:1159.37 04:50:48 INFO - PROCESS | 23757 | Values: 270.6 278.0 283.4 291.4 292.9 4572.8 4681.5 4780.0 4829.5 4836.8 4601.2 4693.6 4708.7 4719.7 4745.0 3536.4 3713.0 3719.7 3727.6 3757.9 3579.6 3648.7 3700.4 3704.6 3730.2 3680.8 3686.7 3699.8 3712.3 3723.6 3703.9 3711.3 3713.6 3716.1 3719.2 3232.3 3237.5 3238.7 3331.5 3338.8 4562.7 4589.4 4590.9 4592.4 4631.0 4201.1 4202.4 4208.5 4211.5 4214.2 4754.2 4914.8 4939.7 4946.7 4950.8 3404.8 3411.2 3413.4 3417.5 3421.9 5170.9 5192.7 5233.6 5238.3 5257.8 3404.6 3602.4 3610.9 3616.5 3630.6 3603.6 3610.5 3621.5 3640.8 3677.7 4128.0 4142.3 4143.8 4148.4 4162.8 4685.6 4769.4 4819.3 4947.2 4968.0 1210.5 1233.9 1235.9 1236.8 1238.7 776.5 792.5 796.0 798.9 802.4 3947.8 3956.9 3959.8 3960.5 3962.6 4509.1 4520.8 4523.7 4526.7 4553.4 3929.8 3935.2 3940.9 3953.6 3955.8 2326.9 2358.3 2393.6 2399.0 2403.7 4289.0 4294.2 4311.2 4326.4 4328.5 4599.7 4632.4 4648.4 4664.0 4676.4 4272.9 4287.6 4306.0 4502.4 4859.1 5130.8 5136.7 5140.7 5152.4 5154.0 5052.7 5062.3 5064.8 5076.3 5080.6 4665.9 4834.9 4842.6 4848.2 4868.2 3602.3 3620.6 3625.1 3626.2 3639.0 4925.9 5157.8 5218.2 5219.8 5221.6 4851.5 4898.0 4960.0 4997.1 5030.3 4985.5 5000.9 5001.7 5007.1 5007.7 4800.6 4928.3 4934.1 4935.7 4960.8 4988.5 5007.9 5017.3 5026.7 5030.3 4917.5 4918.0 4924.2 4956.7 4967.2 04:50:48 INFO - PROCESS | 23757 | 04:50:48 INFO - PROCESS | 23757 | [#5] yui.html Cycles:180 Average:16455.74 Median:467.20 stddev:23368.53 (5001.8%) stddev-sans-first:23403.66 04:50:48 INFO - PROCESS | 23757 | Values: 575.7 618.8 625.7 662.1 671.8 11862.8 12219.3 12595.4 12668.9 12673.6 12057.7 12368.4 12387.4 12388.7 12468.3 592.1 730.8 736.4 737.2 738.7 598.4 723.5 741.4 743.3 749.3 782.3 784.4 784.8 784.9 784.9 607.5 626.8 778.0 778.5 778.6 549.7 564.2 567.0 568.1 568.8 11954.9 11975.5 11980.1 11987.2 12017.7 11539.2 11857.7 11925.4 12113.3 12474.3 11422.8 11568.1 11615.6 11665.2 11803.6 3824.2 3942.9 4009.0 4024.6 4073.7 65757.7 65921.3 66034.3 66052.0 66158.3 9881.3 9963.6 10061.1 10123.8 10325.8 18725.3 18739.3 18805.2 18828.0 18864.4 5761.5 5948.2 6336.9 6360.5 6460.7 3523.5 3653.3 3668.2 3686.6 3758.8 2587.6 2682.6 2700.2 2705.2 2724.1 480.6 486.4 493.7 496.7 503.4 417.7 443.6 463.2 471.2 506.0 6775.5 6915.7 6916.3 6936.5 7255.4 431.8 452.9 455.8 458.1 485.0 3531.8 3635.2 3720.7 3733.9 3751.7 57126.4 57257.4 57281.4 79376.2 105157.0 55308.4 65000.0 85376.0 86137.0 91304.5 79814.6 80157.6 81142.0 82037.0 83104.0 6969.5 6992.0 7108.8 7185.0 7317.8 38970.8 39397.8 39829.2 47113.8 49207.3 38618.4 41614.6 60001.4 60078.4 61093.4 10320.4 10365.5 10504.0 10606.6 10815.3 10583.2 10801.0 11174.4 11438.8 11559.9 10336.3 10865.7 10905.9 11645.6 11903.0 10435.1 10507.9 10916.7 11058.2 11110.7 11223.1 11481.4 11497.1 11955.8 11972.0 8614.2 8863.3 8876.6 8947.8 8948.5 8234.9 8921.6 9143.4 9625.2 9759.3 04:50:48 INFO - PROCESS | 23757 | -------- Summary: end -------- 04:50:48 INFO - PROCESS | 23757 | 04:50:49 INFO - TEST-INFO | 23757: exit 0 04:50:49 INFO - TEST-OK | dromaeo_css | took 1121995ms 04:50:49 INFO - TEST-START | kraken 04:50:49 INFO - operating with platform_type : linux_ 04:50:49 INFO - Initialising browser for kraken test... 04:50:49 INFO - TEST-INFO | started process 24060 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb00nS0/profile http://localhost:59294/getInfo.html) 04:50:54 INFO - PROCESS | 24060 | __metrics Screen width/height:1600/1200 04:50:54 INFO - PROCESS | 24060 | colorDepth:24 04:50:54 INFO - PROCESS | 24060 | Browser inner width/height: 1024/697 04:50:54 INFO - PROCESS | 24060 | __metrics 04:50:54 INFO - PROCESS | 24060 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:50:54 INFO - PROCESS | 24060 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:50:55 INFO - PROCESS | 24060 | console.error: PushService: 04:50:55 INFO - PROCESS | 24060 | stateChangeProcessEnqueue: Error transitioning state 04:50:55 INFO - PROCESS | 24060 | UnknownError 04:50:55 INFO - TEST-INFO | 24060: exit 0 04:50:55 INFO - Browser initialized. 04:50:55 INFO - Running cycle 1/1 for kraken test... 04:50:55 INFO - TEST-INFO | started process 24143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpb00nS0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:51:08 INFO - PROCESS | 24143 | RSS: Main: 174739456 04:51:08 INFO - PROCESS | 24143 | 04:51:10 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59294/tests/kraken/driver.html?testName=audio-beat-detection) 04:51:11 INFO - PROCESS | 24143 | RSS: Main: 233930752 04:51:11 INFO - PROCESS | 24143 | 04:51:14 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59294/tests/kraken/driver.html?testName=audio-dft) 04:51:15 INFO - PROCESS | 24143 | RSS: Main: 217870336 04:51:15 INFO - PROCESS | 24143 | 04:51:18 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59294/tests/kraken/driver.html?testName=audio-fft) 04:51:19 INFO - PROCESS | 24143 | RSS: Main: 299909120 04:51:19 INFO - PROCESS | 24143 | 04:51:21 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59294/tests/kraken/driver.html?testName=audio-oscillator) 04:51:21 INFO - PROCESS | 24143 | RSS: Main: 209637376 04:51:21 INFO - PROCESS | 24143 | 04:51:24 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59294/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:51:24 INFO - PROCESS | 24143 | RSS: Main: 214388736 04:51:24 INFO - PROCESS | 24143 | 04:51:28 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59294/tests/kraken/driver.html?testName=imaging-darkroom) 04:51:28 INFO - PROCESS | 24143 | RSS: Main: 249577472 04:51:28 INFO - PROCESS | 24143 | 04:51:32 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59294/tests/kraken/driver.html?testName=imaging-desaturate) 04:51:32 INFO - PROCESS | 24143 | RSS: Main: 244400128 04:51:32 INFO - PROCESS | 24143 | 04:51:35 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59294/tests/kraken/driver.html?testName=json-parse-financial) 04:51:36 INFO - PROCESS | 24143 | RSS: Main: 246927360 04:51:36 INFO - PROCESS | 24143 | 04:51:37 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59294/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:51:38 INFO - PROCESS | 24143 | RSS: Main: 210448384 04:51:38 INFO - PROCESS | 24143 | 04:51:40 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59294/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:51:41 INFO - PROCESS | 24143 | RSS: Main: 217640960 04:51:41 INFO - PROCESS | 24143 | 04:51:43 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59294/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:51:44 INFO - PROCESS | 24143 | RSS: Main: 222023680 04:51:44 INFO - PROCESS | 24143 | 04:51:46 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:51:47 INFO - PROCESS | 24143 | RSS: Main: 222564352 04:51:47 INFO - PROCESS | 24143 | 04:51:50 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:51:50 INFO - PROCESS | 24143 | RSS: Main: 221196288 04:51:50 INFO - PROCESS | 24143 | 04:51:52 INFO - PROCESS | 24143 | Cycle 1(1): loaded http://localhost:59294/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59294/tests/kraken/driver.html?testName=ai-astar) 04:51:52 INFO - PROCESS | 24143 | RSS: Main: 272384000 04:51:52 INFO - PROCESS | 24143 | 04:51:52 INFO - PROCESS | 24143 | __start_tp_report 04:51:52 INFO - PROCESS | 24143 | _x_x_mozilla_page_load 04:51:52 INFO - PROCESS | 24143 | _x_x_mozilla_page_load_details 04:51:52 INFO - PROCESS | 24143 | |i|pagename|runs| 04:51:52 INFO - PROCESS | 24143 | |0;ai-astar;113;116;115;115;115;115;115;115;116;115 04:51:52 INFO - PROCESS | 24143 | |1;audio-beat-detection;160;123;126;170;123;129;125;122;157;124 04:51:52 INFO - PROCESS | 24143 | |2;audio-dft;163;162;162;163;163;163;163;162;162;162 04:51:52 INFO - PROCESS | 24143 | |3;audio-fft;78;75;76;105;76;77;80;78;101;77 04:51:53 INFO - PROCESS | 24143 | |4;audio-oscillator;84;84;114;84;83;84;108;83;84;110 04:51:53 INFO - PROCESS | 24143 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;117;117 04:51:53 INFO - PROCESS | 24143 | |6;imaging-darkroom;148;147;146;146;149;149;146;147;146;146 04:51:53 INFO - PROCESS | 24143 | |7;imaging-desaturate;96;96;96;96;97;96;96;96;96;97 04:51:53 INFO - PROCESS | 24143 | |8;json-parse-financial;66;64;64;63;65;66;65;65;66;65 04:51:53 INFO - PROCESS | 24143 | |9;json-stringify-tinderbox;65;65;67;66;67;66;66;66;66;65 04:51:53 INFO - PROCESS | 24143 | |10;stanford-crypto-aes;82;83;86;83;82;88;86;92;82;82 04:51:53 INFO - PROCESS | 24143 | |11;stanford-crypto-ccm;135;132;133;132;130;130;131;132;183;132 04:51:53 INFO - PROCESS | 24143 | |12;stanford-crypto-pbkdf2;178;176;175;173;175;177;178;171;174;174 04:51:53 INFO - PROCESS | 24143 | |13;stanford-crypto-sha256-iterative;70;70;69;73;73;69;68;69;68;67 04:51:53 INFO - PROCESS | 24143 | __end_tp_report 04:51:53 INFO - PROCESS | 24143 | __start_cc_report 04:51:53 INFO - PROCESS | 24143 | _x_x_mozilla_cycle_collect,1972 04:51:53 INFO - PROCESS | 24143 | __end_cc_report 04:51:53 INFO - PROCESS | 24143 | __startTimestamp1474113112996__endTimestamp 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | ------- Summary: start ------- 04:51:53 INFO - PROCESS | 24143 | Number of tests: 14 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:0.82 (0.7%) stddev-sans-first:0.44 04:51:53 INFO - PROCESS | 24143 | Values: 113.0 116.0 115.0 115.0 115.0 115.0 115.0 115.0 116.0 115.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#1] audio-beat-detection Cycles:10 Average:135.90 Median:127.50 stddev:18.62 (14.6%) stddev-sans-first:17.59 04:51:53 INFO - PROCESS | 24143 | Values: 160.0 123.0 126.0 170.0 123.0 129.0 125.0 122.0 157.0 124.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:0.53 (0.3%) stddev-sans-first:0.53 04:51:53 INFO - PROCESS | 24143 | Values: 163.0 162.0 162.0 163.0 163.0 163.0 163.0 162.0 162.0 162.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#3] audio-fft Cycles:10 Average:82.30 Median:77.00 stddev:11.04 (14.3%) stddev-sans-first:11.60 04:51:53 INFO - PROCESS | 24143 | Values: 78.0 75.0 76.0 105.0 76.0 77.0 80.0 78.0 101.0 77.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#4] audio-oscillator Cycles:10 Average:91.80 Median:84.00 stddev:13.10 (15.6%) stddev-sans-first:13.59 04:51:53 INFO - PROCESS | 24143 | Values: 84.0 84.0 114.0 84.0 83.0 84.0 108.0 83.0 84.0 110.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 04:51:53 INFO - PROCESS | 24143 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:1.25 (0.8%) stddev-sans-first:1.27 04:51:53 INFO - PROCESS | 24143 | Values: 148.0 147.0 146.0 146.0 149.0 149.0 146.0 147.0 146.0 146.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 04:51:53 INFO - PROCESS | 24143 | Values: 96.0 96.0 96.0 96.0 97.0 96.0 96.0 96.0 96.0 97.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:0.99 (1.5%) stddev-sans-first:0.97 04:51:53 INFO - PROCESS | 24143 | Values: 66.0 64.0 64.0 63.0 65.0 66.0 65.0 65.0 66.0 65.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#9] json-stringify-tinderbox Cycles:10 Average:65.90 Median:66.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 04:51:53 INFO - PROCESS | 24143 | Values: 65.0 65.0 67.0 66.0 67.0 66.0 66.0 66.0 66.0 65.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#10] stanford-crypto-aes Cycles:10 Average:84.60 Median:84.50 stddev:3.37 (4.0%) stddev-sans-first:3.44 04:51:53 INFO - PROCESS | 24143 | Values: 82.0 83.0 86.0 83.0 82.0 88.0 86.0 92.0 82.0 82.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:132.00 stddev:16.23 (12.3%) stddev-sans-first:17.20 04:51:53 INFO - PROCESS | 24143 | Values: 135.0 132.0 133.0 132.0 130.0 130.0 131.0 132.0 183.0 132.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.10 Median:175.50 stddev:2.23 (1.3%) stddev-sans-first:2.11 04:51:53 INFO - PROCESS | 24143 | Values: 178.0 176.0 175.0 173.0 175.0 177.0 178.0 171.0 174.0 174.0 04:51:53 INFO - PROCESS | 24143 | 04:51:53 INFO - PROCESS | 24143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.60 Median:69.50 stddev:2.01 (2.9%) stddev-sans-first:2.13 04:51:53 INFO - PROCESS | 24143 | Values: 70.0 70.0 69.0 73.0 73.0 69.0 68.0 69.0 68.0 67.0 04:51:53 INFO - PROCESS | 24143 | -------- Summary: end -------- 04:51:53 INFO - PROCESS | 24143 | 04:51:54 INFO - TEST-INFO | 24143: exit 0 04:51:54 INFO - TEST-OK | kraken | took 65173ms 04:51:54 INFO - SUITE-END | took 1187s 04:51:54 INFO - Completed test suite (00:19:47) 04:51:54 INFO - javascript benchmark 04:51:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2560.92317230483, 2604.960925586118, 2636.090548760677, 2641.6301717759516, 2662.227953893371, 4613.123506533756, 4673.532646735325, 4688.554587314204, 4690.413698287714, 4717.834875779348, 4671.369365135705, 4675.4155730533685, 4683.063387322532, 4712.976435117819, 4731.4795372509, 4255.957440425587, 4295.656347492193, 4299.4195783569285, 4301.827926882921, 4363.389125522413, 4390.912181756363, 4422.447194100738, 4465.598096171344, 4470.463544374679, 4516.36770852081, 4226.4716910386205, 4255.744655320691, 4298.78506074695, 4349.652027837766, 4419.602235798761, 4220.936685949713, 4287.099709061101, 4330.826766929319, 4338.240807858612, 4351.412559304516, 4244.61798438139, 4314.676399270036, 4315.633171180453, 4317.373980772771, 4373.169097871426, 4688.601468875116, 4702.741349225791, 4715.41057367829, 4720.905581888377, 4733.976330118362, 4878.756062196911, 4912.435069966964, 4960.082384758795, 4962.05720913029, 4969.602431805447, 5035.1188542005, 5035.697858128524, 5036.697798132123, 5047.697138171685, 5077.898442031139, 4776.355192049029, 4777.856664300077, 4785.210440277316, 4808.2787581863, 4823.734694591796, 4970.353853998957, 5012.04771093491, 5157.329547158845, 5216.295800067019, 5271.578273738091, 4967.4784147664695, 4999.600031997432, 5011.348524691767, 5012.724300163453, 5063.949360506422, 5094.923576146361, 5097.923531147036, 5098.286239926413, 5101.0, 5149.6910185389, 4953.157963146274, 4968.30443737877, 4990.975045124824, 5011.599072074226, 5015.197568389113, 4967.428745694219, 4989.201727723546, 4989.226669866177, 5036.143855544567, 5043.87390315245, 4298.398224248608, 4300.0, 4302.0, 4339.9783001085425, 4354.10740798142, 3726.6273372662517, 3737.6449237322413, 3743.9251214975548, 3745.3632882410056, 3811.7712937223855, 3985.442038114666, 4343.478782546052, 4399.274119770266, 4438.023634800339, 4444.622207112367, 5118.0, 5123.7438128093445, 5126.2054381570915, 5132.076226279306, 5142.61430392722, 4376.321670141133, 4389.385486031958, 4393.1872603568445, 4395.164918665443, 4448.043670610834, 4457.064016556495, 4485.820567177277, 4496.527864574238, 4535.523770004102, 4610.0, 4826.179549476527, 4827.831025914076, 4829.106615276185, 4860.659753817199, 4870.975645121823, 5055.494450554915, 5094.1849304111165, 5096.745162741774, 5103.157978933435, 5158.432572416956, 4617.746023968714, 4659.0, 4800.231962885921, 4800.35195248637, 4871.19625261842, 5041.495850414929, 5070.746462676778, 5076.670016448919, 5132.820351287687, 5140.7429628517675, 5136.922946155736, 5145.485451454824, 5155.046316431472, 5156.767945442539, 5171.0, 4834.444038935427, 4886.53577910098, 5001.749912504288, 5015.724135172601, 5021.397432308147, 4866.780994855169, 4914.385701787277, 4915.459299476983, 4932.186189278872, 4981.750912454435, 4817.0365926814075, 4837.37114175155, 4848.296996935354, 4849.224124140121, 4911.607071434348, 4876.585490233228, 4929.802807887788, 4938.975305123451, 4942.0, 5012.3233363495465, 4828.8792780180775, 4847.903041939071, 4892.633052521004, 4893.730844803427, 4900.8774780630765], "value": 4644.251038051327, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [561.1890817768325, 563.4450066684318, 572.9197912292279, 573.7561536347052, 576.1559315602641, 27387.589186162222, 27964.86017569912, 37861.81069094654, 38988.22023559527, 39128.21743565127, 40695.0, 41069.0, 41082.7945860271, 41142.794286028606, 41145.17709645805, 7406.925930740691, 7562.886556701654, 7569.129550101754, 7569.318761311481, 7569.432292578051, 7425.1832298447125, 7505.812354691149, 7505.887411688829, 7509.324160825525, 7510.474266801326, 7522.774316770506, 7563.810904727398, 7566.4325175611775, 7568.281013303727, 7571.545707257582, 7490.3633191178815, 7547.773566793005, 7553.357964573018, 7559.206283340225, 7562.13035500919, 5520.227168196456, 5560.77756889724, 5571.0, 5572.331320241597, 5574.46702156906, 36718.26563468716, 37064.444033339525, 37083.814580927195, 37085.0, 37110.44334334987, 2651.8541480218582, 2864.255293623652, 2901.1586639874413, 2997.4454725875785, 3256.3161736035463, 26697.46605067907, 27641.0, 27998.720012799815, 28146.296342591395, 28697.426051478855, 3042.9543556846666, 3183.71346578809, 3185.6336521300113, 3239.659835717263, 3295.6210035845943, 260073.0, 260098.9999999981, 261979.0, 262378.0, 262949.0, 26721.599176012376, 27030.5945410819, 43068.353974690406, 43635.563644363785, 43660.345094823606, 32291.19272018218, 32397.676023239936, 32415.189620259684, 32419.675803241666, 32421.18947026343, 11581.710457238469, 11683.649490515298, 11683.766324673628, 11686.532538698357, 11707.531698732126, 9612.903870961341, 9678.56446459911, 9690.612375504901, 9694.563744631509, 9695.369800962915, 7469.663865126083, 7554.206808285161, 7610.9238907610215, 7611.885821712679, 7615.885761713579, 2984.582158497812, 3038.134131772434, 3040.7567394608377, 3055.92360190997, 3056.480398332289, 797.4856217739525, 803.2409373142324, 826.6486743134144, 828.5608627427473, 831.7754206364368, 24923.0, 26190.738092619213, 26886.0, 27261.0, 27305.180844574694, 758.6737702787855, 885.4062687163081, 888.5512816027993, 894.0, 907.7957459571544, 11663.941680291544, 13847.792283115761, 14084.788728169086, 14210.431582736781, 14293.356798943865, 375516.0, 425752.0, 432507.0, 433627.0, 628936.0, 46794.0, 46883.29675054877, 47407.525924741, 47506.0, 47564.0, 1006.3157053203745, 1069.7432616172218, 1077.6659235636978, 1100.4827730966433, 1120.8486854274568, 23988.95147957121, 26578.46843063089, 27907.44185116327, 28189.859050705436, 28357.291067723472, 39272.41091383689, 39925.0, 39958.40062399124, 39969.80015099906, 39970.40044399278, 303495.0, 305949.0, 306158.0, 306585.0, 307506.0, 38166.0, 38486.2302753949, 38727.80636096802, 41418.58581414147, 41650.58349416467, 39223.80388098041, 39368.40947385849, 42813.14373712446, 42932.57067429286, 43127.0, 35790.46314305235, 36191.095222619646, 36220.456693150154, 36499.452508212926, 36662.8166859164, 35756.46365304574, 35859.64140358563, 36632.0, 37033.0, 37600.247995040496, 35372.0, 35421.64578354183, 35583.82208088943, 36058.45912311265, 36452.63547364492, 30418.54372184463, 32791.34417311688, 32964.50553241655, 33056.51245693902, 33168.33663326768, 24441.633375499026, 24850.0, 25106.74893251044, 25516.48967020612, 25517.489650207262], "value": 15796.05686651828, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.6620963512401, 348.95812502499706, 352.53641461478156, 357.92304654499276, 378.9829457674404, 12003.819942700855, 15472.38110475581, 15592.610184745387, 16073.83926160738, 16511.66976660466, 15727.213639318046, 16134.435294764686, 16219.351225950977, 16268.0, 16529.25618347174, 3616.855325786972, 3661.7253705972025, 3719.2003719200366, 3722.4788529605876, 4529.252673308916, 4354.172707185625, 4448.599626033656, 4458.79935402906, 4462.263726485126, 4464.464264288274, 3256.788308759923, 3401.523786669868, 4991.800327986876, 5215.895682086356, 5235.55497782689, 5099.4390617032095, 5262.368515778093, 5268.6575372600655, 5279.472052794709, 5286.101362768339, 5077.796888124471, 5111.795528178868, 5117.513836185593, 5118.513741194581, 5119.308893299394, 11098.44507774608, 11195.0, 11220.214584979054, 11285.435728213557, 11434.885651143548, 1578.5658943790434, 1725.8964462132312, 1754.5262779049713, 1773.627538216976, 1813.3109418421047, 8437.156284371575, 8508.829823403497, 8573.699920502815, 8956.149165829236, 9013.233875120623, 1673.2888522377941, 1678.3873886031633, 1681.4199101310028, 1692.9238184281737, 1738.0614468187164, 62308.68845655788, 68207.0, 68602.0, 69221.65389173022, 70595.64702176457, 9808.803823923481, 9838.16375608067, 9916.752081198028, 10149.0, 10279.331843430153, 13788.448462061606, 13818.581748194027, 13825.861741382458, 13829.51596694111, 13831.515896943558, 6679.86640267192, 6789.321067893171, 6892.345227203407, 6932.757353492603, 7072.878136559012, 6360.745570177141, 6385.904211436832, 6566.638834864033, 6590.670466476657, 6596.769113081019, 4106.322456794595, 4205.095904380573, 4227.32362821947, 4281.2293787118, 4356.08522210333, 1728.4900954218535, 1774.609585891102, 1790.1138936226391, 1803.9098045097955, 1857.6841936870494, 767.1331395523134, 810.8054067023871, 835.1022650650575, 849.8682704180738, 880.4453194487432, 16070.116143612213, 16221.188940552925, 16303.673926521404, 16412.425565105405, 17026.659466810594, 828.353883970504, 856.7815207122144, 876.4040452492367, 888.7422647432172, 902.9390466202186, 7422.814429639302, 9302.348835581444, 9316.254699624014, 9477.4787386693, 9530.761730956781, 407646.0, 411619.0, 414025.0, 414942.0, 420082.0, 79654.20345796584, 83011.0, 85070.0, 85260.57369713236, 86234.56882715547, 890.4301247201796, 914.3096961793804, 916.0656130746735, 916.9587368568431, 917.9678711245208, 13900.83089782851, 14060.226687532284, 14107.506237281646, 14151.221682807545, 14807.25963701789, 37770.244595108496, 37839.0, 38173.0, 38194.0, 38666.6133338663, 50535.49464505308, 51195.74402127966, 51323.48676513187, 51363.48636513587, 52119.218211726096, 6911.827204319932, 6944.37500624926, 6984.685689144102, 7005.649717514206, 7237.203907570269, 8321.750347489586, 10218.897811021794, 10506.212034097625, 10648.254622176373, 11506.30962142274, 9310.162085412345, 9566.426014438877, 9647.1317581418, 10142.239332050274, 10400.791984160425, 4850.53919877611, 9241.537923103953, 9337.766555836159, 9567.37812042215, 9625.278104142077, 9413.435193888388, 9482.288828337765, 9585.089416505421, 9649.131578158, 10080.596776128872, 7093.588259161258, 7155.713771449084, 7337.0, 7375.852482950419, 7571.129320128256, 8173.591320433836, 9435.716928492157, 9488.051194880456, 9640.662576809778, 9781.902180978384], "value": 7630.209871628526, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1191.8391017212684, 1320.8150858879756, 1369.370089758711, 1407.5144075294027, 1641.187612131995, 6745.561538499994, 7459.66431510582, 7769.417293702967, 7790.532568045915, 7917.247861453167, 7744.7676569703, 7749.457537972344, 7768.805779855506, 7803.882941755864, 7805.063392392906, 2067.524469372049, 2103.6844473329047, 2106.073327735799, 2119.5231073008604, 2120.6182887080395, 2062.0504178286865, 2083.7395325584303, 2131.5736852629534, 2134.7865213478603, 2137.903794329251, 2061.927832525862, 2070.0581235537793, 2070.5755320159333, 2071.420002399323, 2118.4386137673528, 2062.6802845558964, 2065.9070341834654, 2068.048697599106, 2069.5860827834417, 2075.6990236415786, 2035.236786205173, 2057.897105144737, 2058.8249998750125, 2072.1193492765665, 2086.2385229391316, 7494.400447964204, 7634.427417943676, 7783.494072885244, 7799.883001754978, 7800.72697455592, 4225.492940847087, 4364.934525982113, 4369.279068953619, 4370.6940514164025, 4371.519132895379, 2735.4529094181044, 2822.379076603144, 2901.361700425903, 2914.8979785707397, 2919.2993681516496, 931.6226928094065, 938.1041105744066, 953.3993584042079, 966.5022513405602, 975.8975307592742, 10553.102986246178, 10642.414667193301, 10646.095081917969, 10657.680269591925, 10664.306820056672, 3800.6959443245028, 3940.605939406094, 3958.0896393829003, 4079.8368065277054, 4271.765052922119, 8225.670973161126, 8264.752057438287, 8344.415890887702, 8348.749537513884, 8360.665573376997, 4221.978890105591, 4240.6395456385935, 4259.574042595777, 4263.978680106642, 4266.317389217772, 3377.7804442711636, 3477.4957631143343, 3710.6845918096724, 3934.960650393459, 3937.074787424953, 3060.5562193482265, 3360.899173024813, 3407.8977630670624, 3422.0418282880833, 3423.6576342365565, 956.6943665765472, 977.4379731654185, 986.363795351994, 1004.9346792458467, 1015.1878497202209, 683.3576438148125, 716.2264754065701, 724.8006798130556, 730.5689643110591, 732.2823632839846, 4694.554017368345, 4745.1221524018165, 4868.95131048692, 4899.804007839718, 5029.874253143701, 363.1502284653923, 366.5711117991956, 368.28368822640243, 375.3169231997738, 385.901595093255, 3144.779865409445, 3238.740900727936, 3293.8517766700556, 3306.6197387300285, 3346.6151392589677, 9391.20174785151, 9613.807723845484, 9694.90305096954, 9696.660616878375, 9703.369280996712, 9604.375715578464, 9624.181944534654, 9634.373765705206, 9651.9034809651, 9652.565634546463, 7176.856462870818, 7249.420046396275, 7261.164966028974, 7363.889541656772, 7378.077740282465, 4825.565699087099, 4850.345203397496, 4960.107180707508, 4988.0, 5071.18860982241, 8675.696350627697, 8679.783005424915, 8716.215540601377, 8874.822503549763, 8922.821543569222, 8706.782330441789, 9024.729258122266, 9061.13919177677, 9075.0, 9080.40977336471, 6877.862442751217, 7091.751788687371, 7213.855722885618, 7227.819304517429, 7227.927720722725, 7019.824504387227, 7037.507374483942, 7079.079719636415, 7144.3927266182955, 7163.462740294394, 6420.390062944013, 6438.291787903233, 6441.871162576816, 6494.837629059311, 6556.967215163893, 6371.585846919936, 6512.3162067982175, 6554.213494380705, 6628.337166283333, 6666.266710661726, 5807.0998995155815, 5973.522118230618, 5996.37038110992, 6055.9091613626715, 6154.138420621206, 4236.512801027921, 4393.384926110283, 4400.889977750582, 4506.59440650343, 4656.3946686930485, 4460.9107817844115, 4464.866054018385, 4474.37358769779, 4548.3859678944245, 4647.837325693719], "value": 3876.792109664573, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.55088553002014, 277.99027034053813, 283.440205593952, 291.4491610855482, 292.9179829647699, 4572.8399506017295, 4681.4616319123315, 4779.952200477994, 4829.492903245157, 4836.830710925118, 4601.240795268785, 4693.601043911263, 4708.717476951385, 4719.740414277213, 4745.0, 3536.3634545781747, 3712.981435092834, 3719.7495515213313, 3727.58996510383, 3757.9060523486996, 3579.6062433132333, 3648.726345524083, 3700.4079347304437, 3704.6480584344445, 3730.1980074284024, 3680.834362453683, 3686.705063594906, 3699.7595156314887, 3712.2761061593, 3723.609021052791, 3703.8703645372284, 3711.3319602471543, 3713.6286371362917, 3716.126710223082, 3719.2189640175598, 3232.288896442779, 3237.482002879528, 3238.740900727936, 3331.53358529806, 3338.849751761177, 4562.74144298571, 4589.403377560929, 4590.862274131781, 4592.402987611623, 4631.0, 4201.117765269297, 4202.411662367271, 4208.537060923296, 4211.473565804275, 4214.157168566299, 4754.168020596382, 4914.754262286907, 4939.654224204307, 4946.653734238605, 4950.8267210647455, 3404.795712257248, 3411.1642647551507, 3413.368526822521, 3417.5386322846593, 3421.863125474978, 5170.870728231786, 5192.662476938987, 5233.633645644768, 5238.292830467876, 5257.7896884124975, 3404.6254911959663, 3602.351576716164, 3610.909727256787, 3616.52985111939, 3630.636936306348, 3603.6396360363756, 3610.530631017951, 3621.492990981265, 3640.7633503822167, 3677.724170687209, 4128.039181388816, 4142.275101857163, 4143.751374917515, 4148.407245471581, 4162.75023498585, 4685.5782979532005, 4769.379980602499, 4819.337303649182, 4947.208446648591, 4968.0, 1210.4915935307015, 1233.901287896966, 1235.9134860559855, 1236.7773800715777, 1238.68413554543, 776.4587294220967, 792.4928046050417, 795.9641816118288, 798.872180451125, 802.3661307566957, 3947.848422609685, 3956.8615098471414, 3959.8020098994934, 3960.4851369321805, 3962.6328916523753, 4509.083639453219, 4520.841770538015, 4523.660725445605, 4526.728396296233, 4553.430821147356, 3929.8231579578414, 3935.2129574085297, 3940.901477463029, 3953.604639536081, 3955.7824319662695, 2326.895289711967, 2358.3278765551736, 2393.628987506939, 2398.97601023991, 2403.663487111806, 4288.978555107205, 4294.205571969195, 4311.223979683625, 4326.3510473428605, 4328.5455027222315, 4599.67802253839, 4632.444106707217, 4648.442186937522, 4663.953360466419, 4676.3686902267755, 4272.914541709149, 4287.641797011631, 4305.956940430556, 4502.4371953505815, 4859.149648811514, 5130.820421285237, 5136.666116702402, 5140.691558506502, 5152.407473140487, 5153.994970980622, 5052.69683818972, 5062.341895553554, 5064.848054558369, 5076.314697515936, 5080.644354895122, 4665.906681866276, 4834.903301934012, 4842.58837998774, 4848.224284114524, 4868.196747536758, 3602.2615363850873, 3620.6284883401413, 3625.1118475973553, 3626.238489917147, 3639.0, 4925.876853078702, 5157.839486115744, 5218.217267409919, 5219.791208351775, 5221.608379371638, 4851.466338702669, 4898.0, 4959.999200483656, 4997.125503037027, 5030.346055012825, 4985.501449854985, 5000.874978125576, 5001.674556242671, 5007.148784706682, 5007.7245751484015, 4800.567948884617, 4928.260760885896, 4934.087193869145, 4935.679180853233, 4960.801567937242, 4988.4762099980435, 5007.924881126713, 5017.297578339108, 5026.698398096126, 5030.270610761346, 4917.483664215206, 4917.975410122926, 4924.162892308388, 4956.677815941952, 4967.180415231446], "value": 3649.458091295045, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.7236526467295, 618.8329151129197, 625.7184267079813, 662.129299970539, 671.7514519627739, 11862.822057669131, 12219.327936963464, 12595.370231488434, 12668.936655316722, 12673.556425525108, 12057.698557536067, 12368.443420046096, 12387.380630968439, 12388.690282742937, 12468.25190488569, 592.0911400999445, 730.7880714592761, 736.3851184261122, 737.1927739125649, 738.7377480994223, 598.3657323237361, 723.5080145501057, 741.3550211316162, 743.3124359967036, 749.3031480722925, 782.2607635784186, 784.3920961255044, 784.8194915169514, 784.8626490364192, 784.8979632647748, 607.4897086447361, 626.7774939896317, 777.9611019449034, 778.4628606261718, 778.5640041576706, 549.7388740348302, 564.2185572981409, 567.0105665613531, 568.088218409451, 568.8464114689011, 11954.940225298906, 11975.520979160823, 11980.10149238802, 11987.220830646067, 12017.699557511045, 11539.249948753304, 11857.703557411047, 11925.40372981356, 12113.33376664283, 12474.251544907243, 11422.771544569145, 11568.074554035657, 11615.593454229062, 11665.24175928562, 11803.586874459354, 3824.2160357126722, 3942.8817135485983, 4008.979955100235, 4024.577419370953, 4073.735207211522, 65757.67121164412, 65921.340786592, 66034.33965660378, 66052.0, 66158.3384166157, 9881.25890558211, 9963.551640176065, 10061.094501494901, 10123.797524049625, 10325.84511232332, 18725.25098996025, 18739.344122955903, 18805.247790088517, 18828.0, 18864.434066978014, 5761.48146666802, 5948.196993405922, 6336.936630633727, 6360.459360954371, 6460.676966151674, 3523.489094081344, 3653.287608916289, 3668.174660701321, 3686.64976827201, 3758.755680880734, 2587.573050446693, 2682.5782335362287, 2700.243931699127, 2705.1613999660167, 2724.1418953029734, 480.5506851094238, 486.3920099875156, 493.70624478435275, 496.65482489669336, 503.39592489012597, 417.6863763463889, 443.6229205175575, 463.1824829176506, 471.21777848770876, 505.97976080957085, 6775.457963362919, 6915.676062497447, 6916.308369163144, 6936.549124307005, 7255.419566434673, 431.7754767520872, 452.9456465224194, 455.8131166221833, 458.0998338265258, 484.9515048495122, 3531.841067151984, 3635.1820840311248, 3720.739548231652, 3733.8879833605033, 3751.6998640108727, 57126.42873571294, 57257.42742572521, 57281.42718572844, 79376.20623793804, 105157.0, 55308.44691553033, 65000.0, 85376.0, 86137.0, 91304.54347728219, 79814.60092699615, 80157.59921200357, 81142.0, 82037.0, 83104.0, 6969.512134150561, 6991.965040174767, 7108.786736397917, 7184.9640751798, 7317.817054573678, 38970.805145975224, 39397.80301098476, 39829.20341593094, 47113.764431179, 49207.26189107095, 38618.42072368973, 41614.58385416107, 60001.39998600133, 60078.39921600728, 61093.38906611055, 10320.380777153396, 10365.481725913523, 10504.0, 10606.575736970743, 10815.297005694605, 10583.241378624829, 10801.0, 11174.441277935908, 11438.771224575295, 11559.942200288944, 10336.276460647983, 10865.728356790827, 10905.945470272598, 11645.59240426581, 11903.0, 10435.113015393474, 10507.94746026265, 10916.672499825017, 11058.170637202404, 11110.722231944266, 11223.102151827998, 11481.425928703698, 11497.137714671266, 11955.76088478243, 11972.042236620875, 8614.18165274298, 8863.290936725176, 8876.644934202559, 8947.821043578962, 8948.463092214488, 8234.917650823654, 8921.643134274556, 9143.359964802667, 9625.229981601315, 9759.316847820584], "value": 6104.740191342362, "unit": "score"}], "name": "dromaeo_css", "value": 6035.81911525826, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0, 115.0, 116.0, 115.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 123.0, 126.0, 170.0, 123.0, 129.0, 125.0, 122.0, 157.0, 124.0], "value": 135.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 162.0, 163.0, 163.0, 163.0, 163.0, 162.0, 162.0, 162.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 75.0, 76.0, 105.0, 76.0, 77.0, 80.0, 78.0, 101.0, 77.0], "value": 82.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 114.0, 84.0, 83.0, 84.0, 108.0, 83.0, 84.0, 110.0], "value": 91.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 146.0, 146.0, 149.0, 149.0, 146.0, 147.0, 146.0, 146.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0, 96.0, 97.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 63.0, 65.0, 66.0, 65.0, 65.0, 66.0, 65.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 67.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 65.0], "value": 65.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 83.0, 86.0, 83.0, 82.0, 88.0, 86.0, 92.0, 82.0, 82.0], "value": 84.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 132.0, 133.0, 132.0, 130.0, 130.0, 131.0, 132.0, 183.0, 132.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [178.0, 176.0, 175.0, 173.0, 175.0, 177.0, 178.0, 171.0, 174.0, 174.0], "value": 175.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 70.0, 69.0, 73.0, 73.0, 69.0, 68.0, 69.0, 68.0, 67.0], "value": 69.6, "unit": "score"}], "name": "kraken", "value": 1544.7999999999997, "alertThreshold": 2.0}]} 04:51:54 INFO - Return code: 0 04:51:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:51:54 INFO - # TBPL SUCCESS # 04:51:54 INFO - Running post-action listener: _resource_record_post_action 04:51:54 INFO - [mozharness: 2016-09-17 11:51:54.805070Z] Finished run-tests step (success) 04:51:54 INFO - Running post-run listener: _resource_record_post_run 04:51:54 INFO - Total resource usage - Wall time: 1204s; CPU: 13.0%; Read bytes: 0; Write bytes: 401928192; Read time: 0; Write time: 343108 04:51:54 INFO - TinderboxPrint: CPU usage
13.1% 04:51:54 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:51:54 INFO - TinderboxPrint: I/O write bytes / time
401,928,192 / 343,108 04:51:54 INFO - TinderboxPrint: CPU idle
8,348.2 (86.9%) 04:51:54 INFO - TinderboxPrint: CPU user
1,204.6 (12.5%) 04:51:54 INFO - TinderboxPrint: Swap in / out
0 / 0 04:51:54 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99741696; Read time: 0; Write time: 119056 04:51:54 INFO - run-tests - Wall time: 1188s; CPU: 13.0%; Read bytes: 0; Write bytes: 290762752; Read time: 0; Write time: 220668 04:51:55 INFO - Running post-run listener: _upload_blobber_files 04:51:55 INFO - Blob upload gear active. 04:51:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:51:55 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 04:51:55 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:51:55 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:51:55 INFO - (blobuploader) - INFO - Open directory for files ... 04:51:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:51:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:51:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:51:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:51:58 INFO - (blobuploader) - INFO - Done attempting. 04:51:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:51:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:51:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:01 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:52:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:01 INFO - (blobuploader) - INFO - Done attempting. 04:52:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:52:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:52:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:52:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:52:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:52:02 INFO - (blobuploader) - INFO - Done attempting. 04:52:02 INFO - (blobuploader) - INFO - Iteration through files over. 04:52:02 INFO - Return code: 0 04:52:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:52:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:52:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e7539ed63f815c571ba6f13b68d262c765fa32071acba43bc2f9ec1c569cae30ce8d1e80aa53c596b8153a9d6e3a9faa43aba38d9eb0e134944e346dca7802d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/571538cbe46418633e17bac40cd5ace6adc474b0a34b961343bc557890491a3eb34a6244fbfc8e4ee11238de29e18990c4bed846fc92c0d02fa43df09aa7d3bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f1afd550f5aea9778e60709cc3c586312f6195903c034d3ff12a1f7417f1c5c2624a954700fe8449e2f1c6831e6ec67f1b8bd2cb07e260db551275f8343f5df3"} 04:52:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:52:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:52:02 INFO - Contents: 04:52:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e7539ed63f815c571ba6f13b68d262c765fa32071acba43bc2f9ec1c569cae30ce8d1e80aa53c596b8153a9d6e3a9faa43aba38d9eb0e134944e346dca7802d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/571538cbe46418633e17bac40cd5ace6adc474b0a34b961343bc557890491a3eb34a6244fbfc8e4ee11238de29e18990c4bed846fc92c0d02fa43df09aa7d3bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f1afd550f5aea9778e60709cc3c586312f6195903c034d3ff12a1f7417f1c5c2624a954700fe8449e2f1c6831e6ec67f1b8bd2cb07e260db551275f8343f5df3"} 04:52:02 INFO - Running post-run listener: copy_logs_to_upload_dir 04:52:02 INFO - Copying logs to upload dir... 04:52:02 INFO - mkdir: /builds/slave/test/build/upload/logs 04:52:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1250.432000 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 50 secs) (at 2016-09-17 04:52:00.918890) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 04:52:00.923219) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e7539ed63f815c571ba6f13b68d262c765fa32071acba43bc2f9ec1c569cae30ce8d1e80aa53c596b8153a9d6e3a9faa43aba38d9eb0e134944e346dca7802d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/571538cbe46418633e17bac40cd5ace6adc474b0a34b961343bc557890491a3eb34a6244fbfc8e4ee11238de29e18990c4bed846fc92c0d02fa43df09aa7d3bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f1afd550f5aea9778e60709cc3c586312f6195903c034d3ff12a1f7417f1c5c2624a954700fe8449e2f1c6831e6ec67f1b8bd2cb07e260db551275f8343f5df3"} build_url:https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011228 build_url: 'https://queue.taskcluster.net/v1/task/RkgMWyVeRImipmiyCHtujw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/6e7539ed63f815c571ba6f13b68d262c765fa32071acba43bc2f9ec1c569cae30ce8d1e80aa53c596b8153a9d6e3a9faa43aba38d9eb0e134944e346dca7802d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/571538cbe46418633e17bac40cd5ace6adc474b0a34b961343bc557890491a3eb34a6244fbfc8e4ee11238de29e18990c4bed846fc92c0d02fa43df09aa7d3bc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f1afd550f5aea9778e60709cc3c586312f6195903c034d3ff12a1f7417f1c5c2624a954700fe8449e2f1c6831e6ec67f1b8bd2cb07e260db551275f8343f5df3"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-17 04:52:00.955949) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 04:52:00.956546) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=516f8d7ca085b4d087ab0a71000001a4-1474111649.583988-1168980084 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004482 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-17 04:52:01.039977) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 04:52:01.040564) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-17 04:52:01.041116) ========= ========= Total master_lag: 0.19 =========