builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-038 starttime: 1474327879.49 results: success (0) buildid: 20160919153516 builduid: f292a2fc449f4d0e9dd1c8a47307b5f5 revision: 5ef7111ff596959cc54653f2eec975b249ab7775 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:19.486796) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:19.491670) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:19.492404) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:19.508173) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:19.508532) ========= 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=8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-19 16:31:19-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 23.8M=0s 2016-09-19 16:31:19 (23.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.130050 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:19.651844) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:19.652213) ========= 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=8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018015 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:19.708092) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:19.708509) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5ef7111ff596959cc54653f2eec975b249ab7775 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5ef7111ff596959cc54653f2eec975b249ab7775 --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=8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-19 16:31:19,907 truncating revision to first 12 chars 2016-09-19 16:31:19,907 Setting DEBUG logging. 2016-09-19 16:31:19,907 attempt 1/10 2016-09-19 16:31:19,907 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5ef7111ff596?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-19 16:31:20,210 unpacking tar archive at: mozilla-central-5ef7111ff596/testing/mozharness/ program finished with exit code 0 elapsedTime=0.652621 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:20.389975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:20.390380) ========= script_repo_revision: 5ef7111ff596959cc54653f2eec975b249ab7775 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:20.390841) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:20.391207) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 16:31:20.405449) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-19 16:31:20.405767) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:31:20 INFO - MultiFileLogger online at 20160919 16:31:20 in /builds/slave/test 16:31:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 16:31:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:20 INFO - {'append_to_log': False, 16:31:20 INFO - 'base_work_dir': '/builds/slave/test', 16:31:20 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:31:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:20 INFO - 'branch': 'Firefox-Non-PGO', 16:31:20 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:20 INFO - 'config_files': ('talos/linux_config.py',), 16:31:20 INFO - 'default_actions': ('clobber', 16:31:20 INFO - 'read-buildbot-config', 16:31:20 INFO - 'download-and-extract', 16:31:20 INFO - 'populate-webroot', 16:31:20 INFO - 'create-virtualenv', 16:31:20 INFO - 'install', 16:31:20 INFO - 'run-tests'), 16:31:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:20 INFO - 'download_minidump_stackwalk': True, 16:31:20 INFO - 'download_symbols': 'ondemand', 16:31:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:20 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:20 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:20 INFO - 'installer_path': 'installer.exe', 16:31:20 INFO - 'log_level': 'info', 16:31:20 INFO - 'log_name': 'talos', 16:31:20 INFO - 'log_to_console': True, 16:31:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:31:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:31:20 INFO - 'opt_config_files': (), 16:31:20 INFO - 'pip_index': False, 16:31:20 INFO - 'sps_profile': False, 16:31:20 INFO - 'sps_profile_interval': 0, 16:31:20 INFO - 'suite': 'dromaeojs', 16:31:20 INFO - 'system_bits': '32', 16:31:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:20 INFO - 'title': 'talos-linux64-ix-038', 16:31:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:20 INFO - 'use_talos_json': True, 16:31:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:20 INFO - 'work_dir': 'build'} 16:31:20 INFO - [mozharness: 2016-09-19 23:31:20.693746Z] Running clobber step. 16:31:20 INFO - Running pre-action listener: _resource_record_pre_action 16:31:20 INFO - Running main action method: clobber 16:31:20 INFO - rmtree: /builds/slave/test/build 16:31:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:21 INFO - Running post-action listener: _resource_record_post_action 16:31:21 INFO - [mozharness: 2016-09-19 23:31:21.156403Z] Finished clobber step (success) 16:31:21 INFO - [mozharness: 2016-09-19 23:31:21.156504Z] Running read-buildbot-config step. 16:31:21 INFO - Running pre-action listener: _resource_record_pre_action 16:31:21 INFO - Running main action method: read_buildbot_config 16:31:21 INFO - Using buildbot properties: 16:31:21 INFO - { 16:31:21 INFO - "project": "", 16:31:21 INFO - "product": "firefox", 16:31:21 INFO - "script_repo_revision": "production", 16:31:21 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:31:21 INFO - "repository": "", 16:31:21 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:31:21 INFO - "buildid": "20160919153516", 16:31:21 INFO - "pgo_build": "False", 16:31:21 INFO - "basedir": "/builds/slave/test", 16:31:21 INFO - "buildnumber": 212, 16:31:21 INFO - "slavename": "talos-linux64-ix-038", 16:31:21 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:31:21 INFO - "platform": "ubuntu64_hw", 16:31:21 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:31:21 INFO - "branch": "mozilla-central", 16:31:21 INFO - "repo_path": "mozilla-central", 16:31:21 INFO - "revision": "5ef7111ff596959cc54653f2eec975b249ab7775", 16:31:21 INFO - "stage_platform": "linux64", 16:31:21 INFO - "builduid": "f292a2fc449f4d0e9dd1c8a47307b5f5", 16:31:21 INFO - "slavebuilddir": "test" 16:31:21 INFO - } 16:31:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:31:21 INFO - Running post-action listener: _resource_record_post_action 16:31:21 INFO - [mozharness: 2016-09-19 23:31:21.158985Z] Finished read-buildbot-config step (success) 16:31:21 INFO - [mozharness: 2016-09-19 23:31:21.159072Z] Running download-and-extract step. 16:31:21 INFO - Running pre-action listener: _resource_record_pre_action 16:31:21 INFO - Running main action method: download_and_extract 16:31:21 INFO - mkdir: /builds/slave/test/build/tests 16:31:21 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')]} 16:31:21 INFO - trying https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:31:21 INFO - Downloading https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:31:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 16:31:21 INFO - Downloaded 1361 bytes. 16:31:21 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:31:21 INFO - Using the following test package requirements: 16:31:21 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:31:21 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:31:21 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:31:21 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:21 INFO - u'jsshell-linux-x86_64.zip'], 16:31:21 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:31:21 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:31:21 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:31:21 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:31:21 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:31:21 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:21 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:31:21 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:31:21 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:31:21 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:31:21 INFO - Fetch https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:31:22 INFO - Expected file size: 20364976 16:31:26 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:31:26 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:31:26 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:31:26 INFO - Fetch https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:31:27 INFO - Expected file size: 20364976 16:31:31 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:31 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:31:31 INFO - Fetch https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:31:32 INFO - Expected file size: 14414059 16:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:33 INFO - trying https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:31:33 INFO - Downloading https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:31:35 INFO - Downloaded 55599175 bytes. 16:31:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:31:35 INFO - mkdir: /builds/slave/test/properties 16:31:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:35 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:35 INFO - Contents: 16:31:35 INFO - build_url:https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:31:36 INFO - Running post-action listener: _resource_record_post_action 16:31:36 INFO - Running post-action listener: set_extra_try_arguments 16:31:36 INFO - [mozharness: 2016-09-19 23:31:36.153196Z] Finished download-and-extract step (success) 16:31:36 INFO - [mozharness: 2016-09-19 23:31:36.153500Z] Running populate-webroot step. 16:31:36 INFO - Running pre-action listener: _resource_record_pre_action 16:31:36 INFO - Running main action method: populate_webroot 16:31:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:36 INFO - '--tppagecycles', 16:31:36 INFO - '7'], 16:31:36 INFO - 'tests': ['tsvgm']}}, 16:31:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:31:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:31:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:31:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:31:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:31:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:36 INFO - 'talos_options': ['--disable-e10s'], 16:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:36 INFO - 'talos_options': ['--disable-e10s'], 16:31:36 INFO - 'tests': ['damp', 'tps']}, 16:31:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:36 INFO - 'tests': ['damp', 'tps']}, 16:31:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:31:36 INFO - 'tests': ['dromaeo_dom']}, 16:31:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:31:36 INFO - 'tests': ['basic_compositor_video']}, 16:31:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:31:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:31:36 INFO - 'tests': ['a11yr', 16:31:36 INFO - 'ts_paint', 16:31:36 INFO - 'tpaint', 16:31:36 INFO - 'sessionrestore', 16:31:36 INFO - 'sessionrestore_no_auto_restore', 16:31:36 INFO - 'tabpaint']}, 16:31:36 INFO - 'other-e10s': {'tests': ['a11yr', 16:31:36 INFO - 'ts_paint', 16:31:36 INFO - 'tpaint', 16:31:36 INFO - 'sessionrestore', 16:31:36 INFO - 'sessionrestore_no_auto_restore', 16:31:36 INFO - 'tabpaint']}, 16:31:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:31:36 INFO - 'ts_paint', 16:31:36 INFO - 'tpaint', 16:31:36 INFO - 'sessionrestore', 16:31:36 INFO - 'sessionrestore_no_auto_restore', 16:31:36 INFO - 'tabpaint']}, 16:31:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:31:36 INFO - 'ts_paint', 16:31:36 INFO - 'tpaint', 16:31:36 INFO - 'sessionrestore', 16:31:36 INFO - 'sessionrestore_no_auto_restore', 16:31:36 INFO - 'tabpaint']}, 16:31:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:31:36 INFO - 'tests': ['a11yr', 16:31:36 INFO - 'ts_paint', 16:31:36 INFO - 'tpaint', 16:31:36 INFO - 'sessionrestore', 16:31:36 INFO - 'sessionrestore_no_auto_restore', 16:31:36 INFO - 'tabpaint']}, 16:31:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:31:36 INFO - 'tests': ['a11yr', 16:31:36 INFO - 'ts_paint', 16:31:36 INFO - 'tpaint', 16:31:36 INFO - 'sessionrestore', 16:31:36 INFO - 'sessionrestore_no_auto_restore', 16:31:36 INFO - 'tabpaint']}, 16:31:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:31:36 INFO - 'tests': ['tsvgx', 16:31:36 INFO - 'tsvgr_opacity', 16:31:36 INFO - 'tart', 16:31:36 INFO - 'tscrollx', 16:31:36 INFO - 'cart']}, 16:31:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:31:36 INFO - 'tsvgr_opacity', 16:31:36 INFO - 'tart', 16:31:36 INFO - 'tscrollx', 16:31:36 INFO - 'cart']}, 16:31:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:36 INFO - 'talos_options': ['--disable-e10s'], 16:31:36 INFO - 'tests': ['tp5o']}, 16:31:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:36 INFO - 'tests': ['tp5o']}, 16:31:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:36 INFO - 'talos_options': ['--disable-e10s', 16:31:36 INFO - '--xperf_path', 16:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:36 INFO - 'tests': ['tp5n']}, 16:31:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:36 INFO - 'talos_options': ['--xperf_path', 16:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:36 INFO - 'tests': ['tp5n']}}, 16:31:36 INFO - 'talos.zip': {'path': '', 16:31:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:36 INFO - Running post-action listener: _resource_record_post_action 16:31:36 INFO - [mozharness: 2016-09-19 23:31:36.170144Z] Finished populate-webroot step (success) 16:31:36 INFO - [mozharness: 2016-09-19 23:31:36.170234Z] Running create-virtualenv step. 16:31:36 INFO - Running pre-action listener: _resource_record_pre_action 16:31:36 INFO - Running main action method: create_virtualenv 16:31:36 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:36 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 16:31:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:36 INFO - Using real prefix '/usr' 16:31:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:36 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:38 INFO - Installing pip.................done. 16:31:38 INFO - Return code: 0 16:31:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31:38 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')]} 16:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:38 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')]} 16:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:38 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 0x7ffe5cfc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180bf60>, '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 0x180cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180d1d0>, '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': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', '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 16:31:38 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 16:31:38 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 16:31:38 INFO - Using env: {'DISPLAY': ':0', 16:31:38 INFO - 'HOME': '/home/cltbld', 16:31:38 INFO - 'LANG': 'en_US.UTF-8', 16:31:38 INFO - 'LANGUAGE': 'en_US:en', 16:31:38 INFO - 'LOGNAME': 'cltbld', 16:31:38 INFO - 'MAIL': '/var/mail/cltbld', 16:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:38 INFO - 'MOZ_NO_REMOTE': '1', 16:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:38 INFO - 'NO_EM_RESTART': '1', 16:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:38 INFO - 'PWD': '/builds/slave/test', 16:31:38 INFO - 'SHELL': '/bin/bash', 16:31:38 INFO - 'SHLVL': '1', 16:31:38 INFO - 'TERM': 'linux', 16:31:38 INFO - 'TMOUT': '86400', 16:31:38 INFO - 'USER': 'cltbld', 16:31:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', 16:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:38 INFO - '_': '/tools/buildbot/bin/python'} 16:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:38 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 16:31:38 INFO - Cleaning up... 16:31:38 INFO - Return code: 0 16:31:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:31:38 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')]} 16:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:38 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')]} 16:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:38 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 0x7ffe5cfc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180bf60>, '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 0x180cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180d1d0>, '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': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', '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 16:31:38 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 16:31:38 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 16:31:38 INFO - Using env: {'DISPLAY': ':0', 16:31:38 INFO - 'HOME': '/home/cltbld', 16:31:38 INFO - 'LANG': 'en_US.UTF-8', 16:31:38 INFO - 'LANGUAGE': 'en_US:en', 16:31:38 INFO - 'LOGNAME': 'cltbld', 16:31:38 INFO - 'MAIL': '/var/mail/cltbld', 16:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:38 INFO - 'MOZ_NO_REMOTE': '1', 16:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:38 INFO - 'NO_EM_RESTART': '1', 16:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:38 INFO - 'PWD': '/builds/slave/test', 16:31:38 INFO - 'SHELL': '/bin/bash', 16:31:38 INFO - 'SHLVL': '1', 16:31:38 INFO - 'TERM': 'linux', 16:31:38 INFO - 'TMOUT': '86400', 16:31:38 INFO - 'USER': 'cltbld', 16:31:38 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', 16:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:38 INFO - '_': '/tools/buildbot/bin/python'} 16:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:39 INFO - Downloading/unpacking psutil>=3.1.1 16: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 16: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 16: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 16: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 16: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 16: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 16:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:41 INFO - Installing collected packages: psutil 16:31:41 INFO - Running setup.py install for psutil 16:31:41 INFO - building 'psutil._psutil_linux' extension 16:31:41 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 16:31:41 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 16:31:41 INFO - building 'psutil._psutil_posix' extension 16:31:41 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 16:31:41 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 16:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:41 INFO - Successfully installed psutil 16:31:41 INFO - Cleaning up... 16:31:41 INFO - Return code: 0 16:31:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffe5cfc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180bf60>, '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 0x180cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180d1d0>, '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': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', '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 16:31:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 16:31:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 16:31:41 INFO - Using env: {'DISPLAY': ':0', 16:31:41 INFO - 'HOME': '/home/cltbld', 16:31:41 INFO - 'LANG': 'en_US.UTF-8', 16:31:41 INFO - 'LANGUAGE': 'en_US:en', 16:31:41 INFO - 'LOGNAME': 'cltbld', 16:31:41 INFO - 'MAIL': '/var/mail/cltbld', 16:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:41 INFO - 'MOZ_NO_REMOTE': '1', 16:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:41 INFO - 'NO_EM_RESTART': '1', 16:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:41 INFO - 'PWD': '/builds/slave/test', 16:31:41 INFO - 'SHELL': '/bin/bash', 16:31:41 INFO - 'SHLVL': '1', 16:31:41 INFO - 'TERM': 'linux', 16:31:41 INFO - 'TMOUT': '86400', 16:31:41 INFO - 'USER': 'cltbld', 16:31:41 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', 16:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:41 INFO - '_': '/tools/buildbot/bin/python'} 16:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 16: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 16: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 16: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 16: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 16: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 16: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 16:31:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:31:43 INFO - Installing collected packages: mozsystemmonitor 16:31:43 INFO - Running setup.py install for mozsystemmonitor 16:31:43 INFO - Successfully installed mozsystemmonitor 16:31:44 INFO - Cleaning up... 16:31:44 INFO - Return code: 0 16:31:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:44 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 0x7ffe5cfc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180bf60>, '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 0x180cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180d1d0>, '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': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', '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 16:31:44 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 16:31:44 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 16:31:44 INFO - Using env: {'DISPLAY': ':0', 16:31:44 INFO - 'HOME': '/home/cltbld', 16:31:44 INFO - 'LANG': 'en_US.UTF-8', 16:31:44 INFO - 'LANGUAGE': 'en_US:en', 16:31:44 INFO - 'LOGNAME': 'cltbld', 16:31:44 INFO - 'MAIL': '/var/mail/cltbld', 16:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:44 INFO - 'MOZ_NO_REMOTE': '1', 16:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:44 INFO - 'NO_EM_RESTART': '1', 16:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:44 INFO - 'PWD': '/builds/slave/test', 16:31:44 INFO - 'SHELL': '/bin/bash', 16:31:44 INFO - 'SHLVL': '1', 16:31:44 INFO - 'TERM': 'linux', 16:31:44 INFO - 'TMOUT': '86400', 16:31:44 INFO - 'USER': 'cltbld', 16:31:44 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', 16:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:44 INFO - '_': '/tools/buildbot/bin/python'} 16:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:44 INFO - Downloading/unpacking jsonschema==2.5.1 16:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:31:46 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 16:31:46 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 16:31:46 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 16:31:46 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 16:31:46 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 16:31:46 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 16:31:46 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:46 INFO - warning: no files found matching '*.txt' 16:31:46 INFO - no previously-included directories found matching 'build' 16:31:46 INFO - no previously-included directories found matching 'dist' 16:31:46 INFO - no previously-included directories found matching '.git*' 16:31:46 INFO - Installing collected packages: jsonschema, functools32 16:31:46 INFO - Running setup.py install for functools32 16:31:46 INFO - warning: no files found matching '*.txt' 16:31:46 INFO - no previously-included directories found matching 'build' 16:31:46 INFO - no previously-included directories found matching 'dist' 16:31:46 INFO - no previously-included directories found matching '.git*' 16:31:46 INFO - Successfully installed jsonschema functools32 16:31:46 INFO - Cleaning up... 16:31:46 INFO - Return code: 0 16:31:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:46 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 0x7ffe5cfc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180bf60>, '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 0x180cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180d1d0>, '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': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', '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 16:31:46 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 16:31:46 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 16:31:46 INFO - Using env: {'DISPLAY': ':0', 16:31:46 INFO - 'HOME': '/home/cltbld', 16:31:46 INFO - 'LANG': 'en_US.UTF-8', 16:31:46 INFO - 'LANGUAGE': 'en_US:en', 16:31:46 INFO - 'LOGNAME': 'cltbld', 16:31:46 INFO - 'MAIL': '/var/mail/cltbld', 16:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:46 INFO - 'MOZ_NO_REMOTE': '1', 16:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:46 INFO - 'NO_EM_RESTART': '1', 16:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:46 INFO - 'PWD': '/builds/slave/test', 16:31:46 INFO - 'SHELL': '/bin/bash', 16:31:46 INFO - 'SHLVL': '1', 16:31:46 INFO - 'TERM': 'linux', 16:31:46 INFO - 'TMOUT': '86400', 16:31:46 INFO - 'USER': 'cltbld', 16:31:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', 16:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:46 INFO - '_': '/tools/buildbot/bin/python'} 16:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:31:46 INFO - Cleaning up... 16:31:46 INFO - Return code: 0 16:31:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16: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')]} 16:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:46 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 0x7ffe5cfc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180bf60>, '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 0x180cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180d1d0>, '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': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', '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 16:31:46 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 16:31:46 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 16:31:46 INFO - Using env: {'DISPLAY': ':0', 16:31:46 INFO - 'HOME': '/home/cltbld', 16:31:46 INFO - 'LANG': 'en_US.UTF-8', 16:31:46 INFO - 'LANGUAGE': 'en_US:en', 16:31:46 INFO - 'LOGNAME': 'cltbld', 16:31:46 INFO - 'MAIL': '/var/mail/cltbld', 16:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:46 INFO - 'MOZ_NO_REMOTE': '1', 16:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:46 INFO - 'NO_EM_RESTART': '1', 16:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:46 INFO - 'PWD': '/builds/slave/test', 16:31:46 INFO - 'SHELL': '/bin/bash', 16:31:46 INFO - 'SHLVL': '1', 16:31:46 INFO - 'TERM': 'linux', 16:31:46 INFO - 'TMOUT': '86400', 16:31:46 INFO - 'USER': 'cltbld', 16:31:46 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', 16:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:46 INFO - '_': '/tools/buildbot/bin/python'} 16:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:47 INFO - Downloading/unpacking blobuploader==1.2.4 16: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 16: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 16: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 16: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 16: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 16: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 16:31:48 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31:49 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 16:31:49 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 16:31:49 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 16:31:49 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 16:31:49 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 16:31:49 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 16:31:49 INFO - Downloading docopt-0.6.1.tar.gz 16:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:49 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:49 INFO - Running setup.py install for blobuploader 16:31:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:49 INFO - Running setup.py install for requests 16:31:50 INFO - Running setup.py install for docopt 16:31:50 INFO - Successfully installed blobuploader requests docopt 16:31:50 INFO - Cleaning up... 16:31:50 INFO - Return code: 0 16:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16: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')]} 16:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16: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')]} 16:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:50 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 0x7ffe5cfc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180bf60>, '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 0x180cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180d1d0>, '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': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', '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 16:31:50 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 16:31:50 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 16:31:50 INFO - Using env: {'DISPLAY': ':0', 16:31:50 INFO - 'HOME': '/home/cltbld', 16:31:50 INFO - 'LANG': 'en_US.UTF-8', 16:31:50 INFO - 'LANGUAGE': 'en_US:en', 16:31:50 INFO - 'LOGNAME': 'cltbld', 16:31:50 INFO - 'MAIL': '/var/mail/cltbld', 16:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:50 INFO - 'MOZ_NO_REMOTE': '1', 16:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:50 INFO - 'NO_EM_RESTART': '1', 16:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:50 INFO - 'PWD': '/builds/slave/test', 16:31:50 INFO - 'SHELL': '/bin/bash', 16:31:50 INFO - 'SHLVL': '1', 16:31:50 INFO - 'TERM': 'linux', 16:31:50 INFO - 'TMOUT': '86400', 16:31:50 INFO - 'USER': 'cltbld', 16:31:50 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', 16:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:50 INFO - '_': '/tools/buildbot/bin/python'} 16:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:50 INFO - Running setup.py (path:/tmp/pip-NnUlJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:50 INFO - Running setup.py (path:/tmp/pip-aMx36x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:50 INFO - Running setup.py (path:/tmp/pip-daBQfi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:50 INFO - Running setup.py (path:/tmp/pip-Bu_po9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:50 INFO - Running setup.py (path:/tmp/pip-6H5Iqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:50 INFO - Running setup.py (path:/tmp/pip-bEOw27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:50 INFO - Running setup.py (path:/tmp/pip-k55rF3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:51 INFO - Running setup.py (path:/tmp/pip-mReped-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:51 INFO - Running setup.py (path:/tmp/pip-tnUBq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:51 INFO - Running setup.py (path:/tmp/pip-39iu4o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:51 INFO - Running setup.py (path:/tmp/pip-q79J51-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:51 INFO - Running setup.py (path:/tmp/pip-Txoaft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:51 INFO - Running setup.py (path:/tmp/pip-AswreE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:51 INFO - Running setup.py (path:/tmp/pip-EChFRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:51 INFO - Running setup.py (path:/tmp/pip-fwA9y5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:51 INFO - Running setup.py (path:/tmp/pip-1Xcuh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:51 INFO - Running setup.py (path:/tmp/pip-7XJJzG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:51 INFO - Running setup.py install for manifestparser 16:31:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:51 INFO - Running setup.py install for mozcrash 16:31:51 INFO - Running setup.py install for mozdebug 16:31:52 INFO - Running setup.py install for mozdevice 16:31:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:52 INFO - Running setup.py install for mozfile 16:31:52 INFO - Running setup.py install for mozhttpd 16:31:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:52 INFO - Running setup.py install for mozinfo 16:31:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:52 INFO - Running setup.py install for mozInstall 16:31:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:52 INFO - Running setup.py install for mozleak 16:31:52 INFO - Running setup.py install for mozlog 16:31:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:52 INFO - Running setup.py install for moznetwork 16:31:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:52 INFO - Running setup.py install for mozprocess 16:31:52 INFO - Running setup.py install for mozprofile 16:31:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Running setup.py install for mozrunner 16:31:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Running setup.py install for mozscreenshot 16:31:53 INFO - Running setup.py install for moztest 16:31:53 INFO - Running setup.py install for mozversion 16:31:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:53 INFO - Cleaning up... 16:31:53 INFO - Return code: 0 16:31:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:53 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')]} 16:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:53 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')]} 16:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:53 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 0x7ffe5cfc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180bf60>, '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 0x180cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180d1d0>, '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': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', '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 16:31:53 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 16:31:53 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 16:31:53 INFO - Using env: {'DISPLAY': ':0', 16:31:53 INFO - 'HOME': '/home/cltbld', 16:31:53 INFO - 'LANG': 'en_US.UTF-8', 16:31:53 INFO - 'LANGUAGE': 'en_US:en', 16:31:53 INFO - 'LOGNAME': 'cltbld', 16:31:53 INFO - 'MAIL': '/var/mail/cltbld', 16:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:53 INFO - 'MOZ_NO_REMOTE': '1', 16:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:53 INFO - 'NO_EM_RESTART': '1', 16:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:53 INFO - 'PWD': '/builds/slave/test', 16:31:53 INFO - 'SHELL': '/bin/bash', 16:31:53 INFO - 'SHLVL': '1', 16:31:53 INFO - 'TERM': 'linux', 16:31:53 INFO - 'TMOUT': '86400', 16:31:53 INFO - 'USER': 'cltbld', 16:31:53 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', 16:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:53 INFO - '_': '/tools/buildbot/bin/python'} 16:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:53 INFO - Running setup.py (path:/tmp/pip-J9IqXs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:53 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)) 16:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:53 INFO - Running setup.py (path:/tmp/pip-HymPgx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:53 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)) 16:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:53 INFO - Running setup.py (path:/tmp/pip-xm61gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:53 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)) 16:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:53 INFO - Running setup.py (path:/tmp/pip-ZjttnM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:54 INFO - Running setup.py (path:/tmp/pip-qt7jFu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:54 INFO - Running setup.py (path:/tmp/pip-kinylU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:54 INFO - Running setup.py (path:/tmp/pip-6yHjSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:54 INFO - Running setup.py (path:/tmp/pip-S9guo5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:54 INFO - Running setup.py (path:/tmp/pip-EZeVJu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:54 INFO - Running setup.py (path:/tmp/pip-TDnYUO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:54 INFO - Running setup.py (path:/tmp/pip-QlpHJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:54 INFO - Running setup.py (path:/tmp/pip-0lKYVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:54 INFO - Running setup.py (path:/tmp/pip-s4Nby0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:54 INFO - Running setup.py (path:/tmp/pip-7J_NUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:54 INFO - Running setup.py (path:/tmp/pip-ATWQnB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:54 INFO - Running setup.py (path:/tmp/pip-UTo4T0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:54 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)) 16:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:54 INFO - Running setup.py (path:/tmp/pip-Qj4AK1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:55 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)) 16:31:55 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)) 16:31:55 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)) 16:31:55 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)) 16:31:55 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)) 16:31:55 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)) 16:31:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31:55 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 16:31:55 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 16:31:55 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 16:31:55 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 16:31:55 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 16:31:55 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 16:31:56 INFO - Downloading blessings-1.6.tar.gz 16:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:57 INFO - Installing collected packages: blessings 16:31:57 INFO - Running setup.py install for blessings 16:31:57 INFO - Successfully installed blessings 16:31:57 INFO - Cleaning up... 16:31:57 INFO - Return code: 0 16:31:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:57 INFO - Reading from file tmpfile_stdout 16:31:57 INFO - Current package versions: 16:31:57 INFO - argparse == 1.2.1 16:31:57 INFO - blessings == 1.6 16:31:57 INFO - blobuploader == 1.2.4 16:31:57 INFO - docopt == 0.6.1 16:31:57 INFO - functools32 == 3.2.3-2 16:31:57 INFO - jsonschema == 2.5.1 16:31:57 INFO - manifestparser == 1.1 16:31:57 INFO - mozInstall == 1.12 16:31:57 INFO - mozcrash == 0.17 16:31:57 INFO - mozdebug == 0.1 16:31:57 INFO - mozdevice == 0.48 16:31:57 INFO - mozfile == 1.2 16:31:57 INFO - mozhttpd == 0.7 16:31:57 INFO - mozinfo == 0.9 16:31:57 INFO - mozleak == 0.1 16:31:57 INFO - mozlog == 3.4 16:31:57 INFO - moznetwork == 0.27 16:31:57 INFO - mozprocess == 0.23 16:31:57 INFO - mozprofile == 0.28 16:31:57 INFO - mozrunner == 6.12 16:31:57 INFO - mozscreenshot == 0.1 16:31:57 INFO - mozsystemmonitor == 0.3 16:31:57 INFO - moztest == 0.7 16:31:57 INFO - mozversion == 1.4 16:31:57 INFO - psutil == 3.1.1 16:31:57 INFO - requests == 1.2.3 16:31:57 INFO - wsgiref == 0.1.2 16:31:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:57 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')]} 16:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:57 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')]} 16:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:57 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 0x7ffe5cfc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180bf60>, '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 0x180cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180d1d0>, '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': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', '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 16:31:57 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 16:31:57 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 16:31:57 INFO - Using env: {'DISPLAY': ':0', 16:31:57 INFO - 'HOME': '/home/cltbld', 16:31:57 INFO - 'LANG': 'en_US.UTF-8', 16:31:57 INFO - 'LANGUAGE': 'en_US:en', 16:31:57 INFO - 'LOGNAME': 'cltbld', 16:31:57 INFO - 'MAIL': '/var/mail/cltbld', 16:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:57 INFO - 'MOZ_NO_REMOTE': '1', 16:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:57 INFO - 'NO_EM_RESTART': '1', 16:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:57 INFO - 'PWD': '/builds/slave/test', 16:31:57 INFO - 'SHELL': '/bin/bash', 16:31:57 INFO - 'SHLVL': '1', 16:31:57 INFO - 'TERM': 'linux', 16:31:57 INFO - 'TMOUT': '86400', 16:31:57 INFO - 'USER': 'cltbld', 16:31:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', 16:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:57 INFO - '_': '/tools/buildbot/bin/python'} 16:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:57 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)) 16:31:57 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)) 16:31:57 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)) 16:31:57 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)) 16:31:57 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)) 16:31:57 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)) 16:31:57 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)) 16:31:57 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)) 16:31:57 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)) 16:31:57 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)) 16:31:57 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)) 16:31:57 INFO - Cleaning up... 16:31:57 INFO - Return code: 0 16:31:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:31:57 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')]} 16:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:57 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')]} 16:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:57 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 0x7ffe5cfc7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x17418a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x180eca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x180bf60>, '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 0x180cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180d1d0>, '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': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', '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 16:31:57 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 16:31:57 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 16:31:57 INFO - Using env: {'DISPLAY': ':0', 16:31:57 INFO - 'HOME': '/home/cltbld', 16:31:57 INFO - 'LANG': 'en_US.UTF-8', 16:31:57 INFO - 'LANGUAGE': 'en_US:en', 16:31:57 INFO - 'LOGNAME': 'cltbld', 16:31:57 INFO - 'MAIL': '/var/mail/cltbld', 16:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:57 INFO - 'MOZ_NO_REMOTE': '1', 16:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:57 INFO - 'NO_EM_RESTART': '1', 16:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:57 INFO - 'PWD': '/builds/slave/test', 16:31:57 INFO - 'SHELL': '/bin/bash', 16:31:57 INFO - 'SHLVL': '1', 16:31:57 INFO - 'TERM': 'linux', 16:31:57 INFO - 'TMOUT': '86400', 16:31:57 INFO - 'USER': 'cltbld', 16:31:57 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', 16:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:57 INFO - '_': '/tools/buildbot/bin/python'} 16:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:31:57 INFO - Cleaning up... 16:31:57 INFO - Return code: 0 16:31:57 INFO - Running post-action listener: _resource_record_post_action 16:31:57 INFO - Running post-action listener: _start_resource_monitoring 16:31:57 INFO - Starting resource monitoring. 16:31:57 INFO - [mozharness: 2016-09-19 23:31:57.858206Z] Finished create-virtualenv step (success) 16:31:57 INFO - [mozharness: 2016-09-19 23:31:57.858710Z] Running install step. 16:31:57 INFO - Running pre-action listener: _resource_record_pre_action 16:31:57 INFO - Running main action method: install 16:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:58 INFO - Reading from file tmpfile_stdout 16:31:58 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:58 INFO - Reading from file tmpfile_stdout 16:31:58 INFO - Output received: 16:31:58 INFO - Usage: mozinstall [options] installer 16:31:58 INFO - Options: 16:31:58 INFO - -h, --help show this help message and exit 16:31:58 INFO - -d DEST, --destination=DEST 16:31:58 INFO - Directory to install application into. [default: 16:31:58 INFO - "/builds/slave/test"] 16:31:58 INFO - --app=APP Application being installed. [default: firefox] 16:31:58 INFO - mkdir: /builds/slave/test/build/application 16:31:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:32:14 INFO - Reading from file tmpfile_stdout 16:32:14 INFO - Output received: 16:32:14 INFO - /builds/slave/test/build/application/firefox/firefox 16:32:14 INFO - Running post-action listener: _resource_record_post_action 16:32:14 INFO - [mozharness: 2016-09-19 23:32:14.216783Z] Finished install step (success) 16:32:14 INFO - [mozharness: 2016-09-19 23:32:14.217453Z] Running run-tests step. 16:32:14 INFO - Running pre-action listener: _resource_record_pre_action 16:32:14 INFO - Running main action method: run_tests 16:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:32:14 INFO - Python 2.7.3 16:32:14 INFO - Return code: 0 16:32:14 INFO - grabbing minidump binary from tooltool 16:32:14 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')]} 16:32:14 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 0x180bf60>, '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 0x180cd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x180d1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:32:14 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 16:32:14 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 16:32:14 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 16:32:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:32:14 INFO - Return code: 0 16:32:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:32:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:32:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:32:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:32:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 16:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-038 --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 16:32:14 INFO - Using env: {'DISPLAY': ':0', 16:32:14 INFO - 'HOME': '/home/cltbld', 16:32:14 INFO - 'LANG': 'en_US.UTF-8', 16:32:14 INFO - 'LANGUAGE': 'en_US:en', 16:32:14 INFO - 'LOGNAME': 'cltbld', 16:32:14 INFO - 'MAIL': '/var/mail/cltbld', 16:32:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:32:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:32:14 INFO - 'MOZ_NO_REMOTE': '1', 16:32:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:32:14 INFO - 'NO_EM_RESTART': '1', 16:32:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:32:14 INFO - 'PWD': '/builds/slave/test', 16:32:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:32:14 INFO - 'SHELL': '/bin/bash', 16:32:14 INFO - 'SHLVL': '1', 16:32:14 INFO - 'TERM': 'linux', 16:32:14 INFO - 'TMOUT': '86400', 16:32:14 INFO - 'USER': 'cltbld', 16:32:14 INFO - 'XDG_SESSION_COOKIE': '8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266', 16:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:32:14 INFO - '_': '/tools/buildbot/bin/python'} 16:32:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-038', '--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 16:32:14 INFO - mozversion application_buildid: 20160919153516 16:32:14 INFO - mozversion application_changeset: 5ef7111ff596959cc54653f2eec975b249ab7775 16:32:14 INFO - mozversion application_display_name: Nightly 16:32:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:32:14 INFO - mozversion application_name: Firefox 16:32:14 INFO - mozversion application_remotingname: firefox 16:32:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:32:14 INFO - mozversion application_vendor: Mozilla 16:32:14 INFO - mozversion application_version: 52.0a1 16:32:14 INFO - mozversion platform_buildid: 20160919153516 16:32:14 INFO - mozversion platform_changeset: 5ef7111ff596959cc54653f2eec975b249ab7775 16:32:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:32:14 INFO - mozversion platform_version: 52.0a1 16:32:14 INFO - using testdate: 1474327934 16:32:14 INFO - actual date: 1474327934 16:32:14 INFO - starting webserver on 'localhost:56697' 16:32:14 INFO - SUITE-START | Running 2 tests 16:32:14 INFO - TEST-START | dromaeo_css 16:32:14 INFO - operating with platform_type : linux_ 16:32:14 INFO - Initialising browser for dromaeo_css test... 16:32:14 INFO - TEST-INFO | started process 25580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0rKgE5/profile http://localhost:56697/getInfo.html) 16:32:19 INFO - PROCESS | 25580 | __metrics Screen width/height:1600/1200 16:32:19 INFO - PROCESS | 25580 | colorDepth:24 16:32:19 INFO - PROCESS | 25580 | Browser inner width/height: 1024/697 16:32:19 INFO - PROCESS | 25580 | __metrics 16:32:20 INFO - PROCESS | 25580 | 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" 16:32:20 INFO - PROCESS | 25580 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:32:20 INFO - PROCESS | 25580 | console.error: PushService: 16:32:20 INFO - PROCESS | 25580 | stateChangeProcessEnqueue: Error transitioning state 16:32:20 INFO - PROCESS | 25580 | UnknownError 16:32:21 INFO - TEST-INFO | 25580: exit 0 16:32:21 INFO - Browser initialized. 16:32:21 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:21 INFO - TEST-INFO | started process 25660 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0rKgE5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:33 INFO - PROCESS | 25660 | RSS: Main: 178946048 16:32:33 INFO - PROCESS | 25660 | 16:32:38 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 16:32:56 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:33:12 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:33:18 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 16:33:25 INFO - PROCESS | 25660 | 1474328005545 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] 16:33:26 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 16:33:28 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:33:36 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 16:33:47 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:33:49 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:33:52 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.18338 seconds. 16:33:56 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 16:34:09 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 16:34:11 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:34:29 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:34:32 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.16671 seconds. 16:34:38 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:34:45 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:34:47 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:34:49 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:34:51 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:34:53 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.1667 seconds. 16:35:03 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:35:11 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:35:15 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:35:22 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.05003 seconds. 16:35:29 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 16:35:34 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 16:35:38 INFO - PROCESS | 25660 | Cycle 1(1): loaded http://localhost:56697/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56697/tests/dromaeo/cssquery-ext.html) 16:35:39 INFO - PROCESS | 25660 | RSS: Main: 303505408 16:35:39 INFO - PROCESS | 25660 | 16:35:52 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:35:54 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:35:56 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:35:58 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:36:00 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:36:08 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:36:11 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:36:12 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:36:22 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:36:25 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:36:31 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:36:33 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:36:35 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:36:42 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:36:43 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:36:51 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 16:37:03 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:37:05 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:37:13 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:37:15 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:37:17 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:37:19 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:37:46 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 16:38:02 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:38:09 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:38:14 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:38:42 INFO - PROCESS | 25660 | Cycle 1(1): loaded http://localhost:56697/tests/dromaeo/cssquery-ext.html (next: http://localhost:56697/tests/dromaeo/cssquery-jquery.html) 16:38:43 INFO - PROCESS | 25660 | RSS: Main: 274989056 16:38:43 INFO - PROCESS | 25660 | 16:38:46 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:39:03 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 16:39:09 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:39:14 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:39:44 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:39:50 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:39:52 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:39:58 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:40:04 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:40:06 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00012 seconds. 16:40:12 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:40:26 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 16:40:28 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:40:42 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:40:48 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:40:50 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:40:53 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:40:55 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:41:03 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:41:05 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:41:07 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:41:09 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:41:11 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:41:14 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:41:17 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 16:41:33 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:41:37 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:41:43 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:41:45 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:41:45 INFO - PROCESS | 25660 | Cycle 1(1): loaded http://localhost:56697/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56697/tests/dromaeo/cssquery-mootools.html) 16:41:46 INFO - PROCESS | 25660 | RSS: Main: 217227264 16:41:46 INFO - PROCESS | 25660 | 16:41:51 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 16:41:53 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.03335 seconds. 16:41:58 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:42:00 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:42:02 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:42:16 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:42:23 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:42:32 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:42:33 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:42:37 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0334 seconds. 16:42:42 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:42:45 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:42:47 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 16:42:49 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:42:51 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:43:01 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:43:04 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:43:12 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.05014 seconds. 16:43:17 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 16:43:21 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:43:25 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:43:59 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:44:02 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:44:07 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:44:12 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:44:29 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:44:30 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 16:44:32 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:44:34 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:44:36 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:44:48 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:44:48 INFO - PROCESS | 25660 | Cycle 1(1): loaded http://localhost:56697/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56697/tests/dromaeo/cssquery-prototype.html) 16:44:49 INFO - PROCESS | 25660 | RSS: Main: 217485312 16:44:49 INFO - PROCESS | 25660 | 16:44:52 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 16:45:04 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:45:12 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:45:13 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:45:26 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.05006 seconds. 16:45:28 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 16:45:30 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:45:46 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:45:52 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 16:46:17 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:46:20 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:46:23 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 16:46:33 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:46:36 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.99996 seconds. 16:46:37 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:46:39 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:46:41 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:46:47 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:46:49 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:46:51 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:47:05 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:47:07 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:47:09 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:47:15 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:47:28 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 16:47:30 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:47:42 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:47:43 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:47:45 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:47:52 INFO - PROCESS | 25660 | Cycle 1(1): loaded http://localhost:56697/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56697/tests/dromaeo/cssquery-yui.html) 16:47:52 INFO - PROCESS | 25660 | RSS: Main: 216883200 16:47:52 INFO - PROCESS | 25660 | 16:47:56 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 16:48:01 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:48:04 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:48:13 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:48:15 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:48:21 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:48:23 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:48:25 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:48:33 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:48:37 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:48:42 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 16:48:47 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:48:49 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:48:57 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:49:00 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:49:02 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1 seconds. 16:49:04 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:49:18 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:49:20 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:49:41 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 16:49:42 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01668 seconds. 16:49:58 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:50:06 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 16:50:25 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 16:50:34 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.05004 seconds. 16:50:38 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.13337 seconds. 16:50:51 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:50:53 INFO - PROCESS | 25660 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:50:55 INFO - PROCESS | 25660 | Cycle 1(1): loaded http://localhost:56697/tests/dromaeo/cssquery-yui.html (next: http://localhost:56697/tests/dromaeo/cssquery-dojo.html) 16:50:55 INFO - PROCESS | 25660 | RSS: Main: 308985856 16:50:55 INFO - PROCESS | 25660 | 16:50:55 INFO - PROCESS | 25660 | __start_tp_report 16:50:55 INFO - PROCESS | 25660 | _x_x_mozilla_page_load 16:50:55 INFO - PROCESS | 25660 | _x_x_mozilla_page_load_details 16:50:55 INFO - PROCESS | 25660 | |i|pagename|runs| 16:50:55 INFO - PROCESS | 25660 | |0;dojo.html;2590.7797837183844;2616.3066787301354;2648.3776312566542;2651.7480839320256;2663.547196976514;4638.8608341749805;4752.405949256343;4760.047990401925;4811.302361157635;4852.9272060919075;4738.763061846911;4759.6430267729975;4769.260764581487;4809.855704328867;4821.4696383397795;4366.366876802862;4374.059577190919;4401.075774087445;4431.158079964796;4509.210888094587;4416.227160246944;4490.977545112286;4497.865064048084;4509.075639493896;4525.864224073267;4294.677899157576;4349.391085248068;4414.911701765946;4451.977740111295;4480.865574032784;4403.691741578091;4406.096750166208;4407.382966384709;4412;4424.756638384888;4323.567643235683;4361.062371590092;4369;4382.627476664487;4437.511873693891;4763.690360126615;4769.260764581495;4773.856784296477;4834.226523756182;4841.225403935388;5131.897362052738;5132.384113906355;5138.640295179339;5139.383274007143;5182.637215394924;4971.428285747149;5034.194528875362;5037.370328708911;5158.2520534522655;5215.035218484554;4727.243641017455;4789.664723469394;4803.495632958559;4847.151748444008;4853.49038350968;5205.193195054772;5254.789808407697;5259.47405259471;5270.393904700932;5316.3354580677415;5031.169856973558;5038.622103342191;5044.142495775727;5046.798128074909;5061.797528098835;4948.579370753526;5020.246962955586;5024.145895197825;5071.112555302807;5110.28456016158;4962.478939711351;5025.296458495814;5027;5043.344365232496;5043.87390315245;5005.624578156653;5008.398992120896;5021.974890125526;5027;5031.647784655112;4260.062786187033;4264.019275566637;4266.232078225949;4302.139572085595;4314.02934339771;3627.4558816177782;3636.5454318210222;3665.835037423269;3689.0592898810633;3722.6277372262557;4425.911481770411;4436.068425630589;4437.622802061796;4480.0367920896515;4487.730736155841;5061.417936937226;5064.215046667772;5070.923936140961;5091.389033315952;5150.6137039721425;4309.245881970643;4356.499002614676;4358.825646974149;4420.336949457607;4432.4237849080055;4576.610988065985;4613.884652883705;4617.0996655651825;4628.213203755369;4655.2784318430695;4844.297576851407;4854.878628034327;4856.1016212000895;4890.559849613552;4912.042151780369;5095.515925987025;5099.6175286852895;5103.18349064148;5108.66793658411;5112.258722485293;4645.558671926162;4691.296305554194;4735.905281894412;4783.449903261169;4893.681910675795;4990.80036798524;5049.419316778617;5053.545180933734;5059.569936555434;5064.72144032067;5056.84829455117;5063.316452278895;5066.44269130388;5066.518680725325;5127.307813445137;4780.95219047805;4824.372831531879;4914.115459217375;4921.237208232729;4980.900381992412;4821.108095002436;4957.380327459067;4978.800847966186;4982.775775090202;5082.898342033065;4913.213885778258;4913.41039075299;4916.434610019894;4920.237363208708;4972.577330926912;5045.520675535819;5061.569766569735;5062.1141300271565;5067.366579177603;5120.078385890575;4783;4799.448063472745;4831.95168048315;4841.685290456109;4855.198892182751 16:50:55 INFO - PROCESS | 25660 | |1;ext.html;541.1300614920524;565.8132816170662;577.9624324418916;582.30705460502;598.1267349669481;27275;28048.298792530197;37379;38178.236435271276;38238.04404889879;35353.82323088387;38261;38269;38331;38338.61661383385;7622.161562228164;7814.218578142197;7817.765467035998;7818.14000459949;7820.983272174638;7576;7653.1964143764935;7656.732014379498;7658.195889431613;7661.080670319569;7668.041494813148;7694.269044440797;7723.72966946157;7724.034495688039;7726.961365193166;7678.232176782333;7683.231676832328;7712.57580833054;7713.6914523419;7721.189275126087;7695.961520192419;7719.1508934017775;7757.689692412297;7760;7762.184970578121;37480.81259593712;37878;37951.81024094862;37988;38052.809735951145;2864.799464037518;2913.849465992689;2964.8814047438077;3061.6019917410595;3110.880083170057;27680.446391072266;27892.72107278942;27897.16308510748;29051.85474072616;29646.40707185844;3348.832558372096;3499.737519686034;3515.226650136966;3584.8028358440274;3685.5073695153505;242400;243890;246726;246947;247388;30543;49053.75473122683;49373.25940110901;49390.50609493931;49473.010539789;31265.531017034762;32920.83539582335;33019.3396132076;33044.83477582645;33064;13415.865841341656;13718.17690938547;13719.725605488034;13729.725405491834;13731;10066.496675166212;10153.086222240034;10156.441395723159;10169.338992965582;10182.134518566005;7694.807629809299;7719.691212351443;7780.066392032993;7787.065552133667;7789.1042530108625;3047.756179505634;3077.292222788771;3083.830389328564;3126.390353881017;3175.5077962915784;847.220557087481;856.9914300856911;879.4371602174614;916.5279880861361;930.4510338900081;26446.86776566105;26664;26824.865875670497;27052.32369190786;27410.314742131206;730.393773168269;925.319889880937;939.1078475448352;941.5433514745343;989.218517371283;13720.010598463166;14470.710585788436;14516.419343226364;14813.777793333109;14819.925900370428;368993;371921;372517;373011;373163;48056.5194348052;48523.5147648526;48541.757291214024;48572.757136214095;48576.5142348572;1069.4064794039382;1111.7887601355555;1153.2503872482953;1184.08233618946;1199.676087456382;26089.478210436064;28127.093310404227;29040.419191615627;29372.706272936997;29526.557101643062;39650.60349396584;40267.3959890596;40274.79862600668;40309.1938161241;40355.394669080575;288641;290620;290956;291018;291217;24335.26994190177;24450.51098977975;24867.751322486543;25054.749452505243;25123.74876251287;39487.60512394954;40144.79927600343;41067.589324106375;41206;41288;34255.80104696423;34659.48010779891;34944.30111397707;34957.65042349646;35627.64372356347;34309.48535771915;34488.13779655529;34515.82742086273;34580.48129278113;34658.48012279868;33262.83368583238;33909.830450847585;34451.31097377988;34596.82701586476;34706.82646586751;29562.260943475725;32037.519437208928;32069.839650801598;32086.358272833946;32274.838625806722;24095.397615059763;24255.393615159763;24416.409457313122;24934;24960.875195623907 16:50:55 INFO - PROCESS | 25660 | |2;jquery.html;356.11150180300154;372.52503058600263;375.48558474889404;380.16174335590017;397.36223361504784;12118.636440906776;15877.126758028304;16263.756043659354;16962.83037169628;17100;15036.398544058251;15492.845071549282;15811.446599369025;15953.202339883017;16408.26162822673;4435.824506505778;4715.787789549461;5008.474110218429;5055.620828437882;5108.565771909392;4950.55445009949;5019.121653710605;5033.320501732256;5034.6909803451;5035.521625445595;5010.198368261079;5010.749462526859;5017.347744793172;5084.4661310562415;5323.307969963918;5350.063738845706;5413.458654134594;5417.10617748073;5423.050966080959;5423.83728488146;5118.667286626394;5239.21411788231;5246.134387826004;5246.7901283948595;5288.048151332759;12227.205231659913;12324.383780810924;12403.875961240363;12419.385479887556;12488.875111248954;1873.8505889954688;1890.1210936914401;1930.420873737887;1978.5844972555637;2143.453419378064;8983;9019.323550733656;9057.592408341641;9523.095305945924;9669.742933418682;1661.2524364036233;1725.8705597080143;1729;1730.2041061111904;1735.4967059552714;62133.39277311323;67720.3227967714;68224.6588767053;68783.65608171927;70418.64790676013;10013.599456021677;10035.899641003643;10165.542550585242;10392.896071039344;10432.68701938943;14230.43078276878;14233.79739558591;14236.786448203286;14254.002219844719;14265.072770269899;7226.74706385274;7423.888641670379;7458.776236712907;7552.811179720551;7633.6564854581675;7057.329553692391;7097.538659987187;7300.12398512182;7313.597752123685;7315.231900650461;4137.648299894482;4312.654987600984;4345.9130817383475;4349.456317960255;4470.552944705503;1799.5051360875864;1809.3124612647373;1872.1201035513286;1896.9810301896805;1904.2858927902037;750.9261755689416;800.3197282310106;878.3763527895138;906.931980101495;913.1918252346721;15713.528594141966;16018.359265629477;16226.594335141715;17015.025308676082;17242.137893105293;834.8580741273877;838.9077201507952;842.6587232170981;870.4385671242013;901.7610333261691;8460;8892.15524525169;9039.412438191497;9157.313201509913;9292.39599426035;358193;370731;373673;374286;375056;74612.15223149315;77320.61339693266;79169.60415197887;79620.60189699015;79942.60028699819;870.856308709056;887.924526415249;888.440282621944;890.3411475508207;892.1569117184199;14598.416063357772;14645.853541464448;14646;14830.555083347517;15362.155081470179;35420.82289588536;35937;35962.28075438529;36039.63960360363;37619.81190094032;48393;48462.51537484721;49060.75469622629;49655;51088.23367649563;7508.774736757688;7697.8845317319165;10779.568817247222;10977.945110274397;11334;8357.707480238163;8405.285550728257;12212.38938053076;12766.106372553832;12971.221726696429;7258.165310989092;7447.962760186381;7548.584827834522;7904.960475197588;8078.272955434039;7730.922690773245;7924.20757924203;7991.72028978983;8104.311133553714;8359.623816928131;7643.57960312166;7999.480033797785;8140.837183256183;8195.180481951995;8488.40581159313;10824.943260780426;11062.834057489305;11226.494807733836;11619.024765789667;11865.644030679094;10546.736331591772;11146.275492092987;11151.275167114112;11225.550977960791;11319.151063670093 16:50:55 INFO - PROCESS | 25660 | |3;mootools.html;1227.8526576810784;1371.9245441500716;1406.5077222971959;1468.192494128229;1677.370985880295;6689.230738465078;7526.209747976466;7783.416243781718;7795.649195786189;7978.202179782019;7806.843863122735;7866.881996770053;7876.842463150733;7877;7879.133295337509;2171.587398394304;2196.1654571262898;2199.846010779246;2200.977990220101;2201.966970495444;2098.8740675559516;2139.711138996231;2158.69778231047;2159.6436587962967;2162.113533451285;2138.5509043100888;2171.6742488626674;2179.9564008719817;2180.106156475845;2181.3019833653157;2087.6868469729584;2094.6124966881025;2095.3399679101035;2095.6542170541766;2098.0768461876723;2044.4377796106041;2090.9477263068393;2097.2345094040716;2099.580083983194;2108.5677436125557;7568.167501574822;7768.067831860213;7812.6093695315;7813.062432508135;7818.14000459949;4388.297872340442;4434.933475997863;4513.052259025609;4520.773961301955;4534.478534968488;2841.2044627504333;2907.4330505551425;2937.4418860416454;2944.8674809633617;2948.4987552115977;865.8268346330696;902.8600566912139;904.7692838326251;915.1854849184232;932.9253659707207;10426.947865260701;10552.841707374395;10601.946990265076;10605.09856662177;10606.628767993083;3872.457855900176;4056.1076563156057;4175.498940127204;4229.048464095554;4233.301505251599;8229.25936665703;8235.052968908652;8237.423380363318;8242.670293188325;8245.381596380295;4451.59935605797;4461.353103799931;4464.017916058462;4466.709663871838;4469.910601788011;3591.102224443889;3690.9261814763554;3753.7155819774675;4139.544650088488;4179.370045682186;3091.7526597872115;3217.3726123406177;3399.7280217582534;3419.452887537982;3440.535527703728;1024.5850430575629;1028.139068286404;1044.2220545693508;1056.1181413519796;1057.381431862369;670.497127154634;685.9691313890787;715.0168518287355;723.6309482164029;734.8089496730888;4832.540908613676;4906.852794416173;4947.381577302837;5076.238564215398;5089.262057001714;400.3174587328598;402.87712247764125;404.31468660620556;408.9468369111996;409.20614008822787;3291.4075466415798;3293.2919422324317;3315.8176300303717;3356.882509112218;3372.966270337314;9296.488693121943;9615.134637882624;9684;9693.951530242304;9703.417794932328;9563.808723825485;9636.277279204087;9654.986226446263;9658.75853103664;9666.1151075541;7252.2385149559595;7282.162551306562;7316.304951029537;7317.231690672509;7333.2666733327305;4601.838935637236;4661.766911654336;4735.33705281254;5092.872678183075;5123.641345105807;8697.6086076128;8739.737807865775;8750.343724220582;8944.731658050008;8950.597223124845;8750.606222719865;8978.057303982987;8996.910030899608;9127.315451341308;9163.633454662006;5685.943140568706;5927.4665280125;6080.209572755513;6246.063090536456;6274.058891166362;7220.494565380373;7269.0186824777975;7279.636018198963;7282.817929551804;7283.890741638774;6540.444062254762;6675.33246675348;6720.563163394364;6723.7646682365885;6819.965900170468;6348.841278968062;6390.073439351361;6397.26431460388;6401.807945761635;6558.081868538504;5592.077307244259;5641.802536911188;5670.9432905672065;5682.77268909239;5683.090705487102;4154.688398370074;4190.350495673176;4254.425652536868;4300.505441874099;4405.427294451701;4424.911501770011;4481.260592002283;4520.299353600197;4536.795844187085;4553.772311384484 16:50:55 INFO - PROCESS | 25660 | |4;prototype.html;301.6998086903531;302.3333549523301;305.4898319805923;311.23746820290296;311.2747298793811;4790.520947905207;4840.782164802584;4843.152448321543;4845.709257444556;4867.53758392953;4769.379980602525;4776.37907072081;4785.258284965836;4793.90412191756;4807.399075115611;3579.910502237445;3689.594144644087;3708.6662200401956;3731.328360895038;3773.52830896138;3727.7763334200035;3736.7197460190596;3774.792386418746;3777.7544459610176;3785.1104990327253;3714.9257014859822;3718.3971220145872;3718.572364178127;3736.7384283100196;3764.416515440111;3549.3433714762723;3652.2878038782446;3705.2585284916045;3732.981335093321;3759.2857357102334;3316.0714999800093;3317.701406873393;3318.4690449528202;3337.7496687748517;3368.360011597813;4648.395708557866;4651.999820038674;4656.788025687805;4701.905961880743;4703.200455922467;4185.644220241283;4274.5939135782055;4292.935605965882;4302.870913872589;4340.674449416307;4969.503049695001;4981.2030075187795;4985.601151907838;5001.89996200074;5073.492650734897;3654.1230104774927;3675.7794532328144;3676.9816150919073;3682.0978860179425;3685.244524872395;5126.487351264844;5265.735733634536;5274.7626356814035;5280.841574752763;5283.762230699628;3730.123420996064;3737.364648009845;3738.420544815558;3756.624337566276;3756.69946404287;3793.829277682511;3795.411711184771;3795.9430608540893;3806.238752249506;3811.733178677521;4280.871573852789;4289.163613095417;4296.806643701041;4300.09697963425;4300.89247768802;4809.470958194595;5006.524380183877;5021.221710634857;5050.419201791841;5058.46886076964;1305.5822136916286;1316.2892038299403;1316.6379245707315;1320.1748906933167;1322.530501671912;831.1854382704983;859.2739135430551;866.7486428935538;869.4131461263622;874.8731433942042;4272.188284225987;4388.2759344707765;4434.733915965053;4533.750643714561;4546.840860569864;5146.974265128725;5152.562032227228;5154.561862241751;5157.355330583677;5169.71566563835;4497.572730590588;4499.302608095751;4504.662150338738;4521.502634710179;4528.230200865861;2605.674290713661;2723.801527328009;2726.577380506025;2742.27236840789;2745.492083964473;4928.521443566916;4932.334134891744;4932.901341973212;4945.947431815828;4946.505349465025;5019.949800502021;5231.659942103751;5300.04599172145;5337.172738225581;5344.171653393731;4873.463918968911;4875.585575226146;4903.190973489334;4909.386326709161;4920.8769780755765;5144.202648589475;5145.716985565829;5161.148410512224;5200.817971370984;5201.765920533509;4891.51084891508;5006.799728010985;5069.949300506948;5085.694858308513;5087.262346959744;4869.758211656147;4877.561019508261;4888.5111488850835;4892.608591312757;4896.461389247252;3749.1751814600743;3750.6061863503937;3752.6622603965775;3797.905052373713;3799.6580307772433;4927.728974906415;5180.222966554896;5180.611454140879;5202.4132639545305;5202.60980426462;4994.900101998012;5010.949890501049;5011.4236862761245;5014.749262536786;5057.797688092583;5007.123753343078;5009.874753131201;5016.147254966738;5024.598032157345;5042.747862606929;4684.929726054043;4911.852644420673;4913.852584422473;4918.0901533216465;4923.630727695366;4862.270659401118;5001.274815151855;5102.438731739431;5114.258432527337;5132.717700526507;4796.736179510161;5008.649394542347;5036.571891389273;5047.864230548097;5059.772310246121 16:50:55 INFO - PROCESS | 25660 | |5;yui.html;577.3706659740882;578.1328007988018;595.244040069112;626.3923993726086;631.7915088020953;12313.199642023263;12906.548270810523;13331.333433328344;13405.530806421777;13410.530631427902;12280.692982675437;12603;12818.294993775338;12868.549600763976;12922.28927408992;745.2510227221649;765.7090305683832;772.8531579;772.9265719756614;773.6325245508367;600.9218801555792;617.9721912513947;736.8452624948767;754.9886751698729;761.543074155505;794.289111245435;795.085651500773;796.8725003999361;797.214743477677;797.8085259537698;787.2914377060634;787.8778789287669;788.7318311773996;789.0688986995343;789.1477204618998;459.0497669823467;468.11759832715234;565.1663795901054;580.3934888042006;583.5302581421954;12062.577809776616;12119.212251203644;12119.272843629322;12119.515219391214;12122.090843186796;11307.660770176826;11405.714857128554;11725.70685732855;12369.072319575978;12468.376581170905;9841.311108222428;9925.503724813803;10221;10276.794464110675;10415;3253.316803471274;3265;3268.673132686736;3272.541844141822;3387.8814241501427;69549;70074.64962675206;70162.64918675374;70291;70975.99999999949;9383.091241714954;9409.388389754644;9477.857832132524;9484.14642682148;9636.566354514063;18120.818791812177;18223;18264;18468.81531184671;18560.350387736366;6447.419732224029;6694.196696396463;6703.530752847351;6729.007142078865;6755.932440675629;3575.284943011408;3621.3843646580144;3665.9266814663556;3680.1351682354625;3802.5056742623283;2884.2645125493286;2989.671136175019;2994.700529946988;2996.865141068657;3015.32155265068;465.1162790697634;470.98351557695315;476.94515130759714;481.4920259126585;487.1377661539056;419.52216128296686;477.1840153337831;497.01838868235666;511.89250257446355;528.1285878300757;6948.6178260196175;7124.323189297009;7203.927960720431;7267.236940121317;7465.776026719207;449.66499957531846;450.6777653977422;465.9347691323217;477.78738461385046;491.7541229385307;3300;3435.3301106284534;3576.445650924111;3697.7966211858607;3708.7589306694977;58168.41831581714;92730;94143;94784;96739.51630241804;65718.34281657219;67415.66292168507;67694.66152669303;79529.60235198903;80300.19699803044;47000.76499617549;62878;63852.68073659602;73672;74703.62648186942;7454.888176677463;7728.111267204344;7964.163762804822;7977.2022797719765;8071.919280807351;31357.8432107838;41242.38136427896;41408.18363273453;42397.788011060984;43507.495866158046;63891;64516;64760;64836.35163648303;66281;10027.699169024942;10227.642032528825;10337.224708146769;10380.065794078268;10470.790584188426;11653.708657283636;11807.291562506278;12050.156489045683;12082.033437324817;12259.877401225873;10420.635277765545;10476.423796691255;11065.83401248998;11397.544098235978;11408.828867566826;11078.501467433824;11191.019294173975;11239.100871930063;11338.716532086764;11399.715007124889;9381.061893810564;10249.231307651808;10380.948095259475;10525.473726313501;10633.468326583794;9225.446473211628;9360.859587106062;9633.133018028411;9866.457344845816;9926.106650401498;9240.475321571865;9610.183134433652;9615.759606009906;9872.654457093968;9880.654177103766 16:50:55 INFO - PROCESS | 25660 | __end_tp_report 16:50:55 INFO - PROCESS | 25660 | __start_cc_report 16:50:55 INFO - PROCESS | 25660 | _x_x_mozilla_cycle_collect,1112 16:50:55 INFO - PROCESS | 25660 | __end_cc_report 16:50:55 INFO - PROCESS | 25660 | __startTimestamp1474329055982__endTimestamp 16:50:55 INFO - PROCESS | 25660 | 16:50:55 INFO - PROCESS | 25660 | ------- Summary: start ------- 16:50:55 INFO - PROCESS | 25660 | Number of tests: 6 16:50:55 INFO - PROCESS | 25660 | 16:50:55 INFO - PROCESS | 25660 | [#0] dojo.html Cycles:165 Average:4711.32 Median:4841.69 stddev:499.52 (10.3%) stddev-sans-first:472.54 16:50:55 INFO - PROCESS | 25660 | Values: 2590.8 2616.3 2648.4 2651.7 2663.5 4638.9 4752.4 4760.0 4811.3 4852.9 4738.8 4759.6 4769.3 4809.9 4821.5 4366.4 4374.1 4401.1 4431.2 4509.2 4416.2 4491.0 4497.9 4509.1 4525.9 4294.7 4349.4 4414.9 4452.0 4480.9 4403.7 4406.1 4407.4 4412.0 4424.8 4323.6 4361.1 4369.0 4382.6 4437.5 4763.7 4769.3 4773.9 4834.2 4841.2 5131.9 5132.4 5138.6 5139.4 5182.6 4971.4 5034.2 5037.4 5158.3 5215.0 4727.2 4789.7 4803.5 4847.2 4853.5 5205.2 5254.8 5259.5 5270.4 5316.3 5031.2 5038.6 5044.1 5046.8 5061.8 4948.6 5020.2 5024.1 5071.1 5110.3 4962.5 5025.3 5027.0 5043.3 5043.9 5005.6 5008.4 5022.0 5027.0 5031.6 4260.1 4264.0 4266.2 4302.1 4314.0 3627.5 3636.5 3665.8 3689.1 3722.6 4425.9 4436.1 4437.6 4480.0 4487.7 5061.4 5064.2 5070.9 5091.4 5150.6 4309.2 4356.5 4358.8 4420.3 4432.4 4576.6 4613.9 4617.1 4628.2 4655.3 4844.3 4854.9 4856.1 4890.6 4912.0 5095.5 5099.6 5103.2 5108.7 5112.3 4645.6 4691.3 4735.9 4783.4 4893.7 4990.8 5049.4 5053.5 5059.6 5064.7 5056.8 5063.3 5066.4 5066.5 5127.3 4781.0 4824.4 4914.1 4921.2 4980.9 4821.1 4957.4 4978.8 4982.8 5082.9 4913.2 4913.4 4916.4 4920.2 4972.6 5045.5 5061.6 5062.1 5067.4 5120.1 4783.0 4799.4 4832.0 4841.7 4855.2 16:50:55 INFO - PROCESS | 25660 | 16:50:55 INFO - PROCESS | 25660 | [#1] ext.html Cycles:180 Average:44187.05 Median:34825.56 stddev:80942.29 (232.4%) stddev-sans-first:81103.02 16:50:55 INFO - PROCESS | 25660 | Values: 541.1 565.8 578.0 582.3 598.1 27275.0 28048.3 37379.0 38178.2 38238.0 35353.8 38261.0 38269.0 38331.0 38338.6 7622.2 7814.2 7817.8 7818.1 7821.0 7576.0 7653.2 7656.7 7658.2 7661.1 7668.0 7694.3 7723.7 7724.0 7727.0 7678.2 7683.2 7712.6 7713.7 7721.2 7696.0 7719.2 7757.7 7760.0 7762.2 37480.8 37878.0 37951.8 37988.0 38052.8 2864.8 2913.8 2964.9 3061.6 3110.9 27680.4 27892.7 27897.2 29051.9 29646.4 3348.8 3499.7 3515.2 3584.8 3685.5 242400.0 243890.0 246726.0 246947.0 247388.0 30543.0 49053.8 49373.3 49390.5 49473.0 31265.5 32920.8 33019.3 33044.8 33064.0 13415.9 13718.2 13719.7 13729.7 13731.0 10066.5 10153.1 10156.4 10169.3 10182.1 7694.8 7719.7 7780.1 7787.1 7789.1 3047.8 3077.3 3083.8 3126.4 3175.5 847.2 857.0 879.4 916.5 930.5 26446.9 26664.0 26824.9 27052.3 27410.3 730.4 925.3 939.1 941.5 989.2 13720.0 14470.7 14516.4 14813.8 14819.9 368993.0 371921.0 372517.0 373011.0 373163.0 48056.5 48523.5 48541.8 48572.8 48576.5 1069.4 1111.8 1153.3 1184.1 1199.7 26089.5 28127.1 29040.4 29372.7 29526.6 39650.6 40267.4 40274.8 40309.2 40355.4 288641.0 290620.0 290956.0 291018.0 291217.0 24335.3 24450.5 24867.8 25054.7 25123.7 39487.6 40144.8 41067.6 41206.0 41288.0 34255.8 34659.5 34944.3 34957.7 35627.6 34309.5 34488.1 34515.8 34580.5 34658.5 33262.8 33909.8 34451.3 34596.8 34706.8 29562.3 32037.5 32069.8 32086.4 32274.8 24095.4 24255.4 24416.4 24934.0 24960.9 16:50:55 INFO - PROCESS | 25660 | 16:50:55 INFO - PROCESS | 25660 | [#2] jquery.html Cycles:180 Average:23307.87 Median:27005.65 stddev:61322.78 (227.1%) stddev-sans-first:61470.59 16:50:55 INFO - PROCESS | 25660 | Values: 356.1 372.5 375.5 380.2 397.4 12118.6 15877.1 16263.8 16962.8 17100.0 15036.4 15492.8 15811.4 15953.2 16408.3 4435.8 4715.8 5008.5 5055.6 5108.6 4950.6 5019.1 5033.3 5034.7 5035.5 5010.2 5010.7 5017.3 5084.5 5323.3 5350.1 5413.5 5417.1 5423.1 5423.8 5118.7 5239.2 5246.1 5246.8 5288.0 12227.2 12324.4 12403.9 12419.4 12488.9 1873.9 1890.1 1930.4 1978.6 2143.5 8983.0 9019.3 9057.6 9523.1 9669.7 1661.3 1725.9 1729.0 1730.2 1735.5 62133.4 67720.3 68224.7 68783.7 70418.6 10013.6 10035.9 10165.5 10392.9 10432.7 14230.4 14233.8 14236.8 14254.0 14265.1 7226.7 7423.9 7458.8 7552.8 7633.7 7057.3 7097.5 7300.1 7313.6 7315.2 4137.6 4312.7 4345.9 4349.5 4470.6 1799.5 1809.3 1872.1 1897.0 1904.3 750.9 800.3 878.4 906.9 913.2 15713.5 16018.4 16226.6 17015.0 17242.1 834.9 838.9 842.7 870.4 901.8 8460.0 8892.2 9039.4 9157.3 9292.4 358193.0 370731.0 373673.0 374286.0 375056.0 74612.2 77320.6 79169.6 79620.6 79942.6 870.9 887.9 888.4 890.3 892.2 14598.4 14645.9 14646.0 14830.6 15362.2 35420.8 35937.0 35962.3 36039.6 37619.8 48393.0 48462.5 49060.8 49655.0 51088.2 7508.8 7697.9 10779.6 10977.9 11334.0 8357.7 8405.3 12212.4 12766.1 12971.2 7258.2 7448.0 7548.6 7905.0 8078.3 7730.9 7924.2 7991.7 8104.3 8359.6 7643.6 7999.5 8140.8 8195.2 8488.4 10824.9 11062.8 11226.5 11619.0 11865.6 10546.7 11146.3 11151.3 11225.6 11319.2 16:50:55 INFO - PROCESS | 25660 | 16:50:55 INFO - PROCESS | 25660 | [#3] mootools.html Cycles:180 Average:4962.23 Median:4631.80 stddev:2862.64 (61.8%) stddev-sans-first:2856.92 16:50:55 INFO - PROCESS | 25660 | Values: 1227.9 1371.9 1406.5 1468.2 1677.4 6689.2 7526.2 7783.4 7795.6 7978.2 7806.8 7866.9 7876.8 7877.0 7879.1 2171.6 2196.2 2199.8 2201.0 2202.0 2098.9 2139.7 2158.7 2159.6 2162.1 2138.6 2171.7 2180.0 2180.1 2181.3 2087.7 2094.6 2095.3 2095.7 2098.1 2044.4 2090.9 2097.2 2099.6 2108.6 7568.2 7768.1 7812.6 7813.1 7818.1 4388.3 4434.9 4513.1 4520.8 4534.5 2841.2 2907.4 2937.4 2944.9 2948.5 865.8 902.9 904.8 915.2 932.9 10426.9 10552.8 10601.9 10605.1 10606.6 3872.5 4056.1 4175.5 4229.0 4233.3 8229.3 8235.1 8237.4 8242.7 8245.4 4451.6 4461.4 4464.0 4466.7 4469.9 3591.1 3690.9 3753.7 4139.5 4179.4 3091.8 3217.4 3399.7 3419.5 3440.5 1024.6 1028.1 1044.2 1056.1 1057.4 670.5 686.0 715.0 723.6 734.8 4832.5 4906.9 4947.4 5076.2 5089.3 400.3 402.9 404.3 408.9 409.2 3291.4 3293.3 3315.8 3356.9 3373.0 9296.5 9615.1 9684.0 9694.0 9703.4 9563.8 9636.3 9655.0 9658.8 9666.1 7252.2 7282.2 7316.3 7317.2 7333.3 4601.8 4661.8 4735.3 5092.9 5123.6 8697.6 8739.7 8750.3 8944.7 8950.6 8750.6 8978.1 8996.9 9127.3 9163.6 5685.9 5927.5 6080.2 6246.1 6274.1 7220.5 7269.0 7279.6 7282.8 7283.9 6540.4 6675.3 6720.6 6723.8 6820.0 6348.8 6390.1 6397.3 6401.8 6558.1 5592.1 5641.8 5670.9 5682.8 5683.1 4154.7 4190.4 4254.4 4300.5 4405.4 4424.9 4481.3 4520.3 4536.8 4553.8 16:50:55 INFO - PROCESS | 25660 | 16:50:56 INFO - PROCESS | 25660 | [#4] prototype.html Cycles:180 Average:4189.81 Median:4795.32 stddev:1206.57 (25.2%) stddev-sans-first:1174.13 16:50:56 INFO - PROCESS | 25660 | Values: 301.7 302.3 305.5 311.2 311.3 4790.5 4840.8 4843.2 4845.7 4867.5 4769.4 4776.4 4785.3 4793.9 4807.4 3579.9 3689.6 3708.7 3731.3 3773.5 3727.8 3736.7 3774.8 3777.8 3785.1 3714.9 3718.4 3718.6 3736.7 3764.4 3549.3 3652.3 3705.3 3733.0 3759.3 3316.1 3317.7 3318.5 3337.7 3368.4 4648.4 4652.0 4656.8 4701.9 4703.2 4185.6 4274.6 4292.9 4302.9 4340.7 4969.5 4981.2 4985.6 5001.9 5073.5 3654.1 3675.8 3677.0 3682.1 3685.2 5126.5 5265.7 5274.8 5280.8 5283.8 3730.1 3737.4 3738.4 3756.6 3756.7 3793.8 3795.4 3795.9 3806.2 3811.7 4280.9 4289.2 4296.8 4300.1 4300.9 4809.5 5006.5 5021.2 5050.4 5058.5 1305.6 1316.3 1316.6 1320.2 1322.5 831.2 859.3 866.7 869.4 874.9 4272.2 4388.3 4434.7 4533.8 4546.8 5147.0 5152.6 5154.6 5157.4 5169.7 4497.6 4499.3 4504.7 4521.5 4528.2 2605.7 2723.8 2726.6 2742.3 2745.5 4928.5 4932.3 4932.9 4945.9 4946.5 5019.9 5231.7 5300.0 5337.2 5344.2 4873.5 4875.6 4903.2 4909.4 4920.9 5144.2 5145.7 5161.1 5200.8 5201.8 4891.5 5006.8 5069.9 5085.7 5087.3 4869.8 4877.6 4888.5 4892.6 4896.5 3749.2 3750.6 3752.7 3797.9 3799.7 4927.7 5180.2 5180.6 5202.4 5202.6 4994.9 5010.9 5011.4 5014.7 5057.8 5007.1 5009.9 5016.1 5024.6 5042.7 4684.9 4911.9 4913.9 4918.1 4923.6 4862.3 5001.3 5102.4 5114.3 5132.7 4796.7 5008.6 5036.6 5047.9 5059.8 16:50:56 INFO - PROCESS | 25660 | 16:50:56 INFO - PROCESS | 25660 | [#5] yui.html Cycles:180 Average:16703.63 Median:489.45 stddev:23743.94 (4851.2%) stddev-sans-first:23779.67 16:50:56 INFO - PROCESS | 25660 | Values: 577.4 578.1 595.2 626.4 631.8 12313.2 12906.5 13331.3 13405.5 13410.5 12280.7 12603.0 12818.3 12868.5 12922.3 745.3 765.7 772.9 772.9 773.6 600.9 618.0 736.8 755.0 761.5 794.3 795.1 796.9 797.2 797.8 787.3 787.9 788.7 789.1 789.1 459.0 468.1 565.2 580.4 583.5 12062.6 12119.2 12119.3 12119.5 12122.1 11307.7 11405.7 11725.7 12369.1 12468.4 9841.3 9925.5 10221.0 10276.8 10415.0 3253.3 3265.0 3268.7 3272.5 3387.9 69549.0 70074.6 70162.6 70291.0 70976.0 9383.1 9409.4 9477.9 9484.1 9636.6 18120.8 18223.0 18264.0 18468.8 18560.4 6447.4 6694.2 6703.5 6729.0 6755.9 3575.3 3621.4 3665.9 3680.1 3802.5 2884.3 2989.7 2994.7 2996.9 3015.3 465.1 471.0 476.9 481.5 487.1 419.5 477.2 497.0 511.9 528.1 6948.6 7124.3 7203.9 7267.2 7465.8 449.7 450.7 465.9 477.8 491.8 3300.0 3435.3 3576.4 3697.8 3708.8 58168.4 92730.0 94143.0 94784.0 96739.5 65718.3 67415.7 67694.7 79529.6 80300.2 47000.8 62878.0 63852.7 73672.0 74703.6 7454.9 7728.1 7964.2 7977.2 8071.9 31357.8 41242.4 41408.2 42397.8 43507.5 63891.0 64516.0 64760.0 64836.4 66281.0 10027.7 10227.6 10337.2 10380.1 10470.8 11653.7 11807.3 12050.2 12082.0 12259.9 10420.6 10476.4 11065.8 11397.5 11408.8 11078.5 11191.0 11239.1 11338.7 11399.7 9381.1 10249.2 10380.9 10525.5 10633.5 9225.4 9360.9 9633.1 9866.5 9926.1 9240.5 9610.2 9615.8 9872.7 9880.7 16:50:56 INFO - PROCESS | 25660 | -------- Summary: end -------- 16:50:56 INFO - PROCESS | 25660 | 16:50:57 INFO - TEST-INFO | 25660: exit 0 16:50:57 INFO - TEST-OK | dromaeo_css | took 1122519ms 16:50:57 INFO - TEST-START | kraken 16:50:57 INFO - operating with platform_type : linux_ 16:50:57 INFO - Initialising browser for kraken test... 16:50:57 INFO - TEST-INFO | started process 25965 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkS2x7w/profile http://localhost:56697/getInfo.html) 16:51:02 INFO - PROCESS | 25965 | __metrics Screen width/height:1600/1200 16:51:02 INFO - PROCESS | 25965 | colorDepth:24 16:51:02 INFO - PROCESS | 25965 | Browser inner width/height: 1024/697 16:51:02 INFO - PROCESS | 25965 | __metrics 16:51:02 INFO - PROCESS | 25965 | 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" 16:51:02 INFO - PROCESS | 25965 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:51:03 INFO - PROCESS | 25965 | console.error: PushService: 16:51:03 INFO - PROCESS | 25965 | stateChangeProcessEnqueue: Error transitioning state 16:51:03 INFO - PROCESS | 25965 | UnknownError 16:51:04 INFO - TEST-INFO | 25965: exit 0 16:51:04 INFO - Browser initialized. 16:51:04 INFO - Running cycle 1/1 for kraken test... 16:51:04 INFO - TEST-INFO | started process 26045 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpkS2x7w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:51:16 INFO - PROCESS | 26045 | RSS: Main: 174895104 16:51:16 INFO - PROCESS | 26045 | 16:51:19 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56697/tests/kraken/driver.html?testName=audio-beat-detection) 16:51:20 INFO - PROCESS | 26045 | RSS: Main: 233922560 16:51:20 INFO - PROCESS | 26045 | 16:51:22 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56697/tests/kraken/driver.html?testName=audio-dft) 16:51:23 INFO - PROCESS | 26045 | RSS: Main: 218427392 16:51:23 INFO - PROCESS | 26045 | 16:51:26 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56697/tests/kraken/driver.html?testName=audio-fft) 16:51:27 INFO - PROCESS | 26045 | RSS: Main: 300359680 16:51:27 INFO - PROCESS | 26045 | 16:51:29 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56697/tests/kraken/driver.html?testName=audio-oscillator) 16:51:30 INFO - PROCESS | 26045 | RSS: Main: 209731584 16:51:30 INFO - PROCESS | 26045 | 16:51:32 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56697/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:32 INFO - PROCESS | 26045 | RSS: Main: 213520384 16:51:32 INFO - PROCESS | 26045 | 16:51:36 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56697/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:36 INFO - PROCESS | 26045 | RSS: Main: 250146816 16:51:36 INFO - PROCESS | 26045 | 16:51:40 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56697/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:40 INFO - PROCESS | 26045 | RSS: Main: 248815616 16:51:40 INFO - PROCESS | 26045 | 16:51:43 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56697/tests/kraken/driver.html?testName=json-parse-financial) 16:51:44 INFO - PROCESS | 26045 | RSS: Main: 248582144 16:51:44 INFO - PROCESS | 26045 | 16:51:46 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56697/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:51:46 INFO - PROCESS | 26045 | RSS: Main: 211935232 16:51:46 INFO - PROCESS | 26045 | 16:51:48 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56697/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:51:49 INFO - PROCESS | 26045 | RSS: Main: 218894336 16:51:49 INFO - PROCESS | 26045 | 16:51:51 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56697/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:51:52 INFO - PROCESS | 26045 | RSS: Main: 223186944 16:51:52 INFO - PROCESS | 26045 | 16:51:54 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:51:55 INFO - PROCESS | 26045 | RSS: Main: 224878592 16:51:55 INFO - PROCESS | 26045 | 16:51:58 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:59 INFO - PROCESS | 26045 | RSS: Main: 222220288 16:51:59 INFO - PROCESS | 26045 | 16:52:00 INFO - PROCESS | 26045 | Cycle 1(1): loaded http://localhost:56697/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56697/tests/kraken/driver.html?testName=ai-astar) 16:52:01 INFO - PROCESS | 26045 | RSS: Main: 273350656 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | __start_tp_report 16:52:01 INFO - PROCESS | 26045 | _x_x_mozilla_page_load 16:52:01 INFO - PROCESS | 26045 | _x_x_mozilla_page_load_details 16:52:01 INFO - PROCESS | 26045 | |i|pagename|runs| 16:52:01 INFO - PROCESS | 26045 | |0;ai-astar;111;116;117;115;115;116;116;115;115;116 16:52:01 INFO - PROCESS | 26045 | |1;audio-beat-detection;151;125;129;162;125;129;124;123;160;124 16:52:01 INFO - PROCESS | 26045 | |2;audio-dft;163;161;163;161;162;161;161;161;161;161 16:52:01 INFO - PROCESS | 26045 | |3;audio-fft;75;80;76;111;77;76;76;75;97;76 16:52:01 INFO - PROCESS | 26045 | |4;audio-oscillator;85;84;113;84;84;84;116;84;85;112 16:52:01 INFO - PROCESS | 26045 | |5;imaging-gaussian-blur;117;118;118;117;118;117;118;118;118;118 16:52:01 INFO - PROCESS | 26045 | |6;imaging-darkroom;147;147;146;146;147;146;146;146;146;146 16:52:01 INFO - PROCESS | 26045 | |7;imaging-desaturate;96;96;95;96;95;96;95;96;95;96 16:52:01 INFO - PROCESS | 26045 | |8;json-parse-financial;63;63;63;64;63;64;64;64;63;73 16:52:01 INFO - PROCESS | 26045 | |9;json-stringify-tinderbox;65;66;65;66;67;65;66;67;67;66 16:52:01 INFO - PROCESS | 26045 | |10;stanford-crypto-aes;86;88;83;83;91;85;89;82;81;81 16:52:01 INFO - PROCESS | 26045 | |11;stanford-crypto-ccm;145;130;131;134;141;140;135;132;171;142 16:52:01 INFO - PROCESS | 26045 | |12;stanford-crypto-pbkdf2;175;175;172;171;174;173;172;179;171;178 16:52:01 INFO - PROCESS | 26045 | |13;stanford-crypto-sha256-iterative;71;69;70;69;70;68;69;69;68;71 16:52:01 INFO - PROCESS | 26045 | __end_tp_report 16:52:01 INFO - PROCESS | 26045 | __start_cc_report 16:52:01 INFO - PROCESS | 26045 | _x_x_mozilla_cycle_collect,1952 16:52:01 INFO - PROCESS | 26045 | __end_cc_report 16:52:01 INFO - PROCESS | 26045 | __startTimestamp1474329121177__endTimestamp 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | ------- Summary: start ------- 16:52:01 INFO - PROCESS | 26045 | Number of tests: 14 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#0] ai-astar Cycles:10 Average:115.20 Median:116.00 stddev:1.62 (1.4%) stddev-sans-first:0.71 16:52:01 INFO - PROCESS | 26045 | Values: 111.0 116.0 117.0 115.0 115.0 116.0 116.0 115.0 115.0 116.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#1] audio-beat-detection Cycles:10 Average:135.20 Median:129.00 stddev:15.87 (12.3%) stddev-sans-first:15.77 16:52:01 INFO - PROCESS | 26045 | Values: 151.0 125.0 129.0 162.0 125.0 129.0 124.0 123.0 160.0 124.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#2] audio-dft Cycles:10 Average:161.50 Median:161.00 stddev:0.85 (0.5%) stddev-sans-first:0.71 16:52:01 INFO - PROCESS | 26045 | Values: 163.0 161.0 163.0 161.0 162.0 161.0 161.0 161.0 161.0 161.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:12.19 (16.0%) stddev-sans-first:12.67 16:52:01 INFO - PROCESS | 26045 | Values: 75.0 80.0 76.0 111.0 77.0 76.0 76.0 75.0 97.0 76.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#4] audio-oscillator Cycles:10 Average:93.10 Median:84.00 stddev:14.23 (16.9%) stddev-sans-first:14.79 16:52:01 INFO - PROCESS | 26045 | Values: 85.0 84.0 113.0 84.0 84.0 84.0 116.0 84.0 85.0 112.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 16:52:01 INFO - PROCESS | 26045 | Values: 117.0 118.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 118.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 16:52:01 INFO - PROCESS | 26045 | Values: 147.0 147.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 146.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:52:01 INFO - PROCESS | 26045 | Values: 96.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 95.0 96.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#8] json-parse-financial Cycles:10 Average:64.40 Median:64.00 stddev:3.06 (4.8%) stddev-sans-first:3.21 16:52:01 INFO - PROCESS | 26045 | Values: 63.0 63.0 63.0 64.0 63.0 64.0 64.0 64.0 63.0 73.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#9] json-stringify-tinderbox Cycles:10 Average:66.00 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.78 16:52:01 INFO - PROCESS | 26045 | Values: 65.0 66.0 65.0 66.0 67.0 65.0 66.0 67.0 67.0 66.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.50 stddev:3.51 (4.1%) stddev-sans-first:3.70 16:52:01 INFO - PROCESS | 26045 | Values: 86.0 88.0 83.0 83.0 91.0 85.0 89.0 82.0 81.0 81.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#11] stanford-crypto-ccm Cycles:10 Average:140.10 Median:140.50 stddev:12.00 (8.5%) stddev-sans-first:12.60 16:52:01 INFO - PROCESS | 26045 | Values: 145.0 130.0 131.0 134.0 141.0 140.0 135.0 132.0 171.0 142.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.00 Median:174.50 stddev:2.79 (1.6%) stddev-sans-first:2.93 16:52:01 INFO - PROCESS | 26045 | Values: 175.0 175.0 172.0 171.0 174.0 173.0 172.0 179.0 171.0 178.0 16:52:01 INFO - PROCESS | 26045 | 16:52:01 INFO - PROCESS | 26045 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.50 stddev:1.07 (1.5%) stddev-sans-first:0.97 16:52:01 INFO - PROCESS | 26045 | Values: 71.0 69.0 70.0 69.0 70.0 68.0 69.0 69.0 68.0 71.0 16:52:01 INFO - PROCESS | 26045 | -------- Summary: end -------- 16:52:01 INFO - PROCESS | 26045 | 16:52:02 INFO - TEST-INFO | 26045: exit 0 16:52:02 INFO - TEST-OK | kraken | took 65555ms 16:52:02 INFO - SUITE-END | took 1188s 16:52:02 INFO - Completed test suite (00:19:48) 16:52:02 INFO - javascript benchmark 16:52:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.7797837183844, 2616.3066787301354, 2648.3776312566542, 2651.7480839320256, 2663.547196976514, 4638.8608341749805, 4752.405949256343, 4760.047990401925, 4811.302361157635, 4852.9272060919075, 4738.763061846911, 4759.6430267729975, 4769.260764581487, 4809.855704328867, 4821.4696383397795, 4366.366876802862, 4374.059577190919, 4401.075774087445, 4431.158079964796, 4509.210888094587, 4416.227160246944, 4490.977545112286, 4497.865064048084, 4509.075639493896, 4525.864224073267, 4294.677899157576, 4349.391085248068, 4414.911701765946, 4451.977740111295, 4480.865574032784, 4403.691741578091, 4406.096750166208, 4407.382966384709, 4412.0, 4424.756638384888, 4323.567643235683, 4361.062371590092, 4369.0, 4382.627476664487, 4437.511873693891, 4763.690360126615, 4769.260764581495, 4773.856784296477, 4834.226523756182, 4841.225403935388, 5131.897362052738, 5132.384113906355, 5138.640295179339, 5139.383274007143, 5182.637215394924, 4971.428285747149, 5034.194528875362, 5037.370328708911, 5158.2520534522655, 5215.035218484554, 4727.243641017455, 4789.664723469394, 4803.495632958559, 4847.151748444008, 4853.49038350968, 5205.193195054772, 5254.789808407697, 5259.47405259471, 5270.393904700932, 5316.3354580677415, 5031.169856973558, 5038.622103342191, 5044.142495775727, 5046.798128074909, 5061.797528098835, 4948.579370753526, 5020.246962955586, 5024.145895197825, 5071.112555302807, 5110.28456016158, 4962.478939711351, 5025.296458495814, 5027.0, 5043.344365232496, 5043.87390315245, 5005.624578156653, 5008.398992120896, 5021.974890125526, 5027.0, 5031.647784655112, 4260.062786187033, 4264.019275566637, 4266.232078225949, 4302.139572085595, 4314.02934339771, 3627.4558816177782, 3636.5454318210222, 3665.835037423269, 3689.0592898810633, 3722.6277372262557, 4425.911481770411, 4436.068425630589, 4437.622802061796, 4480.0367920896515, 4487.730736155841, 5061.417936937226, 5064.215046667772, 5070.923936140961, 5091.389033315952, 5150.6137039721425, 4309.245881970643, 4356.499002614676, 4358.825646974149, 4420.336949457607, 4432.4237849080055, 4576.610988065985, 4613.884652883705, 4617.0996655651825, 4628.213203755369, 4655.2784318430695, 4844.297576851407, 4854.878628034327, 4856.1016212000895, 4890.559849613552, 4912.042151780369, 5095.515925987025, 5099.6175286852895, 5103.18349064148, 5108.66793658411, 5112.258722485293, 4645.558671926162, 4691.296305554194, 4735.905281894412, 4783.449903261169, 4893.681910675795, 4990.80036798524, 5049.419316778617, 5053.545180933734, 5059.569936555434, 5064.72144032067, 5056.84829455117, 5063.316452278895, 5066.44269130388, 5066.518680725325, 5127.307813445137, 4780.95219047805, 4824.372831531879, 4914.115459217375, 4921.237208232729, 4980.900381992412, 4821.108095002436, 4957.380327459067, 4978.800847966186, 4982.775775090202, 5082.898342033065, 4913.213885778258, 4913.41039075299, 4916.434610019894, 4920.237363208708, 4972.577330926912, 5045.520675535819, 5061.569766569735, 5062.1141300271565, 5067.366579177603, 5120.078385890575, 4783.0, 4799.448063472745, 4831.95168048315, 4841.685290456109, 4855.198892182751], "value": 4678.692618443824, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.1300614920524, 565.8132816170662, 577.9624324418916, 582.30705460502, 598.1267349669481, 27275.0, 28048.298792530197, 37379.0, 38178.236435271276, 38238.04404889879, 35353.82323088387, 38261.0, 38269.0, 38331.0, 38338.61661383385, 7622.161562228164, 7814.218578142197, 7817.765467035998, 7818.14000459949, 7820.983272174638, 7576.0, 7653.1964143764935, 7656.732014379498, 7658.195889431613, 7661.080670319569, 7668.041494813148, 7694.269044440797, 7723.72966946157, 7724.034495688039, 7726.961365193166, 7678.232176782333, 7683.231676832328, 7712.57580833054, 7713.6914523419, 7721.189275126087, 7695.961520192419, 7719.1508934017775, 7757.689692412297, 7760.0, 7762.184970578121, 37480.81259593712, 37878.0, 37951.81024094862, 37988.0, 38052.809735951145, 2864.799464037518, 2913.849465992689, 2964.8814047438077, 3061.6019917410595, 3110.880083170057, 27680.446391072266, 27892.72107278942, 27897.16308510748, 29051.85474072616, 29646.40707185844, 3348.832558372096, 3499.737519686034, 3515.226650136966, 3584.8028358440274, 3685.5073695153505, 242400.0, 243890.0, 246726.0, 246947.0, 247388.0, 30543.0, 49053.75473122683, 49373.25940110901, 49390.50609493931, 49473.010539789, 31265.531017034762, 32920.83539582335, 33019.3396132076, 33044.83477582645, 33064.0, 13415.865841341656, 13718.17690938547, 13719.725605488034, 13729.725405491834, 13731.0, 10066.496675166212, 10153.086222240034, 10156.441395723159, 10169.338992965582, 10182.134518566005, 7694.807629809299, 7719.691212351443, 7780.066392032993, 7787.065552133667, 7789.1042530108625, 3047.756179505634, 3077.292222788771, 3083.830389328564, 3126.390353881017, 3175.5077962915784, 847.220557087481, 856.9914300856911, 879.4371602174614, 916.5279880861361, 930.4510338900081, 26446.86776566105, 26664.0, 26824.865875670497, 27052.32369190786, 27410.314742131206, 730.393773168269, 925.319889880937, 939.1078475448352, 941.5433514745343, 989.218517371283, 13720.010598463166, 14470.710585788436, 14516.419343226364, 14813.777793333109, 14819.925900370428, 368993.0, 371921.0, 372517.0, 373011.0, 373163.0, 48056.5194348052, 48523.5147648526, 48541.757291214024, 48572.757136214095, 48576.5142348572, 1069.4064794039382, 1111.7887601355555, 1153.2503872482953, 1184.08233618946, 1199.676087456382, 26089.478210436064, 28127.093310404227, 29040.419191615627, 29372.706272936997, 29526.557101643062, 39650.60349396584, 40267.3959890596, 40274.79862600668, 40309.1938161241, 40355.394669080575, 288641.0, 290620.0, 290956.0, 291018.0, 291217.0, 24335.26994190177, 24450.51098977975, 24867.751322486543, 25054.749452505243, 25123.74876251287, 39487.60512394954, 40144.79927600343, 41067.589324106375, 41206.0, 41288.0, 34255.80104696423, 34659.48010779891, 34944.30111397707, 34957.65042349646, 35627.64372356347, 34309.48535771915, 34488.13779655529, 34515.82742086273, 34580.48129278113, 34658.48012279868, 33262.83368583238, 33909.830450847585, 34451.31097377988, 34596.82701586476, 34706.82646586751, 29562.260943475725, 32037.519437208928, 32069.839650801598, 32086.358272833946, 32274.838625806722, 24095.397615059763, 24255.393615159763, 24416.409457313122, 24934.0, 24960.875195623907], "value": 15928.200220132563, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.11150180300154, 372.52503058600263, 375.48558474889404, 380.16174335590017, 397.36223361504784, 12118.636440906776, 15877.126758028304, 16263.756043659354, 16962.83037169628, 17100.0, 15036.398544058251, 15492.845071549282, 15811.446599369025, 15953.202339883017, 16408.26162822673, 4435.824506505778, 4715.787789549461, 5008.474110218429, 5055.620828437882, 5108.565771909392, 4950.55445009949, 5019.121653710605, 5033.320501732256, 5034.6909803451, 5035.521625445595, 5010.198368261079, 5010.749462526859, 5017.347744793172, 5084.4661310562415, 5323.307969963918, 5350.063738845706, 5413.458654134594, 5417.10617748073, 5423.050966080959, 5423.83728488146, 5118.667286626394, 5239.21411788231, 5246.134387826004, 5246.7901283948595, 5288.048151332759, 12227.205231659913, 12324.383780810924, 12403.875961240363, 12419.385479887556, 12488.875111248954, 1873.8505889954688, 1890.1210936914401, 1930.420873737887, 1978.5844972555637, 2143.453419378064, 8983.0, 9019.323550733656, 9057.592408341641, 9523.095305945924, 9669.742933418682, 1661.2524364036233, 1725.8705597080143, 1729.0, 1730.2041061111904, 1735.4967059552714, 62133.39277311323, 67720.3227967714, 68224.6588767053, 68783.65608171927, 70418.64790676013, 10013.599456021677, 10035.899641003643, 10165.542550585242, 10392.896071039344, 10432.68701938943, 14230.43078276878, 14233.79739558591, 14236.786448203286, 14254.002219844719, 14265.072770269899, 7226.74706385274, 7423.888641670379, 7458.776236712907, 7552.811179720551, 7633.6564854581675, 7057.329553692391, 7097.538659987187, 7300.12398512182, 7313.597752123685, 7315.231900650461, 4137.648299894482, 4312.654987600984, 4345.9130817383475, 4349.456317960255, 4470.552944705503, 1799.5051360875864, 1809.3124612647373, 1872.1201035513286, 1896.9810301896805, 1904.2858927902037, 750.9261755689416, 800.3197282310106, 878.3763527895138, 906.931980101495, 913.1918252346721, 15713.528594141966, 16018.359265629477, 16226.594335141715, 17015.025308676082, 17242.137893105293, 834.8580741273877, 838.9077201507952, 842.6587232170981, 870.4385671242013, 901.7610333261691, 8460.0, 8892.15524525169, 9039.412438191497, 9157.313201509913, 9292.39599426035, 358193.0, 370731.0, 373673.0, 374286.0, 375056.0, 74612.15223149315, 77320.61339693266, 79169.60415197887, 79620.60189699015, 79942.60028699819, 870.856308709056, 887.924526415249, 888.440282621944, 890.3411475508207, 892.1569117184199, 14598.416063357772, 14645.853541464448, 14646.0, 14830.555083347517, 15362.155081470179, 35420.82289588536, 35937.0, 35962.28075438529, 36039.63960360363, 37619.81190094032, 48393.0, 48462.51537484721, 49060.75469622629, 49655.0, 51088.23367649563, 7508.774736757688, 7697.8845317319165, 10779.568817247222, 10977.945110274397, 11334.0, 8357.707480238163, 8405.285550728257, 12212.38938053076, 12766.106372553832, 12971.221726696429, 7258.165310989092, 7447.962760186381, 7548.584827834522, 7904.960475197588, 8078.272955434039, 7730.922690773245, 7924.20757924203, 7991.72028978983, 8104.311133553714, 8359.623816928131, 7643.57960312166, 7999.480033797785, 8140.837183256183, 8195.180481951995, 8488.40581159313, 10824.943260780426, 11062.834057489305, 11226.494807733836, 11619.024765789667, 11865.644030679094, 10546.736331591772, 11146.275492092987, 11151.275167114112, 11225.550977960791, 11319.151063670093], "value": 7948.300120505268, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1227.8526576810784, 1371.9245441500716, 1406.5077222971959, 1468.192494128229, 1677.370985880295, 6689.230738465078, 7526.209747976466, 7783.416243781718, 7795.649195786189, 7978.202179782019, 7806.843863122735, 7866.881996770053, 7876.842463150733, 7877.0, 7879.133295337509, 2171.587398394304, 2196.1654571262898, 2199.846010779246, 2200.977990220101, 2201.966970495444, 2098.8740675559516, 2139.711138996231, 2158.69778231047, 2159.6436587962967, 2162.113533451285, 2138.5509043100888, 2171.6742488626674, 2179.9564008719817, 2180.106156475845, 2181.3019833653157, 2087.6868469729584, 2094.6124966881025, 2095.3399679101035, 2095.6542170541766, 2098.0768461876723, 2044.4377796106041, 2090.9477263068393, 2097.2345094040716, 2099.580083983194, 2108.5677436125557, 7568.167501574822, 7768.067831860213, 7812.6093695315, 7813.062432508135, 7818.14000459949, 4388.297872340442, 4434.933475997863, 4513.052259025609, 4520.773961301955, 4534.478534968488, 2841.2044627504333, 2907.4330505551425, 2937.4418860416454, 2944.8674809633617, 2948.4987552115977, 865.8268346330696, 902.8600566912139, 904.7692838326251, 915.1854849184232, 932.9253659707207, 10426.947865260701, 10552.841707374395, 10601.946990265076, 10605.09856662177, 10606.628767993083, 3872.457855900176, 4056.1076563156057, 4175.498940127204, 4229.048464095554, 4233.301505251599, 8229.25936665703, 8235.052968908652, 8237.423380363318, 8242.670293188325, 8245.381596380295, 4451.59935605797, 4461.353103799931, 4464.017916058462, 4466.709663871838, 4469.910601788011, 3591.102224443889, 3690.9261814763554, 3753.7155819774675, 4139.544650088488, 4179.370045682186, 3091.7526597872115, 3217.3726123406177, 3399.7280217582534, 3419.452887537982, 3440.535527703728, 1024.5850430575629, 1028.139068286404, 1044.2220545693508, 1056.1181413519796, 1057.381431862369, 670.497127154634, 685.9691313890787, 715.0168518287355, 723.6309482164029, 734.8089496730888, 4832.540908613676, 4906.852794416173, 4947.381577302837, 5076.238564215398, 5089.262057001714, 400.3174587328598, 402.87712247764125, 404.31468660620556, 408.9468369111996, 409.20614008822787, 3291.4075466415798, 3293.2919422324317, 3315.8176300303717, 3356.882509112218, 3372.966270337314, 9296.488693121943, 9615.134637882624, 9684.0, 9693.951530242304, 9703.417794932328, 9563.808723825485, 9636.277279204087, 9654.986226446263, 9658.75853103664, 9666.1151075541, 7252.2385149559595, 7282.162551306562, 7316.304951029537, 7317.231690672509, 7333.2666733327305, 4601.838935637236, 4661.766911654336, 4735.33705281254, 5092.872678183075, 5123.641345105807, 8697.6086076128, 8739.737807865775, 8750.343724220582, 8944.731658050008, 8950.597223124845, 8750.606222719865, 8978.057303982987, 8996.910030899608, 9127.315451341308, 9163.633454662006, 5685.943140568706, 5927.4665280125, 6080.209572755513, 6246.063090536456, 6274.058891166362, 7220.494565380373, 7269.0186824777975, 7279.636018198963, 7282.817929551804, 7283.890741638774, 6540.444062254762, 6675.33246675348, 6720.563163394364, 6723.7646682365885, 6819.965900170468, 6348.841278968062, 6390.073439351361, 6397.26431460388, 6401.807945761635, 6558.081868538504, 5592.077307244259, 5641.802536911188, 5670.9432905672065, 5682.77268909239, 5683.090705487102, 4154.688398370074, 4190.350495673176, 4254.425652536868, 4300.505441874099, 4405.427294451701, 4424.911501770011, 4481.260592002283, 4520.299353600197, 4536.795844187085, 4553.772311384484], "value": 3898.490082427326, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [301.6998086903531, 302.3333549523301, 305.4898319805923, 311.23746820290296, 311.2747298793811, 4790.520947905207, 4840.782164802584, 4843.152448321543, 4845.709257444556, 4867.53758392953, 4769.379980602525, 4776.37907072081, 4785.258284965836, 4793.90412191756, 4807.399075115611, 3579.910502237445, 3689.594144644087, 3708.6662200401956, 3731.328360895038, 3773.52830896138, 3727.7763334200035, 3736.7197460190596, 3774.792386418746, 3777.7544459610176, 3785.1104990327253, 3714.9257014859822, 3718.3971220145872, 3718.572364178127, 3736.7384283100196, 3764.416515440111, 3549.3433714762723, 3652.2878038782446, 3705.2585284916045, 3732.981335093321, 3759.2857357102334, 3316.0714999800093, 3317.701406873393, 3318.4690449528202, 3337.7496687748517, 3368.360011597813, 4648.395708557866, 4651.999820038674, 4656.788025687805, 4701.905961880743, 4703.200455922467, 4185.644220241283, 4274.5939135782055, 4292.935605965882, 4302.870913872589, 4340.674449416307, 4969.503049695001, 4981.2030075187795, 4985.601151907838, 5001.89996200074, 5073.492650734897, 3654.1230104774927, 3675.7794532328144, 3676.9816150919073, 3682.0978860179425, 3685.244524872395, 5126.487351264844, 5265.735733634536, 5274.7626356814035, 5280.841574752763, 5283.762230699628, 3730.123420996064, 3737.364648009845, 3738.420544815558, 3756.624337566276, 3756.69946404287, 3793.829277682511, 3795.411711184771, 3795.9430608540893, 3806.238752249506, 3811.733178677521, 4280.871573852789, 4289.163613095417, 4296.806643701041, 4300.09697963425, 4300.89247768802, 4809.470958194595, 5006.524380183877, 5021.221710634857, 5050.419201791841, 5058.46886076964, 1305.5822136916286, 1316.2892038299403, 1316.6379245707315, 1320.1748906933167, 1322.530501671912, 831.1854382704983, 859.2739135430551, 866.7486428935538, 869.4131461263622, 874.8731433942042, 4272.188284225987, 4388.2759344707765, 4434.733915965053, 4533.750643714561, 4546.840860569864, 5146.974265128725, 5152.562032227228, 5154.561862241751, 5157.355330583677, 5169.71566563835, 4497.572730590588, 4499.302608095751, 4504.662150338738, 4521.502634710179, 4528.230200865861, 2605.674290713661, 2723.801527328009, 2726.577380506025, 2742.27236840789, 2745.492083964473, 4928.521443566916, 4932.334134891744, 4932.901341973212, 4945.947431815828, 4946.505349465025, 5019.949800502021, 5231.659942103751, 5300.04599172145, 5337.172738225581, 5344.171653393731, 4873.463918968911, 4875.585575226146, 4903.190973489334, 4909.386326709161, 4920.8769780755765, 5144.202648589475, 5145.716985565829, 5161.148410512224, 5200.817971370984, 5201.765920533509, 4891.51084891508, 5006.799728010985, 5069.949300506948, 5085.694858308513, 5087.262346959744, 4869.758211656147, 4877.561019508261, 4888.5111488850835, 4892.608591312757, 4896.461389247252, 3749.1751814600743, 3750.6061863503937, 3752.6622603965775, 3797.905052373713, 3799.6580307772433, 4927.728974906415, 5180.222966554896, 5180.611454140879, 5202.4132639545305, 5202.60980426462, 4994.900101998012, 5010.949890501049, 5011.4236862761245, 5014.749262536786, 5057.797688092583, 5007.123753343078, 5009.874753131201, 5016.147254966738, 5024.598032157345, 5042.747862606929, 4684.929726054043, 4911.852644420673, 4913.852584422473, 4918.0901533216465, 4923.630727695366, 4862.270659401118, 5001.274815151855, 5102.438731739431, 5114.258432527337, 5132.717700526507, 4796.736179510161, 5008.649394542347, 5036.571891389273, 5047.864230548097, 5059.772310246121], "value": 3808.93100441059, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.3706659740882, 578.1328007988018, 595.244040069112, 626.3923993726086, 631.7915088020953, 12313.199642023263, 12906.548270810523, 13331.333433328344, 13405.530806421777, 13410.530631427902, 12280.692982675437, 12603.0, 12818.294993775338, 12868.549600763976, 12922.28927408992, 745.2510227221649, 765.7090305683832, 772.8531579, 772.9265719756614, 773.6325245508367, 600.9218801555792, 617.9721912513947, 736.8452624948767, 754.9886751698729, 761.543074155505, 794.289111245435, 795.085651500773, 796.8725003999361, 797.214743477677, 797.8085259537698, 787.2914377060634, 787.8778789287669, 788.7318311773996, 789.0688986995343, 789.1477204618998, 459.0497669823467, 468.11759832715234, 565.1663795901054, 580.3934888042006, 583.5302581421954, 12062.577809776616, 12119.212251203644, 12119.272843629322, 12119.515219391214, 12122.090843186796, 11307.660770176826, 11405.714857128554, 11725.70685732855, 12369.072319575978, 12468.376581170905, 9841.311108222428, 9925.503724813803, 10221.0, 10276.794464110675, 10415.0, 3253.316803471274, 3265.0, 3268.673132686736, 3272.541844141822, 3387.8814241501427, 69549.0, 70074.64962675206, 70162.64918675374, 70291.0, 70975.99999999949, 9383.091241714954, 9409.388389754644, 9477.857832132524, 9484.14642682148, 9636.566354514063, 18120.818791812177, 18223.0, 18264.0, 18468.81531184671, 18560.350387736366, 6447.419732224029, 6694.196696396463, 6703.530752847351, 6729.007142078865, 6755.932440675629, 3575.284943011408, 3621.3843646580144, 3665.9266814663556, 3680.1351682354625, 3802.5056742623283, 2884.2645125493286, 2989.671136175019, 2994.700529946988, 2996.865141068657, 3015.32155265068, 465.1162790697634, 470.98351557695315, 476.94515130759714, 481.4920259126585, 487.1377661539056, 419.52216128296686, 477.1840153337831, 497.01838868235666, 511.89250257446355, 528.1285878300757, 6948.6178260196175, 7124.323189297009, 7203.927960720431, 7267.236940121317, 7465.776026719207, 449.66499957531846, 450.6777653977422, 465.9347691323217, 477.78738461385046, 491.7541229385307, 3300.0, 3435.3301106284534, 3576.445650924111, 3697.7966211858607, 3708.7589306694977, 58168.41831581714, 92730.0, 94143.0, 94784.0, 96739.51630241804, 65718.34281657219, 67415.66292168507, 67694.66152669303, 79529.60235198903, 80300.19699803044, 47000.76499617549, 62878.0, 63852.68073659602, 73672.0, 74703.62648186942, 7454.888176677463, 7728.111267204344, 7964.163762804822, 7977.2022797719765, 8071.919280807351, 31357.8432107838, 41242.38136427896, 41408.18363273453, 42397.788011060984, 43507.495866158046, 63891.0, 64516.0, 64760.0, 64836.35163648303, 66281.0, 10027.699169024942, 10227.642032528825, 10337.224708146769, 10380.065794078268, 10470.790584188426, 11653.708657283636, 11807.291562506278, 12050.156489045683, 12082.033437324817, 12259.877401225873, 10420.635277765545, 10476.423796691255, 11065.83401248998, 11397.544098235978, 11408.828867566826, 11078.501467433824, 11191.019294173975, 11239.100871930063, 11338.716532086764, 11399.715007124889, 9381.061893810564, 10249.231307651808, 10380.948095259475, 10525.473726313501, 10633.468326583794, 9225.446473211628, 9360.859587106062, 9633.133018028411, 9866.457344845816, 9926.106650401498, 9240.475321571865, 9610.183134433652, 9615.759606009906, 9872.654457093968, 9880.654177103766], "value": 6149.406445073553, "unit": "score"}], "name": "dromaeo_css", "value": 6149.751153669302, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 116.0, 117.0, 115.0, 115.0, 116.0, 116.0, 115.0, 115.0, 116.0], "value": 115.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 129.0, 162.0, 125.0, 129.0, 124.0, 123.0, 160.0, 124.0], "value": 135.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 163.0, 161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 80.0, 76.0, 111.0, 77.0, 76.0, 76.0, 75.0, 97.0, 76.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 113.0, 84.0, 84.0, 84.0, 116.0, 84.0, 85.0, 112.0], "value": 93.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0, 95.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 73.0], "value": 64.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 67.0, 65.0, 66.0, 67.0, 67.0, 66.0], "value": 66.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 83.0, 83.0, 91.0, 85.0, 89.0, 82.0, 81.0, 81.0], "value": 84.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 130.0, 131.0, 134.0, 141.0, 140.0, 135.0, 132.0, 171.0, 142.0], "value": 140.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 175.0, 172.0, 171.0, 174.0, 173.0, 172.0, 179.0, 171.0, 178.0], "value": 174.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [71.0, 69.0, 70.0, 69.0, 70.0, 68.0, 69.0, 69.0, 68.0, 71.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1545.3000000000002, "alertThreshold": 2.0}]} 16:52:02 INFO - Return code: 0 16:52:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:52:03 INFO - # TBPL SUCCESS # 16:52:03 INFO - Running post-action listener: _resource_record_post_action 16:52:03 INFO - [mozharness: 2016-09-19 23:52:03.006302Z] Finished run-tests step (success) 16:52:03 INFO - Running post-run listener: _resource_record_post_run 16:52:03 INFO - Total resource usage - Wall time: 1205s; CPU: 13.0%; Read bytes: 8192; Write bytes: 388218880; Read time: 24; Write time: 774488 16:52:03 INFO - TinderboxPrint: CPU usage
13.1% 16:52:03 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 16:52:03 INFO - TinderboxPrint: I/O write bytes / time
388,218,880 / 774,488 16:52:03 INFO - TinderboxPrint: CPU idle
8,353.8 (86.9%) 16:52:03 INFO - TinderboxPrint: CPU user
1,204.0 (12.5%) 16:52:03 INFO - TinderboxPrint: Swap in / out
0 / 0 16:52:03 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 98963456; Read time: 0; Write time: 140860 16:52:03 INFO - run-tests - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289255424; Read time: 12; Write time: 633628 16:52:03 INFO - Running post-run listener: _upload_blobber_files 16:52:03 INFO - Blob upload gear active. 16:52:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:52:03 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 16:52:03 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', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:52:03 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 Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:52:04 INFO - (blobuploader) - INFO - Open directory for files ... 16:52:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:52:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:52:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:05 INFO - (blobuploader) - INFO - Done attempting. 16:52:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:52:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:09 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:52:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:09 INFO - (blobuploader) - INFO - Done attempting. 16:52:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:52:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:52:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:52:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:52:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:52:10 INFO - (blobuploader) - INFO - Done attempting. 16:52:10 INFO - (blobuploader) - INFO - Iteration through files over. 16:52:10 INFO - Return code: 0 16:52:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:52:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:52:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9dddac25aea76c9809494f910db610eb4f280588151b33d22d144134663262aa47cd5bad0454e42e13977053f6469032c11b677557128e11c07f68e5a2d3448", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af82a650ccb390f4b3aa2a52516da2732c373f88e8600801a536f21e4c7ba27423d698e12af8d5d8d06d531badc80d57e729b9af99ff3e07e87aeca22db5f17a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1fc25bce9e52c676409d67a1ba7526e0f33ffcf72db885a9d5bc50a5dd8d7a3cdf290cfe31c2eed447af0bed5cbceb618a3aa4ed8a27e494b35970b94cc96d5"} 16:52:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:52:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:52:10 INFO - Contents: 16:52:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9dddac25aea76c9809494f910db610eb4f280588151b33d22d144134663262aa47cd5bad0454e42e13977053f6469032c11b677557128e11c07f68e5a2d3448", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af82a650ccb390f4b3aa2a52516da2732c373f88e8600801a536f21e4c7ba27423d698e12af8d5d8d06d531badc80d57e729b9af99ff3e07e87aeca22db5f17a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1fc25bce9e52c676409d67a1ba7526e0f33ffcf72db885a9d5bc50a5dd8d7a3cdf290cfe31c2eed447af0bed5cbceb618a3aa4ed8a27e494b35970b94cc96d5"} 16:52:10 INFO - Running post-run listener: copy_logs_to_upload_dir 16:52:10 INFO - Copying logs to upload dir... 16:52:10 INFO - mkdir: /builds/slave/test/build/upload/logs 16:52:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1249.584541 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 49 secs) (at 2016-09-19 16:52:10.012214) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 16:52:10.015419) ========= 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=8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9dddac25aea76c9809494f910db610eb4f280588151b33d22d144134663262aa47cd5bad0454e42e13977053f6469032c11b677557128e11c07f68e5a2d3448", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af82a650ccb390f4b3aa2a52516da2732c373f88e8600801a536f21e4c7ba27423d698e12af8d5d8d06d531badc80d57e729b9af99ff3e07e87aeca22db5f17a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1fc25bce9e52c676409d67a1ba7526e0f33ffcf72db885a9d5bc50a5dd8d7a3cdf290cfe31c2eed447af0bed5cbceb618a3aa4ed8a27e494b35970b94cc96d5"} build_url:https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011522 build_url: 'https://queue.taskcluster.net/v1/task/Uj-s6yeXS06dYNNUs2Iyvg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d9dddac25aea76c9809494f910db610eb4f280588151b33d22d144134663262aa47cd5bad0454e42e13977053f6469032c11b677557128e11c07f68e5a2d3448", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/af82a650ccb390f4b3aa2a52516da2732c373f88e8600801a536f21e4c7ba27423d698e12af8d5d8d06d531badc80d57e729b9af99ff3e07e87aeca22db5f17a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e1fc25bce9e52c676409d67a1ba7526e0f33ffcf72db885a9d5bc50a5dd8d7a3cdf290cfe31c2eed447af0bed5cbceb618a3aa4ed8a27e494b35970b94cc96d5"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 16:52:10.042377) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:52:10.042810) ========= 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=8783db0840cc980e80bb0bd400000236-1474327878.441333-1833455266 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004376 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:52:10.124459) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 16:52:10.124830) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 16:52:10.125177) ========= ========= Total master_lag: 0.19 =========