builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1474328921.66 results: success (0) buildid: 20160919155216 builduid: 2f7fa73d3cfd438b843d0e4300ac322b revision: 80a9c7007243ac4e931a8c4352723cbf840aff03 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:41.660063) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:41.660576) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:41.660891) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:41.676063) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:41.676390) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-19 16:48:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 213M=0s 2016-09-19 16:48:42 (213 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096648 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:41.788426) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:41.788817) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019129 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:41.842194) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:41.842620) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 80a9c7007243ac4e931a8c4352723cbf840aff03 --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 80a9c7007243ac4e931a8c4352723cbf840aff03 --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=5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-19 16:48:42,350 truncating revision to first 12 chars 2016-09-19 16:48:42,350 Setting DEBUG logging. 2016-09-19 16:48:42,350 attempt 1/10 2016-09-19 16:48:42,350 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/80a9c7007243?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-19 16:48:42,826 unpacking tar archive at: mozilla-central-80a9c7007243/testing/mozharness/ program finished with exit code 0 elapsedTime=0.794851 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:42.653410) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:42.653782) ========= script_repo_revision: 80a9c7007243ac4e931a8c4352723cbf840aff03 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:42.654301) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:42.654608) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-19 16:48:42.664757) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-19 16:48:42.665263) ========= /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=5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:48:43 INFO - MultiFileLogger online at 20160919 16:48:43 in /builds/slave/test 16:48:43 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:48:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:48:43 INFO - {'append_to_log': False, 16:48:43 INFO - 'base_work_dir': '/builds/slave/test', 16:48:43 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:48:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:48:43 INFO - 'branch': 'Firefox-Non-PGO', 16:48:43 INFO - 'buildbot_json_path': 'buildprops.json', 16:48:43 INFO - 'config_files': ('talos/linux_config.py',), 16:48:43 INFO - 'default_actions': ('clobber', 16:48:43 INFO - 'read-buildbot-config', 16:48:43 INFO - 'download-and-extract', 16:48:43 INFO - 'populate-webroot', 16:48:43 INFO - 'create-virtualenv', 16:48:43 INFO - 'install', 16:48:43 INFO - 'run-tests'), 16:48:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:48:43 INFO - 'download_minidump_stackwalk': True, 16:48:43 INFO - 'download_symbols': 'ondemand', 16:48:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:48:43 INFO - 'tooltool.py': '/tools/tooltool.py', 16:48:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:48:43 INFO - '/tools/misc-python/virtualenv.py')}, 16:48:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:48:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:48:43 INFO - 'installer_path': 'installer.exe', 16:48:43 INFO - 'log_level': 'info', 16:48:43 INFO - 'log_name': 'talos', 16:48:43 INFO - 'log_to_console': True, 16:48:43 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:48:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:48:43 INFO - 'opt_config_files': (), 16:48:43 INFO - 'pip_index': False, 16:48:43 INFO - 'sps_profile': False, 16:48:43 INFO - 'sps_profile_interval': 0, 16:48:43 INFO - 'suite': 'dromaeojs', 16:48:43 INFO - 'system_bits': '32', 16:48:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:48:43 INFO - 'title': 'talos-linux64-ix-051', 16:48:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:48:43 INFO - 'use_talos_json': True, 16:48:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:48:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:48:43 INFO - 'work_dir': 'build'} 16:48:43 INFO - [mozharness: 2016-09-19 23:48:43.274198Z] Running clobber step. 16:48:43 INFO - Running pre-action listener: _resource_record_pre_action 16:48:43 INFO - Running main action method: clobber 16:48:43 INFO - rmtree: /builds/slave/test/build 16:48:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:48:44 INFO - Running post-action listener: _resource_record_post_action 16:48:44 INFO - [mozharness: 2016-09-19 23:48:44.241423Z] Finished clobber step (success) 16:48:44 INFO - [mozharness: 2016-09-19 23:48:44.241522Z] Running read-buildbot-config step. 16:48:44 INFO - Running pre-action listener: _resource_record_pre_action 16:48:44 INFO - Running main action method: read_buildbot_config 16:48:44 INFO - Using buildbot properties: 16:48:44 INFO - { 16:48:44 INFO - "project": "", 16:48:44 INFO - "product": "firefox", 16:48:44 INFO - "script_repo_revision": "production", 16:48:44 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:48:44 INFO - "repository": "", 16:48:44 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:48:44 INFO - "buildid": "20160919155216", 16:48:44 INFO - "pgo_build": "False", 16:48:44 INFO - "basedir": "/builds/slave/test", 16:48:44 INFO - "buildnumber": 213, 16:48:44 INFO - "slavename": "talos-linux64-ix-051", 16:48:44 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:48:44 INFO - "platform": "ubuntu64_hw", 16:48:44 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:48:44 INFO - "branch": "mozilla-central", 16:48:44 INFO - "repo_path": "mozilla-central", 16:48:44 INFO - "revision": "80a9c7007243ac4e931a8c4352723cbf840aff03", 16:48:44 INFO - "stage_platform": "linux64", 16:48:44 INFO - "builduid": "2f7fa73d3cfd438b843d0e4300ac322b", 16:48:44 INFO - "slavebuilddir": "test" 16:48:44 INFO - } 16:48:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 16:48:44 INFO - Running post-action listener: _resource_record_post_action 16:48:44 INFO - [mozharness: 2016-09-19 23:48:44.243942Z] Finished read-buildbot-config step (success) 16:48:44 INFO - [mozharness: 2016-09-19 23:48:44.244030Z] Running download-and-extract step. 16:48:44 INFO - Running pre-action listener: _resource_record_pre_action 16:48:44 INFO - Running main action method: download_and_extract 16:48:44 INFO - mkdir: /builds/slave/test/build/tests 16:48: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:48:44 INFO - trying https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:48:44 INFO - Downloading https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/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:48:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/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:48:45 INFO - Downloaded 1361 bytes. 16:48:45 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 16:48:45 INFO - Using the following test package requirements: 16:48:45 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:48:45 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:48:45 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:48:45 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:45 INFO - u'jsshell-linux-x86_64.zip'], 16:48:45 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:48:45 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 16:48:45 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:48:45 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:48:45 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:48:45 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 16:48:45 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:48:45 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:48:45 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:48:45 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:48:45 INFO - Fetch https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:48:46 INFO - Expected file size: 20365853 16:48:50 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:48:50 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 16:48:50 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:48:50 INFO - Fetch https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 16:48:51 INFO - Expected file size: 20365853 16:48:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 16:48:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:48:55 INFO - Fetch https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 16:48:56 INFO - Expected file size: 14414059 16:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:48:56 INFO - trying https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:48:56 INFO - Downloading https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/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:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/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:48:58 INFO - Downloaded 55599493 bytes. 16:48:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:48:58 INFO - mkdir: /builds/slave/test/properties 16:48:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:48:58 INFO - Writing to file /builds/slave/test/properties/build_url 16:48:58 INFO - Contents: 16:48:58 INFO - build_url:https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 16:48:58 INFO - Running post-action listener: _resource_record_post_action 16:48:58 INFO - Running post-action listener: set_extra_try_arguments 16:48:58 INFO - [mozharness: 2016-09-19 23:48:58.769244Z] Finished download-and-extract step (success) 16:48:58 INFO - [mozharness: 2016-09-19 23:48:58.769472Z] Running populate-webroot step. 16:48:58 INFO - Running pre-action listener: _resource_record_pre_action 16:48:58 INFO - Running main action method: populate_webroot 16:48:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:48:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:48:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:48:58 INFO - '--tppagecycles', 16:48:58 INFO - '7'], 16:48:58 INFO - 'tests': ['tsvgm']}}, 16:48:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:48:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:48:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:48:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:48:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:48:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:48:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:58 INFO - 'talos_options': ['--disable-e10s'], 16:48:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:48:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:58 INFO - 'talos_options': ['--disable-e10s'], 16:48:58 INFO - 'tests': ['damp', 'tps']}, 16:48:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:58 INFO - 'tests': ['damp', 'tps']}, 16:48:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:48:58 INFO - 'tests': ['dromaeo_dom']}, 16:48:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:48:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:48:58 INFO - 'tests': ['basic_compositor_video']}, 16:48:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:48:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:48:58 INFO - 'tests': ['a11yr', 16:48:58 INFO - 'ts_paint', 16:48:58 INFO - 'tpaint', 16:48:58 INFO - 'sessionrestore', 16:48:58 INFO - 'sessionrestore_no_auto_restore', 16:48:58 INFO - 'tabpaint']}, 16:48:58 INFO - 'other-e10s': {'tests': ['a11yr', 16:48:58 INFO - 'ts_paint', 16:48:58 INFO - 'tpaint', 16:48:58 INFO - 'sessionrestore', 16:48:58 INFO - 'sessionrestore_no_auto_restore', 16:48:58 INFO - 'tabpaint']}, 16:48:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:48:58 INFO - 'ts_paint', 16:48:58 INFO - 'tpaint', 16:48:58 INFO - 'sessionrestore', 16:48:58 INFO - 'sessionrestore_no_auto_restore', 16:48:58 INFO - 'tabpaint']}, 16:48:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:48:58 INFO - 'ts_paint', 16:48:58 INFO - 'tpaint', 16:48:58 INFO - 'sessionrestore', 16:48:58 INFO - 'sessionrestore_no_auto_restore', 16:48:58 INFO - 'tabpaint']}, 16:48:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:48:58 INFO - 'tests': ['a11yr', 16:48:58 INFO - 'ts_paint', 16:48:58 INFO - 'tpaint', 16:48:58 INFO - 'sessionrestore', 16:48:58 INFO - 'sessionrestore_no_auto_restore', 16:48:58 INFO - 'tabpaint']}, 16:48:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:48:58 INFO - 'tests': ['a11yr', 16:48:58 INFO - 'ts_paint', 16:48:58 INFO - 'tpaint', 16:48:58 INFO - 'sessionrestore', 16:48:58 INFO - 'sessionrestore_no_auto_restore', 16:48:58 INFO - 'tabpaint']}, 16:48:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:48:58 INFO - 'tests': ['tsvgx', 16:48:58 INFO - 'tsvgr_opacity', 16:48:58 INFO - 'tart', 16:48:58 INFO - 'tscrollx', 16:48:58 INFO - 'cart']}, 16:48:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:48:58 INFO - 'tsvgr_opacity', 16:48:58 INFO - 'tart', 16:48:58 INFO - 'tscrollx', 16:48:58 INFO - 'cart']}, 16:48:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:58 INFO - 'talos_options': ['--disable-e10s'], 16:48:58 INFO - 'tests': ['tp5o']}, 16:48:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:58 INFO - 'tests': ['tp5o']}, 16:48:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:58 INFO - 'talos_options': ['--disable-e10s', 16:48:58 INFO - '--xperf_path', 16:48:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:58 INFO - 'tests': ['tp5n']}, 16:48:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:48:58 INFO - 'talos_options': ['--xperf_path', 16:48:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:48:58 INFO - 'tests': ['tp5n']}}, 16:48:58 INFO - 'talos.zip': {'path': '', 16:48:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:48:58 INFO - Running post-action listener: _resource_record_post_action 16:48:58 INFO - [mozharness: 2016-09-19 23:48:58.787444Z] Finished populate-webroot step (success) 16:48:58 INFO - [mozharness: 2016-09-19 23:48:58.787532Z] Running create-virtualenv step. 16:48:58 INFO - Running pre-action listener: _resource_record_pre_action 16:48:58 INFO - Running main action method: create_virtualenv 16:48:58 INFO - Creating virtualenv /builds/slave/test/build/venv 16:48:58 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:48:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:48:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:48:58 INFO - Using real prefix '/usr' 16:48:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:48:59 INFO - Installing distribute.............................................................................................................................................................................................done. 16:49:01 INFO - Installing pip.................done. 16:49:01 INFO - Return code: 0 16:49:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:01 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 0x7f8dfd9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbf60>, '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 0x14ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cd1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', '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:49:01 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:49:01 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:49:01 INFO - Using env: {'DISPLAY': ':0', 16:49:01 INFO - 'HOME': '/home/cltbld', 16:49:01 INFO - 'LANG': 'en_US.UTF-8', 16:49:01 INFO - 'LANGUAGE': 'en_US:en', 16:49:01 INFO - 'LOGNAME': 'cltbld', 16:49:01 INFO - 'MAIL': '/var/mail/cltbld', 16:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:01 INFO - 'MOZ_NO_REMOTE': '1', 16:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:01 INFO - 'NO_EM_RESTART': '1', 16:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:01 INFO - 'PWD': '/builds/slave/test', 16:49:01 INFO - 'SHELL': '/bin/bash', 16:49:01 INFO - 'SHLVL': '1', 16:49:01 INFO - 'TERM': 'linux', 16:49:01 INFO - 'TMOUT': '86400', 16:49:01 INFO - 'USER': 'cltbld', 16:49:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', 16:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:01 INFO - '_': '/tools/buildbot/bin/python'} 16:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:01 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:49:01 INFO - Cleaning up... 16:49:01 INFO - Return code: 0 16:49:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:01 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 0x7f8dfd9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbf60>, '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 0x14ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cd1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', '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:49:01 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:49:01 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:49:01 INFO - Using env: {'DISPLAY': ':0', 16:49:01 INFO - 'HOME': '/home/cltbld', 16:49:01 INFO - 'LANG': 'en_US.UTF-8', 16:49:01 INFO - 'LANGUAGE': 'en_US:en', 16:49:01 INFO - 'LOGNAME': 'cltbld', 16:49:01 INFO - 'MAIL': '/var/mail/cltbld', 16:49:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:01 INFO - 'MOZ_NO_REMOTE': '1', 16:49:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:01 INFO - 'NO_EM_RESTART': '1', 16:49:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:01 INFO - 'PWD': '/builds/slave/test', 16:49:01 INFO - 'SHELL': '/bin/bash', 16:49:01 INFO - 'SHLVL': '1', 16:49:01 INFO - 'TERM': 'linux', 16:49:01 INFO - 'TMOUT': '86400', 16:49:01 INFO - 'USER': 'cltbld', 16:49:01 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', 16:49:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:01 INFO - '_': '/tools/buildbot/bin/python'} 16:49:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:01 INFO - Downloading/unpacking psutil>=3.1.1 16:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:49:03 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:03 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:03 INFO - Installing collected packages: psutil 16:49:03 INFO - Running setup.py install for psutil 16:49:03 INFO - building 'psutil._psutil_linux' extension 16:49:03 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:49:04 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:49:04 INFO - building 'psutil._psutil_posix' extension 16:49:04 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:49:04 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:49:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:49:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:49:04 INFO - Successfully installed psutil 16:49:04 INFO - Cleaning up... 16:49:04 INFO - Return code: 0 16:49:04 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:49:04 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:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:04 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:49:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:04 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 0x7f8dfd9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbf60>, '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 0x14ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cd1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', '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:49:04 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:49:04 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:49:04 INFO - Using env: {'DISPLAY': ':0', 16:49:04 INFO - 'HOME': '/home/cltbld', 16:49:04 INFO - 'LANG': 'en_US.UTF-8', 16:49:04 INFO - 'LANGUAGE': 'en_US:en', 16:49:04 INFO - 'LOGNAME': 'cltbld', 16:49:04 INFO - 'MAIL': '/var/mail/cltbld', 16:49:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:04 INFO - 'MOZ_NO_REMOTE': '1', 16:49:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:04 INFO - 'NO_EM_RESTART': '1', 16:49:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:04 INFO - 'PWD': '/builds/slave/test', 16:49:04 INFO - 'SHELL': '/bin/bash', 16:49:04 INFO - 'SHLVL': '1', 16:49:04 INFO - 'TERM': 'linux', 16:49:04 INFO - 'TMOUT': '86400', 16:49:04 INFO - 'USER': 'cltbld', 16:49:04 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', 16:49:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:04 INFO - '_': '/tools/buildbot/bin/python'} 16:49:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:04 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:06 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:49:06 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:49:06 INFO - Installing collected packages: mozsystemmonitor 16:49:06 INFO - Running setup.py install for mozsystemmonitor 16:49:06 INFO - Successfully installed mozsystemmonitor 16:49:06 INFO - Cleaning up... 16:49:06 INFO - Return code: 0 16:49:06 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dfd9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbf60>, '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 0x14ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cd1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', '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:49:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:49:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:49:06 INFO - Using env: {'DISPLAY': ':0', 16:49:06 INFO - 'HOME': '/home/cltbld', 16:49:06 INFO - 'LANG': 'en_US.UTF-8', 16:49:06 INFO - 'LANGUAGE': 'en_US:en', 16:49:06 INFO - 'LOGNAME': 'cltbld', 16:49:06 INFO - 'MAIL': '/var/mail/cltbld', 16:49:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:06 INFO - 'MOZ_NO_REMOTE': '1', 16:49:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:06 INFO - 'NO_EM_RESTART': '1', 16:49:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:06 INFO - 'PWD': '/builds/slave/test', 16:49:06 INFO - 'SHELL': '/bin/bash', 16:49:06 INFO - 'SHLVL': '1', 16:49:06 INFO - 'TERM': 'linux', 16:49:06 INFO - 'TMOUT': '86400', 16:49:06 INFO - 'USER': 'cltbld', 16:49:06 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', 16:49:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:06 INFO - '_': '/tools/buildbot/bin/python'} 16:49:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:06 INFO - Downloading/unpacking jsonschema==2.5.1 16:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:08 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:49:08 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:08 INFO - Downloading functools32-3.2.3-2.tar.gz 16:49:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:49:09 INFO - warning: no files found matching '*.txt' 16:49:09 INFO - no previously-included directories found matching 'build' 16:49:09 INFO - no previously-included directories found matching 'dist' 16:49:09 INFO - no previously-included directories found matching '.git*' 16:49:09 INFO - Installing collected packages: jsonschema, functools32 16:49:09 INFO - Running setup.py install for functools32 16:49:09 INFO - warning: no files found matching '*.txt' 16:49:09 INFO - no previously-included directories found matching 'build' 16:49:09 INFO - no previously-included directories found matching 'dist' 16:49:09 INFO - no previously-included directories found matching '.git*' 16:49:09 INFO - Successfully installed jsonschema functools32 16:49:09 INFO - Cleaning up... 16:49:09 INFO - Return code: 0 16:49:09 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 16:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8dfd9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbf60>, '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 0x14ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cd1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', '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:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 16:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 16:49:09 INFO - Using env: {'DISPLAY': ':0', 16:49:09 INFO - 'HOME': '/home/cltbld', 16:49:09 INFO - 'LANG': 'en_US.UTF-8', 16:49:09 INFO - 'LANGUAGE': 'en_US:en', 16:49:09 INFO - 'LOGNAME': 'cltbld', 16:49:09 INFO - 'MAIL': '/var/mail/cltbld', 16:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:09 INFO - 'MOZ_NO_REMOTE': '1', 16:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:09 INFO - 'NO_EM_RESTART': '1', 16:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:09 INFO - 'PWD': '/builds/slave/test', 16:49:09 INFO - 'SHELL': '/bin/bash', 16:49:09 INFO - 'SHLVL': '1', 16:49:09 INFO - 'TERM': 'linux', 16:49:09 INFO - 'TMOUT': '86400', 16:49:09 INFO - 'USER': 'cltbld', 16:49:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', 16:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:09 INFO - '_': '/tools/buildbot/bin/python'} 16:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:09 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 16:49:09 INFO - Cleaning up... 16:49:09 INFO - Return code: 0 16:49:09 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dfd9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbf60>, '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 0x14ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cd1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', '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:49:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:49:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:49:09 INFO - Using env: {'DISPLAY': ':0', 16:49:09 INFO - 'HOME': '/home/cltbld', 16:49:09 INFO - 'LANG': 'en_US.UTF-8', 16:49:09 INFO - 'LANGUAGE': 'en_US:en', 16:49:09 INFO - 'LOGNAME': 'cltbld', 16:49:09 INFO - 'MAIL': '/var/mail/cltbld', 16:49:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:09 INFO - 'MOZ_NO_REMOTE': '1', 16:49:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:09 INFO - 'NO_EM_RESTART': '1', 16:49:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:09 INFO - 'PWD': '/builds/slave/test', 16:49:09 INFO - 'SHELL': '/bin/bash', 16:49:09 INFO - 'SHLVL': '1', 16:49:09 INFO - 'TERM': 'linux', 16:49:09 INFO - 'TMOUT': '86400', 16:49:09 INFO - 'USER': 'cltbld', 16:49:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', 16:49:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:09 INFO - '_': '/tools/buildbot/bin/python'} 16:49:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:09 INFO - Downloading/unpacking blobuploader==1.2.4 16:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:11 INFO - Downloading blobuploader-1.2.4.tar.gz 16:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:49:11 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:49:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:49:12 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:49:12 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:49:12 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:49:12 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:49:12 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:49:12 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:49:12 INFO - Downloading docopt-0.6.1.tar.gz 16:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:49:12 INFO - Installing collected packages: blobuploader, requests, docopt 16:49:12 INFO - Running setup.py install for blobuploader 16:49:12 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:49:12 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:49:12 INFO - Running setup.py install for requests 16:49:12 INFO - Running setup.py install for docopt 16:49:12 INFO - Successfully installed blobuploader requests docopt 16:49:12 INFO - Cleaning up... 16:49:12 INFO - Return code: 0 16:49:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dfd9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbf60>, '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 0x14ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cd1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', '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:49:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:49:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:49:12 INFO - Using env: {'DISPLAY': ':0', 16:49:12 INFO - 'HOME': '/home/cltbld', 16:49:12 INFO - 'LANG': 'en_US.UTF-8', 16:49:12 INFO - 'LANGUAGE': 'en_US:en', 16:49:12 INFO - 'LOGNAME': 'cltbld', 16:49:12 INFO - 'MAIL': '/var/mail/cltbld', 16:49:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:12 INFO - 'MOZ_NO_REMOTE': '1', 16:49:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:12 INFO - 'NO_EM_RESTART': '1', 16:49:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:12 INFO - 'PWD': '/builds/slave/test', 16:49:12 INFO - 'SHELL': '/bin/bash', 16:49:12 INFO - 'SHLVL': '1', 16:49:12 INFO - 'TERM': 'linux', 16:49:12 INFO - 'TMOUT': '86400', 16:49:12 INFO - 'USER': 'cltbld', 16:49:12 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', 16:49:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:12 INFO - '_': '/tools/buildbot/bin/python'} 16:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:13 INFO - Running setup.py (path:/tmp/pip-SMFszi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:13 INFO - Running setup.py (path:/tmp/pip-TV2OMQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:13 INFO - Running setup.py (path:/tmp/pip-FMdXNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:13 INFO - Running setup.py (path:/tmp/pip-iU2a9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:13 INFO - Running setup.py (path:/tmp/pip-V0SgAR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:13 INFO - Running setup.py (path:/tmp/pip-IDRofN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:13 INFO - Running setup.py (path:/tmp/pip-5MykhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:13 INFO - Running setup.py (path:/tmp/pip-ENbeCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:13 INFO - Running setup.py (path:/tmp/pip-28qKlC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:13 INFO - Running setup.py (path:/tmp/pip-p96_7o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:13 INFO - Running setup.py (path:/tmp/pip-GeG4PA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:14 INFO - Running setup.py (path:/tmp/pip-DAIeBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:14 INFO - Running setup.py (path:/tmp/pip-oUwp_W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:14 INFO - Running setup.py (path:/tmp/pip-WVGs7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:14 INFO - Running setup.py (path:/tmp/pip-5yYq0s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:14 INFO - Running setup.py (path:/tmp/pip-Kng9ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:14 INFO - Running setup.py (path:/tmp/pip-Ge9r0C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:14 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:49:14 INFO - Running setup.py install for manifestparser 16:49:14 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:49:14 INFO - Running setup.py install for mozcrash 16:49:14 INFO - Running setup.py install for mozdebug 16:49:14 INFO - Running setup.py install for mozdevice 16:49:14 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:49:14 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:49:14 INFO - Running setup.py install for mozfile 16:49:14 INFO - Running setup.py install for mozhttpd 16:49:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Running setup.py install for mozinfo 16:49:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Running setup.py install for mozInstall 16:49:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Running setup.py install for mozleak 16:49:15 INFO - Running setup.py install for mozlog 16:49:15 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Running setup.py install for moznetwork 16:49:15 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Running setup.py install for mozprocess 16:49:15 INFO - Running setup.py install for mozprofile 16:49:15 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Running setup.py install for mozrunner 16:49:15 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:49:15 INFO - Running setup.py install for mozscreenshot 16:49:16 INFO - Running setup.py install for moztest 16:49:16 INFO - Running setup.py install for mozversion 16:49:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:49:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:49:16 INFO - Cleaning up... 16:49:16 INFO - Return code: 0 16:49:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dfd9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbf60>, '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 0x14ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cd1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', '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:49:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:49:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:49:16 INFO - Using env: {'DISPLAY': ':0', 16:49:16 INFO - 'HOME': '/home/cltbld', 16:49:16 INFO - 'LANG': 'en_US.UTF-8', 16:49:16 INFO - 'LANGUAGE': 'en_US:en', 16:49:16 INFO - 'LOGNAME': 'cltbld', 16:49:16 INFO - 'MAIL': '/var/mail/cltbld', 16:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:16 INFO - 'MOZ_NO_REMOTE': '1', 16:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:16 INFO - 'NO_EM_RESTART': '1', 16:49:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:16 INFO - 'PWD': '/builds/slave/test', 16:49:16 INFO - 'SHELL': '/bin/bash', 16:49:16 INFO - 'SHLVL': '1', 16:49:16 INFO - 'TERM': 'linux', 16:49:16 INFO - 'TMOUT': '86400', 16:49:16 INFO - 'USER': 'cltbld', 16:49:16 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', 16:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:16 INFO - '_': '/tools/buildbot/bin/python'} 16:49:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:49:16 INFO - Running setup.py (path:/tmp/pip-YCppER-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:49:16 INFO - Running setup.py (path:/tmp/pip-5tVXF1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:49:16 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:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:49:16 INFO - Running setup.py (path:/tmp/pip-jj9oHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:49:16 INFO - Running setup.py (path:/tmp/pip-XS2Q8I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:49:16 INFO - Running setup.py (path:/tmp/pip-j90FrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:49:16 INFO - Running setup.py (path:/tmp/pip-kscW3F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:49:16 INFO - Running setup.py (path:/tmp/pip-1QYUHr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:49:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:49:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:49:16 INFO - Running setup.py (path:/tmp/pip-rrDDl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:49:17 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:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:49:17 INFO - Running setup.py (path:/tmp/pip-nBYFWf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:49:17 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:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:49:17 INFO - Running setup.py (path:/tmp/pip-Ly38ql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:49:17 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:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:49:17 INFO - Running setup.py (path:/tmp/pip-Cel46H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:49:17 INFO - Running setup.py (path:/tmp/pip-hoFMDu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:49:17 INFO - Running setup.py (path:/tmp/pip-bddS2X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:49:17 INFO - Running setup.py (path:/tmp/pip-z47i2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:49:17 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:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:17 INFO - Running setup.py (path:/tmp/pip-ob_JWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:49:17 INFO - Running setup.py (path:/tmp/pip-iPIvJR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:49:17 INFO - Running setup.py (path:/tmp/pip-AyVDP0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 16:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:49:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:49:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:49:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:49:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:49:19 INFO - Downloading blessings-1.6.tar.gz 16:49:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:49:19 INFO - Installing collected packages: blessings 16:49:19 INFO - Running setup.py install for blessings 16:49:19 INFO - Successfully installed blessings 16:49:19 INFO - Cleaning up... 16:49:19 INFO - Return code: 0 16:49:19 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:49:19 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:20 INFO - Reading from file tmpfile_stdout 16:49:20 INFO - Current package versions: 16:49:20 INFO - argparse == 1.2.1 16:49:20 INFO - blessings == 1.6 16:49:20 INFO - blobuploader == 1.2.4 16:49:20 INFO - docopt == 0.6.1 16:49:20 INFO - functools32 == 3.2.3-2 16:49:20 INFO - jsonschema == 2.5.1 16:49:20 INFO - manifestparser == 1.1 16:49:20 INFO - mozInstall == 1.12 16:49:20 INFO - mozcrash == 0.17 16:49:20 INFO - mozdebug == 0.1 16:49:20 INFO - mozdevice == 0.48 16:49:20 INFO - mozfile == 1.2 16:49:20 INFO - mozhttpd == 0.7 16:49:20 INFO - mozinfo == 0.9 16:49:20 INFO - mozleak == 0.1 16:49:20 INFO - mozlog == 3.4 16:49:20 INFO - moznetwork == 0.27 16:49:20 INFO - mozprocess == 0.23 16:49:20 INFO - mozprofile == 0.28 16:49:20 INFO - mozrunner == 6.12 16:49:20 INFO - mozscreenshot == 0.1 16:49:20 INFO - mozsystemmonitor == 0.3 16:49:20 INFO - moztest == 0.7 16:49:20 INFO - mozversion == 1.4 16:49:20 INFO - psutil == 3.1.1 16:49:20 INFO - requests == 1.2.3 16:49:20 INFO - wsgiref == 0.1.2 16:49:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:20 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 0x7f8dfd9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbf60>, '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 0x14ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cd1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', '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:49:20 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:49:20 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:49:20 INFO - Using env: {'DISPLAY': ':0', 16:49:20 INFO - 'HOME': '/home/cltbld', 16:49:20 INFO - 'LANG': 'en_US.UTF-8', 16:49:20 INFO - 'LANGUAGE': 'en_US:en', 16:49:20 INFO - 'LOGNAME': 'cltbld', 16:49:20 INFO - 'MAIL': '/var/mail/cltbld', 16:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:20 INFO - 'MOZ_NO_REMOTE': '1', 16:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:20 INFO - 'NO_EM_RESTART': '1', 16:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:20 INFO - 'PWD': '/builds/slave/test', 16:49:20 INFO - 'SHELL': '/bin/bash', 16:49:20 INFO - 'SHLVL': '1', 16:49:20 INFO - 'TERM': 'linux', 16:49:20 INFO - 'TMOUT': '86400', 16:49:20 INFO - 'USER': 'cltbld', 16:49:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', 16:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:20 INFO - '_': '/tools/buildbot/bin/python'} 16:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 16:49:20 INFO - Cleaning up... 16:49:20 INFO - Return code: 0 16:49:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:49:20 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8dfd9aaf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14ceca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbf60>, '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 0x14ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cd1d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', '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:49:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:49:20 INFO - Using env: {'DISPLAY': ':0', 16:49:20 INFO - 'HOME': '/home/cltbld', 16:49:20 INFO - 'LANG': 'en_US.UTF-8', 16:49:20 INFO - 'LANGUAGE': 'en_US:en', 16:49:20 INFO - 'LOGNAME': 'cltbld', 16:49:20 INFO - 'MAIL': '/var/mail/cltbld', 16:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:20 INFO - 'MOZ_NO_REMOTE': '1', 16:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:20 INFO - 'NO_EM_RESTART': '1', 16:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:20 INFO - 'PWD': '/builds/slave/test', 16:49:20 INFO - 'SHELL': '/bin/bash', 16:49:20 INFO - 'SHLVL': '1', 16:49:20 INFO - 'TERM': 'linux', 16:49:20 INFO - 'TMOUT': '86400', 16:49:20 INFO - 'USER': 'cltbld', 16:49:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', 16:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:20 INFO - '_': '/tools/buildbot/bin/python'} 16:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:49:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:49:20 INFO - Cleaning up... 16:49:20 INFO - Return code: 0 16:49:20 INFO - Running post-action listener: _resource_record_post_action 16:49:20 INFO - Running post-action listener: _start_resource_monitoring 16:49:20 INFO - Starting resource monitoring. 16:49:20 INFO - [mozharness: 2016-09-19 23:49:20.525688Z] Finished create-virtualenv step (success) 16:49:20 INFO - [mozharness: 2016-09-19 23:49:20.526188Z] Running install step. 16:49:20 INFO - Running pre-action listener: _resource_record_pre_action 16:49:20 INFO - Running main action method: install 16:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:49:20 INFO - Reading from file tmpfile_stdout 16:49:20 INFO - Detecting whether we're running mozinstall >=1.0... 16:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:49:20 INFO - Reading from file tmpfile_stdout 16:49:20 INFO - Output received: 16:49:20 INFO - Usage: mozinstall [options] installer 16:49:20 INFO - Options: 16:49:20 INFO - -h, --help show this help message and exit 16:49:20 INFO - -d DEST, --destination=DEST 16:49:20 INFO - Directory to install application into. [default: 16:49:20 INFO - "/builds/slave/test"] 16:49:20 INFO - --app=APP Application being installed. [default: firefox] 16:49:20 INFO - mkdir: /builds/slave/test/build/application 16:49:20 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:49:20 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:49:36 INFO - Reading from file tmpfile_stdout 16:49:36 INFO - Output received: 16:49:36 INFO - /builds/slave/test/build/application/firefox/firefox 16:49:36 INFO - Running post-action listener: _resource_record_post_action 16:49:36 INFO - [mozharness: 2016-09-19 23:49:36.875424Z] Finished install step (success) 16:49:36 INFO - [mozharness: 2016-09-19 23:49:36.875668Z] Running run-tests step. 16:49:36 INFO - Running pre-action listener: _resource_record_pre_action 16:49:36 INFO - Running main action method: run_tests 16:49:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:49:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:49:36 INFO - Python 2.7.3 16:49:36 INFO - Return code: 0 16:49:36 INFO - grabbing minidump binary from tooltool 16:49:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 16:49:36 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14cbf60>, '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 0x14ccd40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14cd1d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:49:36 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:49:36 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:49:36 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:49:36 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:49:36 INFO - Return code: 0 16:49:36 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:49:36 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:49:36 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:49:36 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:49:36 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:49:36 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/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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:49:36 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/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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:49:36 INFO - Using env: {'DISPLAY': ':0', 16:49:36 INFO - 'HOME': '/home/cltbld', 16:49:36 INFO - 'LANG': 'en_US.UTF-8', 16:49:36 INFO - 'LANGUAGE': 'en_US:en', 16:49:36 INFO - 'LOGNAME': 'cltbld', 16:49:36 INFO - 'MAIL': '/var/mail/cltbld', 16:49:36 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:49:36 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:49:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:49:36 INFO - 'MOZ_NO_REMOTE': '1', 16:49:36 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:49:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:49:36 INFO - 'NO_EM_RESTART': '1', 16:49:36 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:49:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:49:36 INFO - 'PWD': '/builds/slave/test', 16:49:36 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:49:36 INFO - 'SHELL': '/bin/bash', 16:49:36 INFO - 'SHLVL': '1', 16:49:36 INFO - 'TERM': 'linux', 16:49:36 INFO - 'TMOUT': '86400', 16:49:36 INFO - 'USER': 'cltbld', 16:49:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778', 16:49:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:49:36 INFO - '_': '/tools/buildbot/bin/python'} 16:49:36 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/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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:49:37 INFO - mozversion application_buildid: 20160919155216 16:49:37 INFO - mozversion application_changeset: 80a9c7007243ac4e931a8c4352723cbf840aff03 16:49:37 INFO - mozversion application_display_name: Nightly 16:49:37 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:49:37 INFO - mozversion application_name: Firefox 16:49:37 INFO - mozversion application_remotingname: firefox 16:49:37 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:49:37 INFO - mozversion application_vendor: Mozilla 16:49:37 INFO - mozversion application_version: 52.0a1 16:49:37 INFO - mozversion platform_buildid: 20160919155216 16:49:37 INFO - mozversion platform_changeset: 80a9c7007243ac4e931a8c4352723cbf840aff03 16:49:37 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:49:37 INFO - mozversion platform_version: 52.0a1 16:49:37 INFO - using testdate: 1474328977 16:49:37 INFO - actual date: 1474328977 16:49:37 INFO - starting webserver on 'localhost:43237' 16:49:37 INFO - SUITE-START | Running 2 tests 16:49:37 INFO - TEST-START | dromaeo_css 16:49:37 INFO - operating with platform_type : linux_ 16:49:37 INFO - Initialising browser for dromaeo_css test... 16:49:37 INFO - TEST-INFO | started process 14768 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqSIngj/profile http://localhost:43237/getInfo.html) 16:49:41 INFO - PROCESS | 14768 | __metrics Screen width/height:1600/1200 16:49:41 INFO - PROCESS | 14768 | colorDepth:24 16:49:41 INFO - PROCESS | 14768 | Browser inner width/height: 1024/697 16:49:41 INFO - PROCESS | 14768 | __metrics 16:49:42 INFO - PROCESS | 14768 | 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:49:42 INFO - PROCESS | 14768 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:49:42 INFO - PROCESS | 14768 | console.error: PushService: 16:49:42 INFO - PROCESS | 14768 | stateChangeProcessEnqueue: Error transitioning state 16:49:42 INFO - PROCESS | 14768 | UnknownError 16:49:43 INFO - TEST-INFO | 14768: exit 0 16:49:43 INFO - Browser initialized. 16:49:43 INFO - Running cycle 1/1 for dromaeo_css test... 16:49:43 INFO - TEST-INFO | started process 14850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqSIngj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:49:56 INFO - PROCESS | 14850 | RSS: Main: 174907392 16:49:56 INFO - PROCESS | 14850 | 16:50:18 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 16:50:33 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.05006 seconds. 16:50:36 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:50:40 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:50:44 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 16:50:47 INFO - PROCESS | 14850 | 1474329047746 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:50:57 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.05006 seconds. 16:51:02 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.03345 seconds. 16:51:09 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.08338 seconds. 16:51:14 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.06673 seconds. 16:51:23 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 16:51:27 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.1667 seconds. 16:51:31 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 16:51:38 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01676 seconds. 16:51:53 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 16:51:55 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:51:57 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:51:58 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:52:13 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:52:16 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:52:17 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:52:18 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 2.06675 seconds. 16:52:21 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01669 seconds. 16:52:47 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.75011 seconds. 16:52:49 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 16:53:00 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 16:53:00 INFO - PROCESS | 14850 | Cycle 1(1): loaded http://localhost:43237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43237/tests/dromaeo/cssquery-ext.html) 16:53:01 INFO - PROCESS | 14850 | RSS: Main: 299245568 16:53:01 INFO - PROCESS | 14850 | 16:53:12 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:53:14 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 16:53:16 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 16:53:18 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:53:26 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 16:53:36 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 16:53:38 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:54:19 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:54:23 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:54:51 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:55:04 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 16:55:09 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 16:55:11 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 16:55:16 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:55:18 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 16:55:21 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:55:22 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 2.00009 seconds. 16:55:36 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:55:41 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:55:42 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:55:44 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:55:46 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:55:48 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:55:50 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:55:52 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 16:55:54 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:56:04 INFO - PROCESS | 14850 | Cycle 1(1): loaded http://localhost:43237/tests/dromaeo/cssquery-ext.html (next: http://localhost:43237/tests/dromaeo/cssquery-jquery.html) 16:56:05 INFO - PROCESS | 14850 | RSS: Main: 279883776 16:56:05 INFO - PROCESS | 14850 | 16:56:08 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 16:56:09 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:56:13 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:56:15 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:56:23 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 16:56:25 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:56:29 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 16:56:39 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:56:42 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.0167 seconds. 16:56:50 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 16:56:52 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:56:54 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 16:57:10 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:57:14 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:57:26 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:57:30 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 16:57:32 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 16:57:33 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 2.01678 seconds. 16:57:36 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:57:38 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:57:42 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 16:57:44 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:57:54 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 16:57:56 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:58:00 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:58:02 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:58:14 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01667 seconds. 16:58:32 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 16:58:47 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:58:51 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:58:57 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:59:03 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 16:59:07 INFO - PROCESS | 14850 | Cycle 1(1): loaded http://localhost:43237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43237/tests/dromaeo/cssquery-mootools.html) 16:59:07 INFO - PROCESS | 14850 | RSS: Main: 219607040 16:59:07 INFO - PROCESS | 14850 | 16:59:13 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.03339 seconds. 16:59:25 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 16:59:26 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 16:59:32 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 16:59:45 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:59:46 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:59:48 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 16:59:53 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.03338 seconds. 17:00:13 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:00:15 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:00:17 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 17:00:19 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 17:00:22 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 17:00:29 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:00:31 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:00:36 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:00:53 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:00:59 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 17:01:21 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:01:23 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 17:01:25 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:01:27 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 17:01:40 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 17:01:52 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:02:08 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:02:10 INFO - PROCESS | 14850 | Cycle 1(1): loaded http://localhost:43237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43237/tests/dromaeo/cssquery-prototype.html) 17:02:10 INFO - PROCESS | 14850 | RSS: Main: 220098560 17:02:10 INFO - PROCESS | 14850 | 17:02:14 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.05006 seconds. 17:02:27 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 17:02:35 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00002 seconds. 17:02:50 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 17:02:52 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 17:03:06 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 17:03:18 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01676 seconds. 17:03:21 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 17:03:28 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:03:36 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 17:03:39 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01672 seconds. 17:03:42 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 17:03:45 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 17:03:46 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.05008 seconds. 17:03:48 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 17:03:54 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:03:55 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:03:56 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 2.00009 seconds. 17:04:00 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 17:04:03 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01674 seconds. 17:04:08 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:04:17 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:04:22 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 17:04:29 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 17:04:31 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 17:04:37 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:04:49 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:04:57 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 17:04:59 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 17:05:01 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:05:06 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 17:05:09 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.03337 seconds. 17:05:13 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:05:14 INFO - PROCESS | 14850 | Cycle 1(1): loaded http://localhost:43237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43237/tests/dromaeo/cssquery-yui.html) 17:05:14 INFO - PROCESS | 14850 | RSS: Main: 219901952 17:05:14 INFO - PROCESS | 14850 | 17:05:18 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.05 seconds. 17:05:33 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01673 seconds. 17:05:41 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:05:43 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:05:45 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00005 seconds. 17:06:17 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:06:26 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 17:06:32 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:06:39 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.05005 seconds. 17:06:42 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 17:06:46 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00003 seconds. 17:06:54 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00001 seconds. 17:07:05 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00006 seconds. 17:07:16 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00009 seconds. 17:07:18 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:07:20 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:07:26 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00007 seconds. 17:07:36 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:07:49 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00004 seconds. 17:07:51 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.00008 seconds. 17:08:09 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 17:08:11 INFO - PROCESS | 14850 | [GFX1-]: Refresh driver waiting for the compositor for 1.01671 seconds. 17:08:17 INFO - PROCESS | 14850 | Cycle 1(1): loaded http://localhost:43237/tests/dromaeo/cssquery-yui.html (next: http://localhost:43237/tests/dromaeo/cssquery-dojo.html) 17:08:18 INFO - PROCESS | 14850 | RSS: Main: 312623104 17:08:18 INFO - PROCESS | 14850 | 17:08:18 INFO - PROCESS | 14850 | __start_tp_report 17:08:18 INFO - PROCESS | 14850 | _x_x_mozilla_page_load 17:08:18 INFO - PROCESS | 14850 | _x_x_mozilla_page_load_details 17:08:18 INFO - PROCESS | 14850 | |i|pagename|runs| 17:08:18 INFO - PROCESS | 14850 | |0;dojo.html;2512.62310653402;2581.754733300336;2608.934776630585;2609.0737788085235;2628.3034995726134;4600.240960241556;4685.929711054337;4731.550502702246;4746.145693775119;4766.8093276268955;4702.694324868881;4712.505186955372;4715.552022557851;4722.811087556503;4772.188727916254;4296.63478604319;4315.223259813232;4333.783310834461;4344.913101737963;4418;4412.338149277602;4413.3159360299205;4435.778211089449;4448.6885917985755;4495.955040449587;4284.9143017139795;4337.63130133939;4423.380726698265;4423.424954755861;4424.093060922503;4366.235908715994;4384.386185933972;4385.3641222022625;4389.31965545341;4390.890227744332;4292.29177185764;4330.610245077926;4333.696641235115;4356.934645980313;4359.738415695068;4732.408448943882;4750.548697873696;4755.262934245197;4818.831340903087;4843.273508973647;5101.617378696613;5111.693298402108;5114.514121158484;5116.820911268125;5119.744012799345;4983.401991760976;5023.497650234947;5070.442251352385;5086.54221120101;5190.844274671766;4734.171519983989;4736.881577960509;4739.644526660514;4788.9521104788855;4789.018251258483;5141.048905952336;5183.352080989876;5187.870303242449;5191.792328306826;5241.318628578337;4845.1278769821065;4899.485554016848;4964.255361695775;4987.800487980513;5037.219231019198;5025.14572522672;5040.243963405518;5051.292819005343;5096.261042148868;5176.534111929869;5019.0463811875625;5036.748162591855;5066.392032956069;5124.436312005676;5127.64106512548;4905.23968784839;4964.304997300381;5024.0956627807345;5042.218456139304;5057.772400241998;4329;4334.934975975363;4369.781510924441;4386.692931494828;4393.846215382447;3757;3774.245150969817;3782.319182547168;3793.696504279706;3832.827522761482;4264.445622069111;4290.163418133434;4309.1381723655395;4349.717268377545;4357.3899654048455;5082.923756143587;5085.644004919694;5109.718965456861;5165.612579056586;5167.044096842096;4322.027543802619;4329.437173167468;4332.090261045153;4336.566343365701;4378.540253273424;4472.508024117345;4517;4587.03672228829;4589.885252868638;4628.791704373311;4737.502562231054;4794.664373493822;4809.639277054165;4810.975945120392;4844.806207751651;5134.871628209325;5142.537171654569;5146.022255771391;5149.0474262261605;5207.453217412117;4688.0858232644305;4801.831935882227;4811.302361157543;4813.205821039489;4867.318575399376;4975.676581022222;4999.075171093359;5015.724135172601;5042.117629414764;5101.438841727481;5061.898762024665;5068.265101560327;5071.290019397361;5071.873203169803;5129.153689641316;4920.975395123001;4926.162552366178;4929.211326187793;4931.654784165074;4991.900161996812;4862.659613826998;4881.682690625098;4905.166121759381;4949.901001979868;4965.776540055634;4896.485868983706;4910.558049775537;4929.112759703288;4942.8022879085875;4947.727874966911;4847.636427268039;4899.387576552931;5055.51972562606;5056.115179843439;5062.0888240115655;4852.320675105418;4917.188663870421;4983.202687569971;4990.076835785391;5020.49795020495 17:08:18 INFO - PROCESS | 14850 | |1;ext.html;554.6145428926897;562.4291344285548;565.5701666733281;566.5807302596078;581.4011568084874;27910.86044569777;38758.806205969;39925.60074399255;40102.7994860026;43478.34782478266;39532.80233598835;39875.20249595006;39895;39896.202075958536;39957;7611.12472065714;7733.149353571102;7741.3419859312025;7748.263914928101;7753.651085701157;7594.54432734035;7678.270564296383;7679.8080047998965;7683.884741728879;7687.269709377628;7687.461877668566;7721.382289416833;7722.073351197836;7731.961340193319;7736.07167139944;7681.3470854977395;7718.884216736697;7720.57536835471;7721.112072111723;7726.459147859652;7603.619819009083;7661.65522551481;7662.348700360476;7663.042119735033;7667.463277570572;36418.08954776125;36571.63428365709;36656;36665.633343666486;36673.44989825155;2908.5200941844782;2974.449726800549;3218.308063766278;3260.7228385587255;3570.6786389224835;27708.584371234447;27955.301117472227;28141.57787633187;28356.43287134246;28419.431611367658;3023.3650933304034;3073.661897191307;3135.608048993876;3147.040152753409;3250.0249925022636;249276;250416.74791626108;250899;250955;252285;31275.84362078175;32298.35403291921;50017;50361;50404.49595503998;32772;33059.33881322408;33123;33124.834375827966;33133.66866331354;13566.253856037816;13678.31608419575;13689.452421903212;13696;13697;11314.830277545843;11392;11396.430178491042;11398.430078496041;11401.828972565418;7664.425168112414;7699.576523291273;7738;7761;7775.22247775218;2957.4676558219726;3015.8642861071303;3019.245188702824;3039.452898478251;3090.7218350348576;758.4501236603529;766.2299389113905;777.4324742937574;799.9600019998977;803.4817542684935;25651.486970260492;27366;27782.444351112863;27805;28194.71805281962;712.5582139073807;852.3607294529103;906.1210625693067;919.2048877720857;973.7195587802017;13975.440982360591;14351.497697580535;14410.207438590978;14746.557603271918;14837.777433338508;363534;364377;365808;368232;370762;46628.3005754914;47346.289805652945;47473.5252647476;47757.283640745416;47770;1050.3960222871879;1055.0451841083832;1062.458146345354;1126.357975953715;1136.1762722026465;25846.353841154123;28514.714852851204;28766.856165719037;29037.27406814762;29130;39700.80149599349;40272;40332.798336008134;40347.3947890776;40356.798216008734;234083;234991;235330;235550;235942;24317.878410607835;24454;25126.12058577941;25435.491290174465;25829.3542661435;39813.80093099516;40226.79886600548;40366.79816600898;40687.1862562753;41099.58900410958;34284.31431371409;34302;34385.312293753486;34662.82668586641;34885.30229395347;34174.65825341715;34641.82679086588;34688.479672804424;34846.303073937874;35182.47226291659;33901.66098339084;34717.652823472454;34795;34842.65157348394;34892.47661285134;29985.400291994476;31469.22650471196;31775.504694483127;31975.36049278955;32928.341433171685;23966.76033239715;24217.757822422256;24407.18909557384;24465.38836529101;24809.503809924063 17:08:18 INFO - PROCESS | 14850 | |2;jquery.html;347.1979726831019;367.7058353317347;370.6552905797608;375.8609314553615;393.9074317535379;12367.650146472175;15642.217889105543;15940.130776460233;16013;16804.57988550287;16006.43977460789;16035.198240087979;16613.584660383498;16816;16897.493075207734;4893.657443978923;4921.261810728383;5027.949720502785;5066;5148.845534633967;3690.5940346561856;3868.864589739346;4989.925151122736;5070.569001634865;5072.898542029157;5604.327480702301;5864.824055278327;5883.0881213411985;5955.851103722398;5979.970100149493;5715.142728590703;5856.355800861902;5898.4101589840675;5944.078667806497;5957.582969192158;5208.739563021872;5208.906129712765;5213.4004589472315;5216.400113986902;5217.921731174036;19228.423147305602;20584.27955021567;20655.5868882623;20693.793062069486;20754.028367305084;1728.809830918598;1794.443722446046;1823.361823361826;2013.536886516095;2316.131450705985;12653.240805551604;13344.399502022336;13696.794548081787;13935.233562154077;13956.162630242117;1664.933402663892;1731.1084791332473;1734.5923707928628;1779.288284686123;1795.111419847184;67745.66127169333;67880;69032.654836726;70315.99999999949;71588.6420567899;9455;9675.516224188763;9892.004537708412;9926.30515863897;10177.949110254402;13566.79649805234;13577.321133943264;13600.523981660792;13604.795928061087;13607.863921360859;7002.579845209202;7139.428845692332;7323.926760732431;7412.369948554326;7420.740274090381;6660.267370589231;6697.933020669829;6796.082528858639;6895.448364130857;6982.650867456607;6104.908426373608;6115.602485838406;6119.5410344224365;6135.662538560422;6185.103160041769;1722.9483115506555;1739.782527184102;1746.2054765081857;1772.7163653815585;1795.4882858385297;735.3602365941558;859.9398042137116;883.3330835219497;926.8517037274004;929.2658799548282;16280.267387967333;16598.6680266394;17018.659626807643;17110.486685399457;18093.45719628387;750.1748077115238;830.5390508267969;831.3723139029994;853.2832420766462;892.8705337726124;7403.85192296151;9131.634734610541;9607.087326703951;9701.369410988404;9785.119339259501;398384;398413;405048;422419;427138;46529;53279;74939.25060749432;78112.21887781163;79362.6031869837;925.509479975614;934.6448349627099;942.1520631431766;949.8195342884829;953.02315126994;14741.705165896836;15104;15153.621159471102;15633.218339082772;15692.450764223197;36026.27947440984;36349.27301454009;36574.69666898338;37137.25725485529;37650.81174594109;48304;49783.502164979334;49878.75060624674;49907.75046124746;50932.745336274565;6973.442124629916;7161.4270858330165;7292.088488938883;7347.742829000959;7552.509086909553;10027.699169024942;10605;11024.50389732448;11190.66428007161;11199.216054876406;8945.15021072997;9132.452052876848;9294.395864268801;9991.450470224207;10027.699169024942;8834.381593288665;9897.901020989699;9979;10568.418736969541;10801.081908037904;9665.806683866424;9842.21262299;10145.239107066853;10357.585696572052;10360.274780765274;7407.370373518312;7733.188015258542;7860.724874629361;7922.920770792219;7963.960180199062;9647.228221742384;9717.6598819041;10216.131628811634;10230.948845255725;10894 17:08:18 INFO - PROCESS | 14850 | |3;mootools.html;1057.249352959399;1083.7453198498351;1230.4647478346926;1233.3463264469833;1243.2602601452136;6398.9680051599735;7297.379722723568;7546.1321947976;7552.886706699397;7569.432292578065;7613.581253031081;7674.695301798693;7686.26980436859;7693.576853273068;7697.653605587748;2137.871727696343;2160.7299087614047;2163.6862654915108;2166.6425039868404;2166.772488888668;2078.449210959097;2127.2022991378235;2146.4848436375237;2147.066026278566;2157;2023.8482113841446;2028.3712049264702;2039.2964427272568;2039.3474088291753;2076.501639606491;2103.5582527669208;2106.2206983416236;2110.029386482228;2111.039477037944;2111.1344348817065;2033.217211373617;2107.7259956205594;2114.1015068595784;2116.227576934408;2116.544942837297;7282.162551306562;7388.408927285805;7396.70413183472;7549.207333229987;7600.657970391346;4294.828206871722;4469.3296005599095;4495.2133376659285;4503.482099558527;4503.48209955856;2671.666041744782;2771.4180022195364;2807.536756435186;2810.985945070282;2822.4919514487383;932.2868005975434;945.4705364995624;967.8983706710835;972.5040229482944;993.0268337029679;10170.644027459077;10228.795424091551;10299.124574411184;10300.27898047137;10300.330478518872;3977.463042489285;4003.6596889264156;4134.937975930364;4149.170165966759;4177.081042170778;7870.094939081964;7950.045994480699;7951.125376208613;7951.165127661628;7956.2043795619975;4241.597048280409;4249.830006799693;4254.468191476066;4255.021345090647;4258.041940563348;3484.4599087141532;3582.7850328980344;3959.030037640739;3960.881173564798;4071.1450595375304;3355.4463513520486;3362.6045191245357;3483.9825800870835;3501.6673416025437;3509.12271932017;1013.4020927652721;1016.8423894296396;1022.2895087913829;1030.5311083457009;1045.174312293295;631.766246488802;725.1407082607127;730.2879692300071;739.3936971683169;769.9384049276044;4492.842750503717;4494.280915053576;4520.59314661682;4600.35595016698;4825.782839772219;392.3330338424689;394.7138324714616;397.30471674569503;401.7368623551578;404.30056003114777;2883.6972117927735;3053.4045861057325;3117.0648805358755;3131.749460043191;3150.6534281229046;8549.743507694779;9248.537573121317;9308.534573271309;9318;9341.859872101924;9257;9259.02780208082;9264.490453025013;9282.164605185566;9282.860757088649;6908.861822763617;7007.614581197981;7065.364117229474;7071.29287071299;7081.539699919592;4398.516163222107;4410.382546443437;4443.577860103285;4456.131054444482;4551.8634440966825;8500.36247281444;8502.44734092282;8585.012723536624;8589.098144694717;8638.308935285288;8549.145085491402;8570.100139485265;8686.652533898574;8700.651973921225;8734.475931444134;5352.5985551084605;5480.10936227001;6033.396660333931;6109.541784366279;6114.908276375769;7034.859302813813;7119.038929744625;7248.130224373109;7408.111026676834;7432.739854105297;6542.084108224757;6599.769008084694;6607.431986727113;6775.322467753185;6786.626735529593;6369.9681501592195;6394.680265986589;6449.12936753551;6510.934890651222;6521.413072823469;5791.391903850204;5878.441548052928;5883.264591926009;5891.58758886891;5897.3807750185615;3888.2612303662213;3909.257241124177;3991.1219531702977;4008.7394319369146;4092.2633925893624;3988.222296652125;3991.401289806436;4017;4092.5293591237387;4183.016991007172 17:08:18 INFO - PROCESS | 14850 | |4;prototype.html;289.6900316661172;293.0373722322172;294.6375957572186;295.5891311077604;303.36142420205465;4963.702177869326;4967.205247160446;4974.204127339617;4975.6019518438525;4983.202687569985;4834.419869615642;4836.806527738886;4869.464358920524;4882.8779280518;4921.212605983043;3625.836837342326;3756.511653485043;3771.1703425246537;3842.1355195081164;3849.3840985442334;3822.8661996830115;3828.8851334459873;3832.693384529231;3840.2511510255513;3852.8266228019666;3797.3354662934016;3803.1442925341853;3806.3529200035923;3818.713596480261;3819.178876541543;3617.8914632561064;3691.6123807000145;3706.888793336177;3799.9620003799882;3822.636849499293;3369.4608862581867;3372.5109859070544;3386.7121294689982;3392.7625066245373;3396.524486571882;4751.453582837983;4756.524347565216;4772.236442169271;4775.474697783241;4785.234362502018;4158.584141585848;4329.870103896888;4359.716618419792;4390.363397307373;4400.889977750549;5019.498050194988;5027.170516864713;5047.570956468705;5054.721990290533;5091.770870310845;3678.503402040717;3693;3720.7581507201944;3738.4018557030745;3745.8127093645207;5086.262491938685;5419.783208671648;5432.674039557639;5447.992121457543;5449.754761035723;3605.170810713498;3658.359787037258;3661.2677464507206;3676.191237927652;3684.428913518409;3735.458358537997;3757.4363845423404;3757.680597149218;3760.2855457462992;3761.39817629178;4308.91382172361;4309.288967320357;4313.460817397825;4330.328799036154;4343.9348409773875;4830.661853670209;5051.646384753106;5110.2590124431745;5141.691498510027;5192.402873669576;1280.36621872172;1300.07694536878;1300.8634093420244;1308.4242933109401;1310.9737805243842;794.582844006901;817.6279792694429;833.2001278772325;838.1869586501084;842.4355681693157;4324.200022995693;4331.722141968127;4427.048184640318;4512.954870451319;4532.093581283756;5299.205119232146;5307.310049693515;5321.973390133025;5325.866853328698;5335.493128152819;4506.639468842484;4520.819167233274;4521.186186486399;4523.5024147343765;4528.9094218116115;2654.9203523894316;2775.6391669083296;2804.8036637435594;2817.60553522507;2828.349479619699;4957.206846904478;4961.206207006934;4962.206047032458;4986.850394488099;4997.475265097185;5173.22401639757;5406.6215364924865;5413.2150838128255;5426.186072089139;5426.8371948841595;4941.530554597308;4942.5057494251005;4946.307516947558;4953.529414705597;5005.6996580205305;5243.872567398028;5258.947410525999;5263.289455923401;5294.629375943801;5319.25530425733;5006.774695138801;5202.973985130202;5217.295665085317;5242.68543887368;5246.921296180637;4922.483139270325;4940.456549779593;4950.430700469492;4959.479254678206;4959.62802789785;3684.3368193725387;3718.5165928429133;3719.702423806143;3745.756525825813;3747.2130852521277;5059.671121377099;5329.946700532945;5330.387005494418;5339.172428273624;5368.785248590013;5119.48805119485;5155.381354237516;5164.173732202829;5172.5344718975475;5174.741262936763;5108.897822043464;5115.15599926023;5137.640365174402;5143.92284115731;5166.586673066221;4815.398075240595;5018.172001619838;5056.696598204119;5057.367829021372;5075.974620126875;4902.264660300983;5029.736618521607;5064.898702026013;5137.8201762938115;5150.742462876916;5037.471065538212;5055.418626857959;5059.46875578059;5063.392392912874;5080.949190508048 17:08:18 INFO - PROCESS | 14850 | |5;yui.html;661.7915356662647;675.166169780321;687.1376422589651;710.3500297228037;742.8625704244715;12518.749625007506;13540.796888046687;13541.255230962293;13571.457141714332;13608.523701670443;13295.135816171965;13513.594592162226;13541.796873046913;13546.729065418685;13563.118397304193;593.783269106775;608.8477880529867;719.7229066809277;726.8182954261434;738.9298016688406;734.5409119300438;743.929326713964;744.0773440933258;744.1776836595565;744.6686224630042;787.8621241282781;788.7357735158729;789.34090034821;790.0716657926913;790.3084800799301;618.9195404597418;631.962082275065;775.4881778026476;788.0228516639384;793.333599776185;557.4759725857681;557.956621118507;558.0680263959198;561.1526594841778;561.2535328013732;13118.147320424141;13128;13140.408681609351;13151.736965260738;13165.473381064747;12783.233006019576;13457.730845383136;13512.783849453597;13529;13571;10411.479426028669;10424.322419042814;10673;10795.514201860935;11096.389698566576;3193.6646652101426;3227.4190645683766;3281.2453135778906;3364.2262279675565;3374.1395944034116;66933.66533167352;66990.33009669889;67604.66197669029;68638.65680671614;71200;10186;10213.08082272599;10541.947290263653;10691.198160138021;10795.568177272979;17579.64840703179;17627;17633.823661763476;17645.38241161553;17646.735298970525;6665.200175978914;6708.960111182774;6741.696623651947;6804.149481314836;6892.069570608004;3257.9674203258137;3483.198864261234;3540.539729835105;3654.8172591370326;3767.3030489359558;2728.9044883428983;2785.2758282846203;2810.1990932584117;2812.943741125166;2817.337925587485;473.76311844077964;478.45695136020174;483.8862867226199;487.1596496044366;495.2076677316337;429.54682809636137;460.3072376074054;460.64300167370556;467.16377683946035;531.1289485244203;7202.53183543068;7725.845483090419;7844.150680846789;7914.129445760962;8310.750677479686;450.66875846252975;488.2578480709373;497.2119191082175;529.5578192209548;547.0836349115216;3513.402721537345;3762.3792074307435;3791.8483260669263;3920.2747491714126;3964.742291751085;101461.49269253755;103402;104462;107467;107520;50759;62272.06591901125;88769.55615222012;90059.54970225107;93399.53300233591;78946;79670;80293.99999999884;80544;81040;7087.22040575526;7172.246914074156;7517.962410187914;7635.350995165251;7654.923450765644;43990.340144898495;45082.774586126856;45269.54730452653;45889;46582;43754.78122609366;64477.35522644901;64571.15716321389;65155.34844651682;67516.52219122859;9033.728988130366;9074.954625226832;9191.21874640663;9324.580393882155;9552.952235239058;9819.36174148678;10015.39907605546;10034.147097496794;10133.79732405333;10280.742981425525;9551.474668893277;9662.903370966482;9673.613055477703;9827.901720982698;10144.746381340525;9091.363604547883;9277.721668349961;9457.10157535033;9493.0981556752;9817.55820988043;9117.90882091197;9324.533773311172;9834.606615735576;9899.802003960025;10313.329633573794;8061.596920154087;8084.83830323402;8132.715354962548;8151.755447336589;8829.69096081634;7897.24976127267;7899.447038707235;7973.20267973198;8443.493390396596;8674.783130421538 17:08:18 INFO - PROCESS | 14850 | __end_tp_report 17:08:18 INFO - PROCESS | 14850 | __start_cc_report 17:08:18 INFO - PROCESS | 14850 | _x_x_mozilla_cycle_collect,1072 17:08:18 INFO - PROCESS | 14850 | __end_cc_report 17:08:18 INFO - PROCESS | 14850 | __startTimestamp1474330098043__endTimestamp 17:08:18 INFO - PROCESS | 14850 | 17:08:18 INFO - PROCESS | 14850 | ------- Summary: start ------- 17:08:18 INFO - PROCESS | 14850 | Number of tests: 6 17:08:18 INFO - PROCESS | 14850 | 17:08:18 INFO - PROCESS | 14850 | [#0] dojo.html Cycles:165 Average:4696.01 Median:4843.27 stddev:501.39 (10.4%) stddev-sans-first:472.77 17:08:18 INFO - PROCESS | 14850 | Values: 2512.6 2581.8 2608.9 2609.1 2628.3 4600.2 4685.9 4731.6 4746.1 4766.8 4702.7 4712.5 4715.6 4722.8 4772.2 4296.6 4315.2 4333.8 4344.9 4418.0 4412.3 4413.3 4435.8 4448.7 4496.0 4284.9 4337.6 4423.4 4423.4 4424.1 4366.2 4384.4 4385.4 4389.3 4390.9 4292.3 4330.6 4333.7 4356.9 4359.7 4732.4 4750.5 4755.3 4818.8 4843.3 5101.6 5111.7 5114.5 5116.8 5119.7 4983.4 5023.5 5070.4 5086.5 5190.8 4734.2 4736.9 4739.6 4789.0 4789.0 5141.0 5183.4 5187.9 5191.8 5241.3 4845.1 4899.5 4964.3 4987.8 5037.2 5025.1 5040.2 5051.3 5096.3 5176.5 5019.0 5036.7 5066.4 5124.4 5127.6 4905.2 4964.3 5024.1 5042.2 5057.8 4329.0 4334.9 4369.8 4386.7 4393.8 3757.0 3774.2 3782.3 3793.7 3832.8 4264.4 4290.2 4309.1 4349.7 4357.4 5082.9 5085.6 5109.7 5165.6 5167.0 4322.0 4329.4 4332.1 4336.6 4378.5 4472.5 4517.0 4587.0 4589.9 4628.8 4737.5 4794.7 4809.6 4811.0 4844.8 5134.9 5142.5 5146.0 5149.0 5207.5 4688.1 4801.8 4811.3 4813.2 4867.3 4975.7 4999.1 5015.7 5042.1 5101.4 5061.9 5068.3 5071.3 5071.9 5129.2 4921.0 4926.2 4929.2 4931.7 4991.9 4862.7 4881.7 4905.2 4949.9 4965.8 4896.5 4910.6 4929.1 4942.8 4947.7 4847.6 4899.4 5055.5 5056.1 5062.1 4852.3 4917.2 4983.2 4990.1 5020.5 17:08:18 INFO - PROCESS | 14850 | 17:08:18 INFO - PROCESS | 14850 | [#1] ext.html Cycles:180 Average:42718.29 Median:34756.33 stddev:76377.67 (219.8%) stddev-sans-first:76526.32 17:08:18 INFO - PROCESS | 14850 | Values: 554.6 562.4 565.6 566.6 581.4 27910.9 38758.8 39925.6 40102.8 43478.3 39532.8 39875.2 39895.0 39896.2 39957.0 7611.1 7733.1 7741.3 7748.3 7753.7 7594.5 7678.3 7679.8 7683.9 7687.3 7687.5 7721.4 7722.1 7732.0 7736.1 7681.3 7718.9 7720.6 7721.1 7726.5 7603.6 7661.7 7662.3 7663.0 7667.5 36418.1 36571.6 36656.0 36665.6 36673.4 2908.5 2974.4 3218.3 3260.7 3570.7 27708.6 27955.3 28141.6 28356.4 28419.4 3023.4 3073.7 3135.6 3147.0 3250.0 249276.0 250416.7 250899.0 250955.0 252285.0 31275.8 32298.4 50017.0 50361.0 50404.5 32772.0 33059.3 33123.0 33124.8 33133.7 13566.3 13678.3 13689.5 13696.0 13697.0 11314.8 11392.0 11396.4 11398.4 11401.8 7664.4 7699.6 7738.0 7761.0 7775.2 2957.5 3015.9 3019.2 3039.5 3090.7 758.5 766.2 777.4 800.0 803.5 25651.5 27366.0 27782.4 27805.0 28194.7 712.6 852.4 906.1 919.2 973.7 13975.4 14351.5 14410.2 14746.6 14837.8 363534.0 364377.0 365808.0 368232.0 370762.0 46628.3 47346.3 47473.5 47757.3 47770.0 1050.4 1055.0 1062.5 1126.4 1136.2 25846.4 28514.7 28766.9 29037.3 29130.0 39700.8 40272.0 40332.8 40347.4 40356.8 234083.0 234991.0 235330.0 235550.0 235942.0 24317.9 24454.0 25126.1 25435.5 25829.4 39813.8 40226.8 40366.8 40687.2 41099.6 34284.3 34302.0 34385.3 34662.8 34885.3 34174.7 34641.8 34688.5 34846.3 35182.5 33901.7 34717.7 34795.0 34842.7 34892.5 29985.4 31469.2 31775.5 31975.4 32928.3 23966.8 24217.8 24407.2 24465.4 24809.5 17:08:18 INFO - PROCESS | 14850 | 17:08:18 INFO - PROCESS | 14850 | [#2] jquery.html Cycles:180 Average:24550.01 Median:5046.97 stddev:67462.57 (1336.7%) stddev-sans-first:67627.34 17:08:18 INFO - PROCESS | 14850 | Values: 347.2 367.7 370.7 375.9 393.9 12367.7 15642.2 15940.1 16013.0 16804.6 16006.4 16035.2 16613.6 16816.0 16897.5 4893.7 4921.3 5027.9 5066.0 5148.8 3690.6 3868.9 4989.9 5070.6 5072.9 5604.3 5864.8 5883.1 5955.9 5980.0 5715.1 5856.4 5898.4 5944.1 5957.6 5208.7 5208.9 5213.4 5216.4 5217.9 19228.4 20584.3 20655.6 20693.8 20754.0 1728.8 1794.4 1823.4 2013.5 2316.1 12653.2 13344.4 13696.8 13935.2 13956.2 1664.9 1731.1 1734.6 1779.3 1795.1 67745.7 67880.0 69032.7 70316.0 71588.6 9455.0 9675.5 9892.0 9926.3 10177.9 13566.8 13577.3 13600.5 13604.8 13607.9 7002.6 7139.4 7323.9 7412.4 7420.7 6660.3 6697.9 6796.1 6895.4 6982.7 6104.9 6115.6 6119.5 6135.7 6185.1 1722.9 1739.8 1746.2 1772.7 1795.5 735.4 859.9 883.3 926.9 929.3 16280.3 16598.7 17018.7 17110.5 18093.5 750.2 830.5 831.4 853.3 892.9 7403.9 9131.6 9607.1 9701.4 9785.1 398384.0 398413.0 405048.0 422419.0 427138.0 46529.0 53279.0 74939.3 78112.2 79362.6 925.5 934.6 942.2 949.8 953.0 14741.7 15104.0 15153.6 15633.2 15692.5 36026.3 36349.3 36574.7 37137.3 37650.8 48304.0 49783.5 49878.8 49907.8 50932.7 6973.4 7161.4 7292.1 7347.7 7552.5 10027.7 10605.0 11024.5 11190.7 11199.2 8945.2 9132.5 9294.4 9991.5 10027.7 8834.4 9897.9 9979.0 10568.4 10801.1 9665.8 9842.2 10145.2 10357.6 10360.3 7407.4 7733.2 7860.7 7922.9 7964.0 9647.2 9717.7 10216.1 10230.9 10894.0 17:08:18 INFO - PROCESS | 14850 | 17:08:18 INFO - PROCESS | 14850 | [#3] mootools.html Cycles:180 Average:4807.45 Median:4481.09 stddev:2774.03 (61.9%) stddev-sans-first:2767.49 17:08:18 INFO - PROCESS | 14850 | Values: 1057.2 1083.7 1230.5 1233.3 1243.3 6399.0 7297.4 7546.1 7552.9 7569.4 7613.6 7674.7 7686.3 7693.6 7697.7 2137.9 2160.7 2163.7 2166.6 2166.8 2078.4 2127.2 2146.5 2147.1 2157.0 2023.8 2028.4 2039.3 2039.3 2076.5 2103.6 2106.2 2110.0 2111.0 2111.1 2033.2 2107.7 2114.1 2116.2 2116.5 7282.2 7388.4 7396.7 7549.2 7600.7 4294.8 4469.3 4495.2 4503.5 4503.5 2671.7 2771.4 2807.5 2811.0 2822.5 932.3 945.5 967.9 972.5 993.0 10170.6 10228.8 10299.1 10300.3 10300.3 3977.5 4003.7 4134.9 4149.2 4177.1 7870.1 7950.0 7951.1 7951.2 7956.2 4241.6 4249.8 4254.5 4255.0 4258.0 3484.5 3582.8 3959.0 3960.9 4071.1 3355.4 3362.6 3484.0 3501.7 3509.1 1013.4 1016.8 1022.3 1030.5 1045.2 631.8 725.1 730.3 739.4 769.9 4492.8 4494.3 4520.6 4600.4 4825.8 392.3 394.7 397.3 401.7 404.3 2883.7 3053.4 3117.1 3131.7 3150.7 8549.7 9248.5 9308.5 9318.0 9341.9 9257.0 9259.0 9264.5 9282.2 9282.9 6908.9 7007.6 7065.4 7071.3 7081.5 4398.5 4410.4 4443.6 4456.1 4551.9 8500.4 8502.4 8585.0 8589.1 8638.3 8549.1 8570.1 8686.7 8700.7 8734.5 5352.6 5480.1 6033.4 6109.5 6114.9 7034.9 7119.0 7248.1 7408.1 7432.7 6542.1 6599.8 6607.4 6775.3 6786.6 6370.0 6394.7 6449.1 6510.9 6521.4 5791.4 5878.4 5883.3 5891.6 5897.4 3888.3 3909.3 3991.1 4008.7 4092.3 3988.2 3991.4 4017.0 4092.5 4183.0 17:08:18 INFO - PROCESS | 14850 | 17:08:18 INFO - PROCESS | 14850 | [#4] prototype.html Cycles:180 Average:4249.43 Median:4892.57 stddev:1243.60 (25.4%) stddev-sans-first:1211.06 17:08:18 INFO - PROCESS | 14850 | Values: 289.7 293.0 294.6 295.6 303.4 4963.7 4967.2 4974.2 4975.6 4983.2 4834.4 4836.8 4869.5 4882.9 4921.2 3625.8 3756.5 3771.2 3842.1 3849.4 3822.9 3828.9 3832.7 3840.3 3852.8 3797.3 3803.1 3806.4 3818.7 3819.2 3617.9 3691.6 3706.9 3800.0 3822.6 3369.5 3372.5 3386.7 3392.8 3396.5 4751.5 4756.5 4772.2 4775.5 4785.2 4158.6 4329.9 4359.7 4390.4 4400.9 5019.5 5027.2 5047.6 5054.7 5091.8 3678.5 3693.0 3720.8 3738.4 3745.8 5086.3 5419.8 5432.7 5448.0 5449.8 3605.2 3658.4 3661.3 3676.2 3684.4 3735.5 3757.4 3757.7 3760.3 3761.4 4308.9 4309.3 4313.5 4330.3 4343.9 4830.7 5051.6 5110.3 5141.7 5192.4 1280.4 1300.1 1300.9 1308.4 1311.0 794.6 817.6 833.2 838.2 842.4 4324.2 4331.7 4427.0 4513.0 4532.1 5299.2 5307.3 5322.0 5325.9 5335.5 4506.6 4520.8 4521.2 4523.5 4528.9 2654.9 2775.6 2804.8 2817.6 2828.3 4957.2 4961.2 4962.2 4986.9 4997.5 5173.2 5406.6 5413.2 5426.2 5426.8 4941.5 4942.5 4946.3 4953.5 5005.7 5243.9 5258.9 5263.3 5294.6 5319.3 5006.8 5203.0 5217.3 5242.7 5246.9 4922.5 4940.5 4950.4 4959.5 4959.6 3684.3 3718.5 3719.7 3745.8 3747.2 5059.7 5329.9 5330.4 5339.2 5368.8 5119.5 5155.4 5164.2 5172.5 5174.7 5108.9 5115.2 5137.6 5143.9 5166.6 4815.4 5018.2 5056.7 5057.4 5076.0 4902.3 5029.7 5064.9 5137.8 5150.7 5037.5 5055.4 5059.5 5063.4 5080.9 17:08:18 INFO - PROCESS | 14850 | 17:08:18 INFO - PROCESS | 14850 | [#5] yui.html Cycles:180 Average:17626.20 Median:559.61 stddev:26455.79 (4727.5%) stddev-sans-first:26499.34 17:08:18 INFO - PROCESS | 14850 | Values: 661.8 675.2 687.1 710.4 742.9 12518.7 13540.8 13541.3 13571.5 13608.5 13295.1 13513.6 13541.8 13546.7 13563.1 593.8 608.8 719.7 726.8 738.9 734.5 743.9 744.1 744.2 744.7 787.9 788.7 789.3 790.1 790.3 618.9 632.0 775.5 788.0 793.3 557.5 558.0 558.1 561.2 561.3 13118.1 13128.0 13140.4 13151.7 13165.5 12783.2 13457.7 13512.8 13529.0 13571.0 10411.5 10424.3 10673.0 10795.5 11096.4 3193.7 3227.4 3281.2 3364.2 3374.1 66933.7 66990.3 67604.7 68638.7 71200.0 10186.0 10213.1 10541.9 10691.2 10795.6 17579.6 17627.0 17633.8 17645.4 17646.7 6665.2 6709.0 6741.7 6804.1 6892.1 3258.0 3483.2 3540.5 3654.8 3767.3 2728.9 2785.3 2810.2 2812.9 2817.3 473.8 478.5 483.9 487.2 495.2 429.5 460.3 460.6 467.2 531.1 7202.5 7725.8 7844.2 7914.1 8310.8 450.7 488.3 497.2 529.6 547.1 3513.4 3762.4 3791.8 3920.3 3964.7 101461.5 103402.0 104462.0 107467.0 107520.0 50759.0 62272.1 88769.6 90059.5 93399.5 78946.0 79670.0 80294.0 80544.0 81040.0 7087.2 7172.2 7518.0 7635.4 7654.9 43990.3 45082.8 45269.5 45889.0 46582.0 43754.8 64477.4 64571.2 65155.3 67516.5 9033.7 9075.0 9191.2 9324.6 9553.0 9819.4 10015.4 10034.1 10133.8 10280.7 9551.5 9662.9 9673.6 9827.9 10144.7 9091.4 9277.7 9457.1 9493.1 9817.6 9117.9 9324.5 9834.6 9899.8 10313.3 8061.6 8084.8 8132.7 8151.8 8829.7 7897.2 7899.4 7973.2 8443.5 8674.8 17:08:18 INFO - PROCESS | 14850 | -------- Summary: end -------- 17:08:18 INFO - PROCESS | 14850 | 17:08:18 INFO - TEST-INFO | 14850: exit 0 17:08:19 INFO - TEST-OK | dromaeo_css | took 1121865ms 17:08:19 INFO - TEST-START | kraken 17:08:19 INFO - operating with platform_type : linux_ 17:08:19 INFO - Initialising browser for kraken test... 17:08:19 INFO - TEST-INFO | started process 15159 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfPV4I9/profile http://localhost:43237/getInfo.html) 17:08:23 INFO - PROCESS | 15159 | __metrics Screen width/height:1600/1200 17:08:23 INFO - PROCESS | 15159 | colorDepth:24 17:08:23 INFO - PROCESS | 15159 | Browser inner width/height: 1024/697 17:08:23 INFO - PROCESS | 15159 | __metrics 17:08:24 INFO - PROCESS | 15159 | 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" 17:08:24 INFO - PROCESS | 15159 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:08:24 INFO - PROCESS | 15159 | console.error: PushService: 17:08:24 INFO - PROCESS | 15159 | stateChangeProcessEnqueue: Error transitioning state 17:08:24 INFO - PROCESS | 15159 | UnknownError 17:08:25 INFO - TEST-INFO | 15159: exit 0 17:08:25 INFO - Browser initialized. 17:08:25 INFO - Running cycle 1/1 for kraken test... 17:08:25 INFO - TEST-INFO | started process 15241 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfPV4I9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:08:37 INFO - PROCESS | 15241 | RSS: Main: 174444544 17:08:37 INFO - PROCESS | 15241 | 17:08:40 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43237/tests/kraken/driver.html?testName=audio-beat-detection) 17:08:41 INFO - PROCESS | 15241 | RSS: Main: 233639936 17:08:41 INFO - PROCESS | 15241 | 17:08:44 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43237/tests/kraken/driver.html?testName=audio-dft) 17:08:44 INFO - PROCESS | 15241 | RSS: Main: 217952256 17:08:44 INFO - PROCESS | 15241 | 17:08:48 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43237/tests/kraken/driver.html?testName=audio-fft) 17:08:48 INFO - PROCESS | 15241 | RSS: Main: 299573248 17:08:48 INFO - PROCESS | 15241 | 17:08:50 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43237/tests/kraken/driver.html?testName=audio-oscillator) 17:08:51 INFO - PROCESS | 15241 | RSS: Main: 208998400 17:08:51 INFO - PROCESS | 15241 | 17:08:53 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:08:54 INFO - PROCESS | 15241 | RSS: Main: 213172224 17:08:54 INFO - PROCESS | 15241 | 17:08:57 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43237/tests/kraken/driver.html?testName=imaging-darkroom) 17:08:58 INFO - PROCESS | 15241 | RSS: Main: 249556992 17:08:58 INFO - PROCESS | 15241 | 17:09:01 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43237/tests/kraken/driver.html?testName=imaging-desaturate) 17:09:02 INFO - PROCESS | 15241 | RSS: Main: 249561088 17:09:02 INFO - PROCESS | 15241 | 17:09:05 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43237/tests/kraken/driver.html?testName=json-parse-financial) 17:09:05 INFO - PROCESS | 15241 | RSS: Main: 249032704 17:09:05 INFO - PROCESS | 15241 | 17:09:07 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:09:08 INFO - PROCESS | 15241 | RSS: Main: 211468288 17:09:08 INFO - PROCESS | 15241 | 17:09:10 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43237/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:09:10 INFO - PROCESS | 15241 | RSS: Main: 218087424 17:09:10 INFO - PROCESS | 15241 | 17:09:12 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:09:13 INFO - PROCESS | 15241 | RSS: Main: 222220288 17:09:13 INFO - PROCESS | 15241 | 17:09:16 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:09:16 INFO - PROCESS | 15241 | RSS: Main: 223547392 17:09:16 INFO - PROCESS | 15241 | 17:09:19 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:09:20 INFO - PROCESS | 15241 | RSS: Main: 221499392 17:09:20 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | Cycle 1(1): loaded http://localhost:43237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43237/tests/kraken/driver.html?testName=ai-astar) 17:09:22 INFO - PROCESS | 15241 | RSS: Main: 272941056 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | __start_tp_report 17:09:22 INFO - PROCESS | 15241 | _x_x_mozilla_page_load 17:09:22 INFO - PROCESS | 15241 | _x_x_mozilla_page_load_details 17:09:22 INFO - PROCESS | 15241 | |i|pagename|runs| 17:09:22 INFO - PROCESS | 15241 | |0;ai-astar;113;114;115;115;114;115;116;117;115;114 17:09:22 INFO - PROCESS | 15241 | |1;audio-beat-detection;153;123;125;166;127;128;123;122;161;126 17:09:22 INFO - PROCESS | 15241 | |2;audio-dft;162;160;162;162;161;160;163;161;160;161 17:09:22 INFO - PROCESS | 15241 | |3;audio-fft;77;77;76;121;76;84;77;77;100;75 17:09:22 INFO - PROCESS | 15241 | |4;audio-oscillator;84;83;124;83;84;84;110;84;84;121 17:09:22 INFO - PROCESS | 15241 | |5;imaging-gaussian-blur;117;117;117;117;117;117;117;117;118;116 17:09:22 INFO - PROCESS | 15241 | |6;imaging-darkroom;146;147;146;147;146;146;147;148;147;148 17:09:22 INFO - PROCESS | 15241 | |7;imaging-desaturate;97;95;96;96;96;95;96;96;96;95 17:09:22 INFO - PROCESS | 15241 | |8;json-parse-financial;66;64;64;65;65;64;66;66;65;65 17:09:22 INFO - PROCESS | 15241 | |9;json-stringify-tinderbox;66;67;65;66;67;66;68;67;66;67 17:09:22 INFO - PROCESS | 15241 | |10;stanford-crypto-aes;86;88;82;82;82;83;84;82;82;83 17:09:22 INFO - PROCESS | 15241 | |11;stanford-crypto-ccm;135;142;130;132;135;132;138;132;180;135 17:09:22 INFO - PROCESS | 15241 | |12;stanford-crypto-pbkdf2;174;178;170;174;175;172;172;172;178;172 17:09:22 INFO - PROCESS | 15241 | |13;stanford-crypto-sha256-iterative;72;68;68;68;72;68;69;71;72;69 17:09:22 INFO - PROCESS | 15241 | __end_tp_report 17:09:22 INFO - PROCESS | 15241 | __start_cc_report 17:09:22 INFO - PROCESS | 15241 | _x_x_mozilla_cycle_collect,1984 17:09:22 INFO - PROCESS | 15241 | __end_cc_report 17:09:22 INFO - PROCESS | 15241 | __startTimestamp1474330162520__endTimestamp 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | ------- Summary: start ------- 17:09:22 INFO - PROCESS | 15241 | Number of tests: 14 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#0] ai-astar Cycles:10 Average:114.80 Median:115.00 stddev:1.14 (1.0%) stddev-sans-first:1.00 17:09:22 INFO - PROCESS | 15241 | Values: 113.0 114.0 115.0 115.0 114.0 115.0 116.0 117.0 115.0 114.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#1] audio-beat-detection Cycles:10 Average:135.40 Median:127.50 stddev:17.35 (13.6%) stddev-sans-first:17.20 17:09:22 INFO - PROCESS | 15241 | Values: 153.0 123.0 125.0 166.0 127.0 128.0 123.0 122.0 161.0 126.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.50 stddev:1.03 (0.6%) stddev-sans-first:1.05 17:09:22 INFO - PROCESS | 15241 | Values: 162.0 160.0 162.0 162.0 161.0 160.0 163.0 161.0 160.0 161.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#3] audio-fft Cycles:10 Average:84.00 Median:77.00 stddev:15.02 (19.5%) stddev-sans-first:15.71 17:09:22 INFO - PROCESS | 15241 | Values: 77.0 77.0 76.0 121.0 76.0 84.0 77.0 77.0 100.0 75.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:84.00 stddev:17.08 (20.3%) stddev-sans-first:17.73 17:09:22 INFO - PROCESS | 15241 | Values: 84.0 83.0 124.0 83.0 84.0 84.0 110.0 84.0 84.0 121.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.47 (0.4%) stddev-sans-first:0.50 17:09:22 INFO - PROCESS | 15241 | Values: 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 116.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 17:09:22 INFO - PROCESS | 15241 | Values: 146.0 147.0 146.0 147.0 146.0 146.0 147.0 148.0 147.0 148.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.50 17:09:22 INFO - PROCESS | 15241 | Values: 97.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 96.0 95.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#8] json-parse-financial Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 17:09:22 INFO - PROCESS | 15241 | Values: 66.0 64.0 64.0 65.0 65.0 64.0 66.0 66.0 65.0 65.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#9] json-stringify-tinderbox Cycles:10 Average:66.50 Median:67.00 stddev:0.85 (1.3%) stddev-sans-first:0.88 17:09:22 INFO - PROCESS | 15241 | Values: 66.0 67.0 65.0 66.0 67.0 66.0 68.0 67.0 66.0 67.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.07 (2.5%) stddev-sans-first:1.96 17:09:22 INFO - PROCESS | 15241 | Values: 86.0 88.0 82.0 82.0 82.0 83.0 84.0 82.0 82.0 83.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#11] stanford-crypto-ccm Cycles:10 Average:139.10 Median:135.00 stddev:14.78 (11.0%) stddev-sans-first:15.61 17:09:22 INFO - PROCESS | 15241 | Values: 135.0 142.0 130.0 132.0 135.0 132.0 138.0 132.0 180.0 135.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.70 Median:174.00 stddev:2.67 (1.5%) stddev-sans-first:2.83 17:09:22 INFO - PROCESS | 15241 | Values: 174.0 178.0 170.0 174.0 175.0 172.0 172.0 172.0 178.0 172.0 17:09:22 INFO - PROCESS | 15241 | 17:09:22 INFO - PROCESS | 15241 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.70 Median:70.00 stddev:1.83 (2.6%) stddev-sans-first:1.74 17:09:22 INFO - PROCESS | 15241 | Values: 72.0 68.0 68.0 68.0 72.0 68.0 69.0 71.0 72.0 69.0 17:09:22 INFO - PROCESS | 15241 | -------- Summary: end -------- 17:09:22 INFO - PROCESS | 15241 | 17:09:23 INFO - TEST-INFO | 15241: exit 0 17:09:23 INFO - TEST-OK | kraken | took 64797ms 17:09:23 INFO - SUITE-END | took 1186s 17:09:24 INFO - Completed test suite (00:19:47) 17:09:24 INFO - javascript benchmark 17:09:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2512.62310653402, 2581.754733300336, 2608.934776630585, 2609.0737788085235, 2628.3034995726134, 4600.240960241556, 4685.929711054337, 4731.550502702246, 4746.145693775119, 4766.8093276268955, 4702.694324868881, 4712.505186955372, 4715.552022557851, 4722.811087556503, 4772.188727916254, 4296.63478604319, 4315.223259813232, 4333.783310834461, 4344.913101737963, 4418.0, 4412.338149277602, 4413.3159360299205, 4435.778211089449, 4448.6885917985755, 4495.955040449587, 4284.9143017139795, 4337.63130133939, 4423.380726698265, 4423.424954755861, 4424.093060922503, 4366.235908715994, 4384.386185933972, 4385.3641222022625, 4389.31965545341, 4390.890227744332, 4292.29177185764, 4330.610245077926, 4333.696641235115, 4356.934645980313, 4359.738415695068, 4732.408448943882, 4750.548697873696, 4755.262934245197, 4818.831340903087, 4843.273508973647, 5101.617378696613, 5111.693298402108, 5114.514121158484, 5116.820911268125, 5119.744012799345, 4983.401991760976, 5023.497650234947, 5070.442251352385, 5086.54221120101, 5190.844274671766, 4734.171519983989, 4736.881577960509, 4739.644526660514, 4788.9521104788855, 4789.018251258483, 5141.048905952336, 5183.352080989876, 5187.870303242449, 5191.792328306826, 5241.318628578337, 4845.1278769821065, 4899.485554016848, 4964.255361695775, 4987.800487980513, 5037.219231019198, 5025.14572522672, 5040.243963405518, 5051.292819005343, 5096.261042148868, 5176.534111929869, 5019.0463811875625, 5036.748162591855, 5066.392032956069, 5124.436312005676, 5127.64106512548, 4905.23968784839, 4964.304997300381, 5024.0956627807345, 5042.218456139304, 5057.772400241998, 4329.0, 4334.934975975363, 4369.781510924441, 4386.692931494828, 4393.846215382447, 3757.0, 3774.245150969817, 3782.319182547168, 3793.696504279706, 3832.827522761482, 4264.445622069111, 4290.163418133434, 4309.1381723655395, 4349.717268377545, 4357.3899654048455, 5082.923756143587, 5085.644004919694, 5109.718965456861, 5165.612579056586, 5167.044096842096, 4322.027543802619, 4329.437173167468, 4332.090261045153, 4336.566343365701, 4378.540253273424, 4472.508024117345, 4517.0, 4587.03672228829, 4589.885252868638, 4628.791704373311, 4737.502562231054, 4794.664373493822, 4809.639277054165, 4810.975945120392, 4844.806207751651, 5134.871628209325, 5142.537171654569, 5146.022255771391, 5149.0474262261605, 5207.453217412117, 4688.0858232644305, 4801.831935882227, 4811.302361157543, 4813.205821039489, 4867.318575399376, 4975.676581022222, 4999.075171093359, 5015.724135172601, 5042.117629414764, 5101.438841727481, 5061.898762024665, 5068.265101560327, 5071.290019397361, 5071.873203169803, 5129.153689641316, 4920.975395123001, 4926.162552366178, 4929.211326187793, 4931.654784165074, 4991.900161996812, 4862.659613826998, 4881.682690625098, 4905.166121759381, 4949.901001979868, 4965.776540055634, 4896.485868983706, 4910.558049775537, 4929.112759703288, 4942.8022879085875, 4947.727874966911, 4847.636427268039, 4899.387576552931, 5055.51972562606, 5056.115179843439, 5062.0888240115655, 4852.320675105418, 4917.188663870421, 4983.202687569971, 4990.076835785391, 5020.49795020495], "value": 4662.932322603512, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [554.6145428926897, 562.4291344285548, 565.5701666733281, 566.5807302596078, 581.4011568084874, 27910.86044569777, 38758.806205969, 39925.60074399255, 40102.7994860026, 43478.34782478266, 39532.80233598835, 39875.20249595006, 39895.0, 39896.202075958536, 39957.0, 7611.12472065714, 7733.149353571102, 7741.3419859312025, 7748.263914928101, 7753.651085701157, 7594.54432734035, 7678.270564296383, 7679.8080047998965, 7683.884741728879, 7687.269709377628, 7687.461877668566, 7721.382289416833, 7722.073351197836, 7731.961340193319, 7736.07167139944, 7681.3470854977395, 7718.884216736697, 7720.57536835471, 7721.112072111723, 7726.459147859652, 7603.619819009083, 7661.65522551481, 7662.348700360476, 7663.042119735033, 7667.463277570572, 36418.08954776125, 36571.63428365709, 36656.0, 36665.633343666486, 36673.44989825155, 2908.5200941844782, 2974.449726800549, 3218.308063766278, 3260.7228385587255, 3570.6786389224835, 27708.584371234447, 27955.301117472227, 28141.57787633187, 28356.43287134246, 28419.431611367658, 3023.3650933304034, 3073.661897191307, 3135.608048993876, 3147.040152753409, 3250.0249925022636, 249276.0, 250416.74791626108, 250899.0, 250955.0, 252285.0, 31275.84362078175, 32298.35403291921, 50017.0, 50361.0, 50404.49595503998, 32772.0, 33059.33881322408, 33123.0, 33124.834375827966, 33133.66866331354, 13566.253856037816, 13678.31608419575, 13689.452421903212, 13696.0, 13697.0, 11314.830277545843, 11392.0, 11396.430178491042, 11398.430078496041, 11401.828972565418, 7664.425168112414, 7699.576523291273, 7738.0, 7761.0, 7775.22247775218, 2957.4676558219726, 3015.8642861071303, 3019.245188702824, 3039.452898478251, 3090.7218350348576, 758.4501236603529, 766.2299389113905, 777.4324742937574, 799.9600019998977, 803.4817542684935, 25651.486970260492, 27366.0, 27782.444351112863, 27805.0, 28194.71805281962, 712.5582139073807, 852.3607294529103, 906.1210625693067, 919.2048877720857, 973.7195587802017, 13975.440982360591, 14351.497697580535, 14410.207438590978, 14746.557603271918, 14837.777433338508, 363534.0, 364377.0, 365808.0, 368232.0, 370762.0, 46628.3005754914, 47346.289805652945, 47473.5252647476, 47757.283640745416, 47770.0, 1050.3960222871879, 1055.0451841083832, 1062.458146345354, 1126.357975953715, 1136.1762722026465, 25846.353841154123, 28514.714852851204, 28766.856165719037, 29037.27406814762, 29130.0, 39700.80149599349, 40272.0, 40332.798336008134, 40347.3947890776, 40356.798216008734, 234083.0, 234991.0, 235330.0, 235550.0, 235942.0, 24317.878410607835, 24454.0, 25126.12058577941, 25435.491290174465, 25829.3542661435, 39813.80093099516, 40226.79886600548, 40366.79816600898, 40687.1862562753, 41099.58900410958, 34284.31431371409, 34302.0, 34385.312293753486, 34662.82668586641, 34885.30229395347, 34174.65825341715, 34641.82679086588, 34688.479672804424, 34846.303073937874, 35182.47226291659, 33901.66098339084, 34717.652823472454, 34795.0, 34842.65157348394, 34892.47661285134, 29985.400291994476, 31469.22650471196, 31775.504694483127, 31975.36049278955, 32928.341433171685, 23966.76033239715, 24217.757822422256, 24407.18909557384, 24465.38836529101, 24809.503809924063], "value": 15779.6517623444, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.1979726831019, 367.7058353317347, 370.6552905797608, 375.8609314553615, 393.9074317535379, 12367.650146472175, 15642.217889105543, 15940.130776460233, 16013.0, 16804.57988550287, 16006.43977460789, 16035.198240087979, 16613.584660383498, 16816.0, 16897.493075207734, 4893.657443978923, 4921.261810728383, 5027.949720502785, 5066.0, 5148.845534633967, 3690.5940346561856, 3868.864589739346, 4989.925151122736, 5070.569001634865, 5072.898542029157, 5604.327480702301, 5864.824055278327, 5883.0881213411985, 5955.851103722398, 5979.970100149493, 5715.142728590703, 5856.355800861902, 5898.4101589840675, 5944.078667806497, 5957.582969192158, 5208.739563021872, 5208.906129712765, 5213.4004589472315, 5216.400113986902, 5217.921731174036, 19228.423147305602, 20584.27955021567, 20655.5868882623, 20693.793062069486, 20754.028367305084, 1728.809830918598, 1794.443722446046, 1823.361823361826, 2013.536886516095, 2316.131450705985, 12653.240805551604, 13344.399502022336, 13696.794548081787, 13935.233562154077, 13956.162630242117, 1664.933402663892, 1731.1084791332473, 1734.5923707928628, 1779.288284686123, 1795.111419847184, 67745.66127169333, 67880.0, 69032.654836726, 70315.99999999949, 71588.6420567899, 9455.0, 9675.516224188763, 9892.004537708412, 9926.30515863897, 10177.949110254402, 13566.79649805234, 13577.321133943264, 13600.523981660792, 13604.795928061087, 13607.863921360859, 7002.579845209202, 7139.428845692332, 7323.926760732431, 7412.369948554326, 7420.740274090381, 6660.267370589231, 6697.933020669829, 6796.082528858639, 6895.448364130857, 6982.650867456607, 6104.908426373608, 6115.602485838406, 6119.5410344224365, 6135.662538560422, 6185.103160041769, 1722.9483115506555, 1739.782527184102, 1746.2054765081857, 1772.7163653815585, 1795.4882858385297, 735.3602365941558, 859.9398042137116, 883.3330835219497, 926.8517037274004, 929.2658799548282, 16280.267387967333, 16598.6680266394, 17018.659626807643, 17110.486685399457, 18093.45719628387, 750.1748077115238, 830.5390508267969, 831.3723139029994, 853.2832420766462, 892.8705337726124, 7403.85192296151, 9131.634734610541, 9607.087326703951, 9701.369410988404, 9785.119339259501, 398384.0, 398413.0, 405048.0, 422419.0, 427138.0, 46529.0, 53279.0, 74939.25060749432, 78112.21887781163, 79362.6031869837, 925.509479975614, 934.6448349627099, 942.1520631431766, 949.8195342884829, 953.02315126994, 14741.705165896836, 15104.0, 15153.621159471102, 15633.218339082772, 15692.450764223197, 36026.27947440984, 36349.27301454009, 36574.69666898338, 37137.25725485529, 37650.81174594109, 48304.0, 49783.502164979334, 49878.75060624674, 49907.75046124746, 50932.745336274565, 6973.442124629916, 7161.4270858330165, 7292.088488938883, 7347.742829000959, 7552.509086909553, 10027.699169024942, 10605.0, 11024.50389732448, 11190.66428007161, 11199.216054876406, 8945.15021072997, 9132.452052876848, 9294.395864268801, 9991.450470224207, 10027.699169024942, 8834.381593288665, 9897.901020989699, 9979.0, 10568.418736969541, 10801.081908037904, 9665.806683866424, 9842.21262299, 10145.239107066853, 10357.585696572052, 10360.274780765274, 7407.370373518312, 7733.188015258542, 7860.724874629361, 7922.920770792219, 7963.960180199062, 9647.228221742384, 9717.6598819041, 10216.131628811634, 10230.948845255725, 10894.0], "value": 8213.273019417074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1057.249352959399, 1083.7453198498351, 1230.4647478346926, 1233.3463264469833, 1243.2602601452136, 6398.9680051599735, 7297.379722723568, 7546.1321947976, 7552.886706699397, 7569.432292578065, 7613.581253031081, 7674.695301798693, 7686.26980436859, 7693.576853273068, 7697.653605587748, 2137.871727696343, 2160.7299087614047, 2163.6862654915108, 2166.6425039868404, 2166.772488888668, 2078.449210959097, 2127.2022991378235, 2146.4848436375237, 2147.066026278566, 2157.0, 2023.8482113841446, 2028.3712049264702, 2039.2964427272568, 2039.3474088291753, 2076.501639606491, 2103.5582527669208, 2106.2206983416236, 2110.029386482228, 2111.039477037944, 2111.1344348817065, 2033.217211373617, 2107.7259956205594, 2114.1015068595784, 2116.227576934408, 2116.544942837297, 7282.162551306562, 7388.408927285805, 7396.70413183472, 7549.207333229987, 7600.657970391346, 4294.828206871722, 4469.3296005599095, 4495.2133376659285, 4503.482099558527, 4503.48209955856, 2671.666041744782, 2771.4180022195364, 2807.536756435186, 2810.985945070282, 2822.4919514487383, 932.2868005975434, 945.4705364995624, 967.8983706710835, 972.5040229482944, 993.0268337029679, 10170.644027459077, 10228.795424091551, 10299.124574411184, 10300.27898047137, 10300.330478518872, 3977.463042489285, 4003.6596889264156, 4134.937975930364, 4149.170165966759, 4177.081042170778, 7870.094939081964, 7950.045994480699, 7951.125376208613, 7951.165127661628, 7956.2043795619975, 4241.597048280409, 4249.830006799693, 4254.468191476066, 4255.021345090647, 4258.041940563348, 3484.4599087141532, 3582.7850328980344, 3959.030037640739, 3960.881173564798, 4071.1450595375304, 3355.4463513520486, 3362.6045191245357, 3483.9825800870835, 3501.6673416025437, 3509.12271932017, 1013.4020927652721, 1016.8423894296396, 1022.2895087913829, 1030.5311083457009, 1045.174312293295, 631.766246488802, 725.1407082607127, 730.2879692300071, 739.3936971683169, 769.9384049276044, 4492.842750503717, 4494.280915053576, 4520.59314661682, 4600.35595016698, 4825.782839772219, 392.3330338424689, 394.7138324714616, 397.30471674569503, 401.7368623551578, 404.30056003114777, 2883.6972117927735, 3053.4045861057325, 3117.0648805358755, 3131.749460043191, 3150.6534281229046, 8549.743507694779, 9248.537573121317, 9308.534573271309, 9318.0, 9341.859872101924, 9257.0, 9259.02780208082, 9264.490453025013, 9282.164605185566, 9282.860757088649, 6908.861822763617, 7007.614581197981, 7065.364117229474, 7071.29287071299, 7081.539699919592, 4398.516163222107, 4410.382546443437, 4443.577860103285, 4456.131054444482, 4551.8634440966825, 8500.36247281444, 8502.44734092282, 8585.012723536624, 8589.098144694717, 8638.308935285288, 8549.145085491402, 8570.100139485265, 8686.652533898574, 8700.651973921225, 8734.475931444134, 5352.5985551084605, 5480.10936227001, 6033.396660333931, 6109.541784366279, 6114.908276375769, 7034.859302813813, 7119.038929744625, 7248.130224373109, 7408.111026676834, 7432.739854105297, 6542.084108224757, 6599.769008084694, 6607.431986727113, 6775.322467753185, 6786.626735529593, 6369.9681501592195, 6394.680265986589, 6449.12936753551, 6510.934890651222, 6521.413072823469, 5791.391903850204, 5878.441548052928, 5883.264591926009, 5891.58758886891, 5897.3807750185615, 3888.2612303662213, 3909.257241124177, 3991.1219531702977, 4008.7394319369146, 4092.2633925893624, 3988.222296652125, 3991.401289806436, 4017.0, 4092.5293591237387, 4183.016991007172], "value": 3781.3441249020484, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.6900316661172, 293.0373722322172, 294.6375957572186, 295.5891311077604, 303.36142420205465, 4963.702177869326, 4967.205247160446, 4974.204127339617, 4975.6019518438525, 4983.202687569985, 4834.419869615642, 4836.806527738886, 4869.464358920524, 4882.8779280518, 4921.212605983043, 3625.836837342326, 3756.511653485043, 3771.1703425246537, 3842.1355195081164, 3849.3840985442334, 3822.8661996830115, 3828.8851334459873, 3832.693384529231, 3840.2511510255513, 3852.8266228019666, 3797.3354662934016, 3803.1442925341853, 3806.3529200035923, 3818.713596480261, 3819.178876541543, 3617.8914632561064, 3691.6123807000145, 3706.888793336177, 3799.9620003799882, 3822.636849499293, 3369.4608862581867, 3372.5109859070544, 3386.7121294689982, 3392.7625066245373, 3396.524486571882, 4751.453582837983, 4756.524347565216, 4772.236442169271, 4775.474697783241, 4785.234362502018, 4158.584141585848, 4329.870103896888, 4359.716618419792, 4390.363397307373, 4400.889977750549, 5019.498050194988, 5027.170516864713, 5047.570956468705, 5054.721990290533, 5091.770870310845, 3678.503402040717, 3693.0, 3720.7581507201944, 3738.4018557030745, 3745.8127093645207, 5086.262491938685, 5419.783208671648, 5432.674039557639, 5447.992121457543, 5449.754761035723, 3605.170810713498, 3658.359787037258, 3661.2677464507206, 3676.191237927652, 3684.428913518409, 3735.458358537997, 3757.4363845423404, 3757.680597149218, 3760.2855457462992, 3761.39817629178, 4308.91382172361, 4309.288967320357, 4313.460817397825, 4330.328799036154, 4343.9348409773875, 4830.661853670209, 5051.646384753106, 5110.2590124431745, 5141.691498510027, 5192.402873669576, 1280.36621872172, 1300.07694536878, 1300.8634093420244, 1308.4242933109401, 1310.9737805243842, 794.582844006901, 817.6279792694429, 833.2001278772325, 838.1869586501084, 842.4355681693157, 4324.200022995693, 4331.722141968127, 4427.048184640318, 4512.954870451319, 4532.093581283756, 5299.205119232146, 5307.310049693515, 5321.973390133025, 5325.866853328698, 5335.493128152819, 4506.639468842484, 4520.819167233274, 4521.186186486399, 4523.5024147343765, 4528.9094218116115, 2654.9203523894316, 2775.6391669083296, 2804.8036637435594, 2817.60553522507, 2828.349479619699, 4957.206846904478, 4961.206207006934, 4962.206047032458, 4986.850394488099, 4997.475265097185, 5173.22401639757, 5406.6215364924865, 5413.2150838128255, 5426.186072089139, 5426.8371948841595, 4941.530554597308, 4942.5057494251005, 4946.307516947558, 4953.529414705597, 5005.6996580205305, 5243.872567398028, 5258.947410525999, 5263.289455923401, 5294.629375943801, 5319.25530425733, 5006.774695138801, 5202.973985130202, 5217.295665085317, 5242.68543887368, 5246.921296180637, 4922.483139270325, 4940.456549779593, 4950.430700469492, 4959.479254678206, 4959.62802789785, 3684.3368193725387, 3718.5165928429133, 3719.702423806143, 3745.756525825813, 3747.2130852521277, 5059.671121377099, 5329.946700532945, 5330.387005494418, 5339.172428273624, 5368.785248590013, 5119.48805119485, 5155.381354237516, 5164.173732202829, 5172.5344718975475, 5174.741262936763, 5108.897822043464, 5115.15599926023, 5137.640365174402, 5143.92284115731, 5166.586673066221, 4815.398075240595, 5018.172001619838, 5056.696598204119, 5057.367829021372, 5075.974620126875, 4902.264660300983, 5029.736618521607, 5064.898702026013, 5137.8201762938115, 5150.742462876916, 5037.471065538212, 5055.418626857959, 5059.46875578059, 5063.392392912874, 5080.949190508048], "value": 3848.6347183493117, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [661.7915356662647, 675.166169780321, 687.1376422589651, 710.3500297228037, 742.8625704244715, 12518.749625007506, 13540.796888046687, 13541.255230962293, 13571.457141714332, 13608.523701670443, 13295.135816171965, 13513.594592162226, 13541.796873046913, 13546.729065418685, 13563.118397304193, 593.783269106775, 608.8477880529867, 719.7229066809277, 726.8182954261434, 738.9298016688406, 734.5409119300438, 743.929326713964, 744.0773440933258, 744.1776836595565, 744.6686224630042, 787.8621241282781, 788.7357735158729, 789.34090034821, 790.0716657926913, 790.3084800799301, 618.9195404597418, 631.962082275065, 775.4881778026476, 788.0228516639384, 793.333599776185, 557.4759725857681, 557.956621118507, 558.0680263959198, 561.1526594841778, 561.2535328013732, 13118.147320424141, 13128.0, 13140.408681609351, 13151.736965260738, 13165.473381064747, 12783.233006019576, 13457.730845383136, 13512.783849453597, 13529.0, 13571.0, 10411.479426028669, 10424.322419042814, 10673.0, 10795.514201860935, 11096.389698566576, 3193.6646652101426, 3227.4190645683766, 3281.2453135778906, 3364.2262279675565, 3374.1395944034116, 66933.66533167352, 66990.33009669889, 67604.66197669029, 68638.65680671614, 71200.0, 10186.0, 10213.08082272599, 10541.947290263653, 10691.198160138021, 10795.568177272979, 17579.64840703179, 17627.0, 17633.823661763476, 17645.38241161553, 17646.735298970525, 6665.200175978914, 6708.960111182774, 6741.696623651947, 6804.149481314836, 6892.069570608004, 3257.9674203258137, 3483.198864261234, 3540.539729835105, 3654.8172591370326, 3767.3030489359558, 2728.9044883428983, 2785.2758282846203, 2810.1990932584117, 2812.943741125166, 2817.337925587485, 473.76311844077964, 478.45695136020174, 483.8862867226199, 487.1596496044366, 495.2076677316337, 429.54682809636137, 460.3072376074054, 460.64300167370556, 467.16377683946035, 531.1289485244203, 7202.53183543068, 7725.845483090419, 7844.150680846789, 7914.129445760962, 8310.750677479686, 450.66875846252975, 488.2578480709373, 497.2119191082175, 529.5578192209548, 547.0836349115216, 3513.402721537345, 3762.3792074307435, 3791.8483260669263, 3920.2747491714126, 3964.742291751085, 101461.49269253755, 103402.0, 104462.0, 107467.0, 107520.0, 50759.0, 62272.06591901125, 88769.55615222012, 90059.54970225107, 93399.53300233591, 78946.0, 79670.0, 80293.99999999884, 80544.0, 81040.0, 7087.22040575526, 7172.246914074156, 7517.962410187914, 7635.350995165251, 7654.923450765644, 43990.340144898495, 45082.774586126856, 45269.54730452653, 45889.0, 46582.0, 43754.78122609366, 64477.35522644901, 64571.15716321389, 65155.34844651682, 67516.52219122859, 9033.728988130366, 9074.954625226832, 9191.21874640663, 9324.580393882155, 9552.952235239058, 9819.36174148678, 10015.39907605546, 10034.147097496794, 10133.79732405333, 10280.742981425525, 9551.474668893277, 9662.903370966482, 9673.613055477703, 9827.901720982698, 10144.746381340525, 9091.363604547883, 9277.721668349961, 9457.10157535033, 9493.0981556752, 9817.55820988043, 9117.90882091197, 9324.533773311172, 9834.606615735576, 9899.802003960025, 10313.329633573794, 8061.596920154087, 8084.83830323402, 8132.715354962548, 8151.755447336589, 8829.69096081634, 7897.24976127267, 7899.447038707235, 7973.20267973198, 8443.493390396596, 8674.783130421538], "value": 6159.819123642481, "unit": "score"}], "name": "dromaeo_css", "value": 6151.395156780928, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [113.0, 114.0, 115.0, 115.0, 114.0, 115.0, 116.0, 117.0, 115.0, 114.0], "value": 114.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 125.0, 166.0, 127.0, 128.0, 123.0, 122.0, 161.0, 126.0], "value": 135.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 162.0, 162.0, 161.0, 160.0, 163.0, 161.0, 160.0, 161.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 121.0, 76.0, 84.0, 77.0, 77.0, 100.0, 75.0], "value": 84.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 124.0, 83.0, 84.0, 84.0, 110.0, 84.0, 84.0, 121.0], "value": 94.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 116.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 147.0, 148.0, 147.0, 148.0], "value": 146.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 64.0, 65.0, 65.0, 64.0, 66.0, 66.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 65.0, 66.0, 67.0, 66.0, 68.0, 67.0, 66.0, 67.0], "value": 66.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 88.0, 82.0, 82.0, 82.0, 83.0, 84.0, 82.0, 82.0, 83.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [135.0, 142.0, 130.0, 132.0, 135.0, 132.0, 138.0, 132.0, 180.0, 135.0], "value": 139.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 178.0, 170.0, 174.0, 175.0, 172.0, 172.0, 172.0, 178.0, 172.0], "value": 173.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 68.0, 68.0, 68.0, 72.0, 68.0, 69.0, 71.0, 72.0, 69.0], "value": 69.7, "unit": "score"}], "name": "kraken", "value": 1546.5, "alertThreshold": 2.0}]} 17:09:24 INFO - Return code: 0 17:09:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 17:09:24 INFO - # TBPL SUCCESS # 17:09:24 INFO - Running post-action listener: _resource_record_post_action 17:09:24 INFO - [mozharness: 2016-09-20 00:09:24.328238Z] Finished run-tests step (success) 17:09:24 INFO - Running post-run listener: _resource_record_post_run 17:09:24 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 385789952; Read time: 16; Write time: 227112 17:09:24 INFO - TinderboxPrint: CPU usage
13.1% 17:09:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 17:09:24 INFO - TinderboxPrint: I/O write bytes / time
385,789,952 / 227,112 17:09:24 INFO - TinderboxPrint: CPU idle
8,344.6 (86.9%) 17:09:24 INFO - TinderboxPrint: CPU user
1,202.8 (12.5%) 17:09:24 INFO - TinderboxPrint: Swap in / out
0 / 0 17:09:24 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99008512; Read time: 0; Write time: 73792 17:09:24 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 286781440; Read time: 0; Write time: 153320 17:09:24 INFO - Running post-run listener: _upload_blobber_files 17:09:24 INFO - Blob upload gear active. 17:09:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:09:24 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 17:09:24 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'] 17:09:24 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 17:09:25 INFO - (blobuploader) - INFO - Open directory for files ... 17:09:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:09:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:09:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:26 INFO - (blobuploader) - INFO - Done attempting. 17:09:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:09:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:09:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:26 INFO - (blobuploader) - INFO - Done attempting. 17:09:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 17:09:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:09:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:09:30 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 17:09:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:09:30 INFO - (blobuploader) - INFO - Done attempting. 17:09:30 INFO - (blobuploader) - INFO - Iteration through files over. 17:09:30 INFO - Return code: 0 17:09:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:09:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:09:30 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e099328aaf4cde209031429eb1bd620813549e2708c837d68a3f812d7847df9dd78f0fbe1a5139f5628d6ed672f9e7f2e26215b5b3bb1ddeb8f128dcd7925fe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90b12dc64cc998e780af2a93fef3806bbfd7648e6c4d9b4c6a839f4e43f278ded9c67ec4e3da8d78cbd5b632433a55a2276c78486517ae2ee6c02ef2ae6dea90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef97c040e1e3735032e6152224a447da7a9f7b89c03e50d7f4456b4b23b8a555940f243c1d812a0d2718c696ae21934e5a195f98f67825b0231f19813fe73ab3"} 17:09:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:09:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:09:30 INFO - Contents: 17:09:30 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e099328aaf4cde209031429eb1bd620813549e2708c837d68a3f812d7847df9dd78f0fbe1a5139f5628d6ed672f9e7f2e26215b5b3bb1ddeb8f128dcd7925fe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90b12dc64cc998e780af2a93fef3806bbfd7648e6c4d9b4c6a839f4e43f278ded9c67ec4e3da8d78cbd5b632433a55a2276c78486517ae2ee6c02ef2ae6dea90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef97c040e1e3735032e6152224a447da7a9f7b89c03e50d7f4456b4b23b8a555940f243c1d812a0d2718c696ae21934e5a195f98f67825b0231f19813fe73ab3"} 17:09:30 INFO - Running post-run listener: copy_logs_to_upload_dir 17:09:30 INFO - Copying logs to upload dir... 17:09:30 INFO - mkdir: /builds/slave/test/build/upload/logs 17:09:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.157092 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-19 17:09:29.834685) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 17:09:29.838477) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778 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/e099328aaf4cde209031429eb1bd620813549e2708c837d68a3f812d7847df9dd78f0fbe1a5139f5628d6ed672f9e7f2e26215b5b3bb1ddeb8f128dcd7925fe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90b12dc64cc998e780af2a93fef3806bbfd7648e6c4d9b4c6a839f4e43f278ded9c67ec4e3da8d78cbd5b632433a55a2276c78486517ae2ee6c02ef2ae6dea90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef97c040e1e3735032e6152224a447da7a9f7b89c03e50d7f4456b4b23b8a555940f243c1d812a0d2718c696ae21934e5a195f98f67825b0231f19813fe73ab3"} build_url:https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011411 build_url: 'https://queue.taskcluster.net/v1/task/WKFZ5S4ETjOONy_6wg3hjg/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/e099328aaf4cde209031429eb1bd620813549e2708c837d68a3f812d7847df9dd78f0fbe1a5139f5628d6ed672f9e7f2e26215b5b3bb1ddeb8f128dcd7925fe5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/90b12dc64cc998e780af2a93fef3806bbfd7648e6c4d9b4c6a839f4e43f278ded9c67ec4e3da8d78cbd5b632433a55a2276c78486517ae2ee6c02ef2ae6dea90", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/ef97c040e1e3735032e6152224a447da7a9f7b89c03e50d7f4456b4b23b8a555940f243c1d812a0d2718c696ae21934e5a195f98f67825b0231f19813fe73ab3"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-19 17:09:29.864866) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 17:09:29.865250) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1474328921.146761-1276915778 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004452 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-19 17:09:29.949185) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 17:09:29.949536) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-19 17:09:29.949863) ========= ========= Total master_lag: 0.17 =========