builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1473360485.05 results: success (0) buildid: 20160908102019 builduid: 03487f857bb34d4e8a81434c2d1967ea revision: 4969ca354b5c3888a42ec55e5da09420f0f7033e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:05.050924) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:05.051496) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:05.051885) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:05.064596) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:05.065241) ========= 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-1473360484.819581-309660620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-08 11:48:05-- 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% 21.0M=0.001s 2016-09-08 11:48:05 (21.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125321 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:05.205942) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:05.206767) ========= 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-1473360484.819581-309660620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019785 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:05.259145) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:05.259577) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4969ca354b5c3888a42ec55e5da09420f0f7033e --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 4969ca354b5c3888a42ec55e5da09420f0f7033e --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-1473360484.819581-309660620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-08 11:48:05,795 truncating revision to first 12 chars 2016-09-08 11:48:05,796 Setting DEBUG logging. 2016-09-08 11:48:05,796 attempt 1/10 2016-09-08 11:48:05,796 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4969ca354b5c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-08 11:48:06,196 unpacking tar archive at: autoland-4969ca354b5c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.747897 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:06.025780) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:06.026685) ========= script_repo_revision: 4969ca354b5c3888a42ec55e5da09420f0f7033e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:06.027780) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:06.028571) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-08 11:48:06.040620) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-08 11:48:06.040933) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:48:06 INFO - MultiFileLogger online at 20160908 11:48:06 in /builds/slave/test 11:48:06 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 11:48:06 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:48:06 INFO - {'append_to_log': False, 11:48:06 INFO - 'base_work_dir': '/builds/slave/test', 11:48:06 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 11:48:06 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:48:06 INFO - 'branch': 'Autoland-Non-PGO', 11:48:06 INFO - 'buildbot_json_path': 'buildprops.json', 11:48:06 INFO - 'config_files': ('talos/linux_config.py',), 11:48:06 INFO - 'default_actions': ('clobber', 11:48:06 INFO - 'read-buildbot-config', 11:48:06 INFO - 'download-and-extract', 11:48:06 INFO - 'populate-webroot', 11:48:06 INFO - 'create-virtualenv', 11:48:06 INFO - 'install', 11:48:06 INFO - 'run-tests'), 11:48:06 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:48:06 INFO - 'download_minidump_stackwalk': True, 11:48:06 INFO - 'download_symbols': 'ondemand', 11:48:06 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:48:06 INFO - 'tooltool.py': '/tools/tooltool.py', 11:48:06 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:48:06 INFO - '/tools/misc-python/virtualenv.py')}, 11:48:06 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:48:06 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:48:06 INFO - 'installer_path': 'installer.exe', 11:48:06 INFO - 'log_level': 'info', 11:48:06 INFO - 'log_name': 'talos', 11:48:06 INFO - 'log_to_console': True, 11:48:06 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:48:06 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:48:06 INFO - 'opt_config_files': (), 11:48:06 INFO - 'pip_index': False, 11:48:06 INFO - 'sps_profile': False, 11:48:06 INFO - 'sps_profile_interval': 0, 11:48:06 INFO - 'suite': 'dromaeojs', 11:48:06 INFO - 'system_bits': '32', 11:48:06 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:48:06 INFO - 'title': 'talos-linux64-ix-051', 11:48:06 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:48:06 INFO - 'use_talos_json': True, 11:48:06 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:48:06 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:48:06 INFO - 'work_dir': 'build'} 11:48:06 INFO - [mozharness: 2016-09-08 18:48:06.676714Z] Running clobber step. 11:48:06 INFO - Running pre-action listener: _resource_record_pre_action 11:48:06 INFO - Running main action method: clobber 11:48:06 INFO - rmtree: /builds/slave/test/build 11:48:06 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:48:07 INFO - Running post-action listener: _resource_record_post_action 11:48:07 INFO - [mozharness: 2016-09-08 18:48:07.150244Z] Finished clobber step (success) 11:48:07 INFO - [mozharness: 2016-09-08 18:48:07.150345Z] Running read-buildbot-config step. 11:48:07 INFO - Running pre-action listener: _resource_record_pre_action 11:48:07 INFO - Running main action method: read_buildbot_config 11:48:07 INFO - Using buildbot properties: 11:48:07 INFO - { 11:48:07 INFO - "project": "", 11:48:07 INFO - "product": "firefox", 11:48:07 INFO - "script_repo_revision": "production", 11:48:07 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 11:48:07 INFO - "repository": "", 11:48:07 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 11:48:07 INFO - "buildid": "20160908102019", 11:48:07 INFO - "pgo_build": "False", 11:48:07 INFO - "basedir": "/builds/slave/test", 11:48:07 INFO - "buildnumber": 426, 11:48:07 INFO - "slavename": "talos-linux64-ix-051", 11:48:07 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 11:48:07 INFO - "platform": "ubuntu64_hw", 11:48:07 INFO - "scheduler": "tests-autoland-linux64-talos", 11:48:07 INFO - "branch": "autoland", 11:48:07 INFO - "repo_path": "integration/autoland", 11:48:07 INFO - "revision": "4969ca354b5c3888a42ec55e5da09420f0f7033e", 11:48:07 INFO - "stage_platform": "linux64", 11:48:07 INFO - "builduid": "03487f857bb34d4e8a81434c2d1967ea", 11:48:07 INFO - "slavebuilddir": "test" 11:48:07 INFO - } 11:48:07 INFO - Found installer url https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 11:48:07 INFO - Running post-action listener: _resource_record_post_action 11:48:07 INFO - [mozharness: 2016-09-08 18:48:07.152824Z] Finished read-buildbot-config step (success) 11:48:07 INFO - [mozharness: 2016-09-08 18:48:07.152916Z] Running download-and-extract step. 11:48:07 INFO - Running pre-action listener: _resource_record_pre_action 11:48:07 INFO - Running main action method: download_and_extract 11:48:07 INFO - mkdir: /builds/slave/test/build/tests 11:48:07 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')]} 11:48:07 INFO - trying https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:48:07 INFO - Downloading https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:48:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 11:48:07 INFO - Downloaded 1361 bytes. 11:48:07 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 11:48:07 INFO - Using the following test package requirements: 11:48:07 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:48:07 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:48:07 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 11:48:07 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:07 INFO - u'jsshell-linux-x86_64.zip'], 11:48:07 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:48:07 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 11:48:07 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:48:07 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:48:07 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:48:07 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 11:48:07 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:48:07 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:48:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:48:08 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:48:12 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 11:48:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 11:48:13 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:48:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 11:48:18 INFO - retry: Calling unzip with args: (), kwargs: {'file_object': >, 'verbose': False, 'extract_dirs': '*', 'extract_to': '/builds/slave/test/build/tests'}, attempt #1 11:48:18 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')]} 11:48:18 INFO - trying https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:48:18 INFO - Downloading https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:48:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 11:48:19 INFO - Downloaded 55782934 bytes. 11:48:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:48:19 INFO - mkdir: /builds/slave/test/properties 11:48:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:48:19 INFO - Writing to file /builds/slave/test/properties/build_url 11:48:19 INFO - Contents: 11:48:19 INFO - build_url:https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 11:48:20 INFO - Running post-action listener: _resource_record_post_action 11:48:20 INFO - Running post-action listener: set_extra_try_arguments 11:48:20 INFO - [mozharness: 2016-09-08 18:48:20.733995Z] Finished download-and-extract step (success) 11:48:20 INFO - [mozharness: 2016-09-08 18:48:20.734225Z] Running populate-webroot step. 11:48:20 INFO - Running pre-action listener: _resource_record_pre_action 11:48:20 INFO - Running main action method: populate_webroot 11:48:20 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:48:20 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:48:20 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:48:20 INFO - '--tppagecycles', 11:48:20 INFO - '7'], 11:48:20 INFO - 'tests': ['tsvgm']}}, 11:48:20 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 11:48:20 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:48:20 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 11:48:20 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 11:48:20 INFO - 'tests': ['dromaeo_css', 'kraken']}, 11:48:20 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 11:48:20 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'talos_options': ['--disable-e10s'], 11:48:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:20 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:48:20 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'talos_options': ['--disable-e10s'], 11:48:20 INFO - 'tests': ['damp', 'tps']}, 11:48:20 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'tests': ['damp', 'tps']}, 11:48:20 INFO - 'g3': {'talos_options': ['--disable-e10s'], 11:48:20 INFO - 'tests': ['dromaeo_dom']}, 11:48:20 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:48:20 INFO - 'g4': {'talos_options': ['--disable-e10s'], 11:48:20 INFO - 'tests': ['basic_compositor_video']}, 11:48:20 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 11:48:20 INFO - 'other': {'talos_options': ['--disable-e10s'], 11:48:20 INFO - 'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'other-e10s': {'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'other-e10s_l64': {'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 11:48:20 INFO - 'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 11:48:20 INFO - 'tests': ['a11yr', 11:48:20 INFO - 'ts_paint', 11:48:20 INFO - 'tpaint', 11:48:20 INFO - 'sessionrestore', 11:48:20 INFO - 'sessionrestore_no_auto_restore', 11:48:20 INFO - 'tabpaint']}, 11:48:20 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 11:48:20 INFO - 'tests': ['tsvgx', 11:48:20 INFO - 'tsvgr_opacity', 11:48:20 INFO - 'tart', 11:48:20 INFO - 'tscrollx', 11:48:20 INFO - 'cart']}, 11:48:20 INFO - 'svgr-e10s': {'tests': ['tsvgx', 11:48:20 INFO - 'tsvgr_opacity', 11:48:20 INFO - 'tart', 11:48:20 INFO - 'tscrollx', 11:48:20 INFO - 'cart']}, 11:48:20 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'talos_options': ['--disable-e10s'], 11:48:20 INFO - 'tests': ['tp5o']}, 11:48:20 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'tests': ['tp5o']}, 11:48:20 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'talos_options': ['--disable-e10s', 11:48:20 INFO - '--xperf_path', 11:48:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:20 INFO - 'tests': ['tp5n']}, 11:48:20 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:48:20 INFO - 'talos_options': ['--xperf_path', 11:48:20 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:48:20 INFO - 'tests': ['tp5n']}}, 11:48:20 INFO - 'talos.zip': {'path': '', 11:48:20 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:48:20 INFO - Running post-action listener: _resource_record_post_action 11:48:20 INFO - [mozharness: 2016-09-08 18:48:20.756467Z] Finished populate-webroot step (success) 11:48:20 INFO - [mozharness: 2016-09-08 18:48:20.756559Z] Running create-virtualenv step. 11:48:20 INFO - Running pre-action listener: _resource_record_pre_action 11:48:20 INFO - Running main action method: create_virtualenv 11:48:20 INFO - Creating virtualenv /builds/slave/test/build/venv 11:48:20 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 11:48:20 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:48:20 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:48:20 INFO - Using real prefix '/usr' 11:48:20 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:48:21 INFO - Installing distribute.............................................................................................................................................................................................done. 11:48:23 INFO - Installing pip.................done. 11:48:23 INFO - Return code: 0 11:48:23 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:48:23 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')]} 11:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:23 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')]} 11:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:23 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 0x7f8d09fd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c06090>, '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 0x2c099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c09e40>, '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-1473360484.819581-309660620', '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 11:48:23 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 11:48:23 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 11:48:23 INFO - Using env: {'DISPLAY': ':0', 11:48:23 INFO - 'HOME': '/home/cltbld', 11:48:23 INFO - 'LANG': 'en_US.UTF-8', 11:48:23 INFO - 'LANGUAGE': 'en_US:en', 11:48:23 INFO - 'LOGNAME': 'cltbld', 11:48:23 INFO - 'MAIL': '/var/mail/cltbld', 11:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:23 INFO - 'MOZ_NO_REMOTE': '1', 11:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:23 INFO - 'NO_EM_RESTART': '1', 11:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:23 INFO - 'PWD': '/builds/slave/test', 11:48:23 INFO - 'SHELL': '/bin/bash', 11:48:23 INFO - 'SHLVL': '1', 11:48:23 INFO - 'TERM': 'linux', 11:48:23 INFO - 'TMOUT': '86400', 11:48:23 INFO - 'USER': 'cltbld', 11:48:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620', 11:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:23 INFO - '_': '/tools/buildbot/bin/python'} 11:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:23 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 11:48:23 INFO - Cleaning up... 11:48:23 INFO - Return code: 0 11:48:23 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 11:48:23 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')]} 11:48:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:23 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')]} 11:48:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:23 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 0x7f8d09fd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c06090>, '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 0x2c099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c09e40>, '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-1473360484.819581-309660620', '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 11:48:23 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 11:48:23 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 11:48:23 INFO - Using env: {'DISPLAY': ':0', 11:48:23 INFO - 'HOME': '/home/cltbld', 11:48:23 INFO - 'LANG': 'en_US.UTF-8', 11:48:23 INFO - 'LANGUAGE': 'en_US:en', 11:48:23 INFO - 'LOGNAME': 'cltbld', 11:48:23 INFO - 'MAIL': '/var/mail/cltbld', 11:48:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:23 INFO - 'MOZ_NO_REMOTE': '1', 11:48:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:23 INFO - 'NO_EM_RESTART': '1', 11:48:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:23 INFO - 'PWD': '/builds/slave/test', 11:48:23 INFO - 'SHELL': '/bin/bash', 11:48:23 INFO - 'SHLVL': '1', 11:48:23 INFO - 'TERM': 'linux', 11:48:23 INFO - 'TMOUT': '86400', 11:48:23 INFO - 'USER': 'cltbld', 11:48:23 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620', 11:48:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:23 INFO - '_': '/tools/buildbot/bin/python'} 11:48:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:23 INFO - Downloading/unpacking psutil>=3.1.1 11:48:23 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 11:48:23 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 11:48:23 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 11:48:23 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 11:48:23 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 11:48:23 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 11:48:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:48:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:25 INFO - Installing collected packages: psutil 11:48:25 INFO - Running setup.py install for psutil 11:48:25 INFO - building 'psutil._psutil_linux' extension 11:48:25 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 11:48:26 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 11:48:26 INFO - building 'psutil._psutil_posix' extension 11:48:26 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 11:48:26 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 11:48:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:48:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:48:26 INFO - Successfully installed psutil 11:48:26 INFO - Cleaning up... 11:48:26 INFO - Return code: 0 11:48:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 11:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:26 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 0x7f8d09fd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c06090>, '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 0x2c099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c09e40>, '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-1473360484.819581-309660620', '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 11:48:26 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 11:48:26 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 11:48:26 INFO - Using env: {'DISPLAY': ':0', 11:48:26 INFO - 'HOME': '/home/cltbld', 11:48:26 INFO - 'LANG': 'en_US.UTF-8', 11:48:26 INFO - 'LANGUAGE': 'en_US:en', 11:48:26 INFO - 'LOGNAME': 'cltbld', 11:48:26 INFO - 'MAIL': '/var/mail/cltbld', 11:48:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:26 INFO - 'MOZ_NO_REMOTE': '1', 11:48:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:26 INFO - 'NO_EM_RESTART': '1', 11:48:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:26 INFO - 'PWD': '/builds/slave/test', 11:48:26 INFO - 'SHELL': '/bin/bash', 11:48:26 INFO - 'SHLVL': '1', 11:48:26 INFO - 'TERM': 'linux', 11:48:26 INFO - 'TMOUT': '86400', 11:48:26 INFO - 'USER': 'cltbld', 11:48:26 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620', 11:48:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:26 INFO - '_': '/tools/buildbot/bin/python'} 11:48:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 11:48:26 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 11:48:26 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 11:48:26 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 11:48:26 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 11:48:26 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 11:48:26 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 11:48:28 INFO - Downloading mozsystemmonitor-0.3.tar.gz 11:48:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:48:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 11:48:28 INFO - Installing collected packages: mozsystemmonitor 11:48:28 INFO - Running setup.py install for mozsystemmonitor 11:48:28 INFO - Successfully installed mozsystemmonitor 11:48:28 INFO - Cleaning up... 11:48:28 INFO - Return code: 0 11:48:28 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 11:48:28 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')]} 11:48:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:28 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')]} 11:48:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:28 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 0x7f8d09fd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c06090>, '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 0x2c099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c09e40>, '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-1473360484.819581-309660620', '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 11:48:28 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 11:48:28 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 11:48:28 INFO - Using env: {'DISPLAY': ':0', 11:48:28 INFO - 'HOME': '/home/cltbld', 11:48:28 INFO - 'LANG': 'en_US.UTF-8', 11:48:28 INFO - 'LANGUAGE': 'en_US:en', 11:48:28 INFO - 'LOGNAME': 'cltbld', 11:48:28 INFO - 'MAIL': '/var/mail/cltbld', 11:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:28 INFO - 'MOZ_NO_REMOTE': '1', 11:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:28 INFO - 'NO_EM_RESTART': '1', 11:48:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:28 INFO - 'PWD': '/builds/slave/test', 11:48:28 INFO - 'SHELL': '/bin/bash', 11:48:28 INFO - 'SHLVL': '1', 11:48:28 INFO - 'TERM': 'linux', 11:48:28 INFO - 'TMOUT': '86400', 11:48:28 INFO - 'USER': 'cltbld', 11:48:28 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620', 11:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:28 INFO - '_': '/tools/buildbot/bin/python'} 11:48:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:28 INFO - Downloading/unpacking jsonschema==2.5.1 11:48:28 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 11:48:28 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 11:48:28 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 11:48:28 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 11:48:28 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 11:48:28 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 11:48:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:48:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 11:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:30 INFO - Downloading functools32-3.2.3-2.tar.gz 11:48:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:48:31 INFO - warning: no files found matching '*.txt' 11:48:31 INFO - no previously-included directories found matching 'build' 11:48:31 INFO - no previously-included directories found matching 'dist' 11:48:31 INFO - no previously-included directories found matching '.git*' 11:48:31 INFO - Installing collected packages: jsonschema, functools32 11:48:31 INFO - Running setup.py install for functools32 11:48:31 INFO - warning: no files found matching '*.txt' 11:48:31 INFO - no previously-included directories found matching 'build' 11:48:31 INFO - no previously-included directories found matching 'dist' 11:48:31 INFO - no previously-included directories found matching '.git*' 11:48:31 INFO - Successfully installed jsonschema functools32 11:48:31 INFO - Cleaning up... 11:48:31 INFO - Return code: 0 11:48:31 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 11:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8d09fd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c06090>, '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 0x2c099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c09e40>, '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-1473360484.819581-309660620', '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 11:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 11:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 11:48:31 INFO - Using env: {'DISPLAY': ':0', 11:48:31 INFO - 'HOME': '/home/cltbld', 11:48:31 INFO - 'LANG': 'en_US.UTF-8', 11:48:31 INFO - 'LANGUAGE': 'en_US:en', 11:48:31 INFO - 'LOGNAME': 'cltbld', 11:48:31 INFO - 'MAIL': '/var/mail/cltbld', 11:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:31 INFO - 'MOZ_NO_REMOTE': '1', 11:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:31 INFO - 'NO_EM_RESTART': '1', 11:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:31 INFO - 'PWD': '/builds/slave/test', 11:48:31 INFO - 'SHELL': '/bin/bash', 11:48:31 INFO - 'SHLVL': '1', 11:48:31 INFO - 'TERM': 'linux', 11:48:31 INFO - 'TMOUT': '86400', 11:48:31 INFO - 'USER': 'cltbld', 11:48:31 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620', 11:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:31 INFO - '_': '/tools/buildbot/bin/python'} 11:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:31 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 11:48:31 INFO - Cleaning up... 11:48:31 INFO - Return code: 0 11:48:31 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8d09fd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c06090>, '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 0x2c099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c09e40>, '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-1473360484.819581-309660620', '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 11:48:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 11:48:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 11:48:31 INFO - Using env: {'DISPLAY': ':0', 11:48:31 INFO - 'HOME': '/home/cltbld', 11:48:31 INFO - 'LANG': 'en_US.UTF-8', 11:48:31 INFO - 'LANGUAGE': 'en_US:en', 11:48:31 INFO - 'LOGNAME': 'cltbld', 11:48:31 INFO - 'MAIL': '/var/mail/cltbld', 11:48:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:31 INFO - 'MOZ_NO_REMOTE': '1', 11:48:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:31 INFO - 'NO_EM_RESTART': '1', 11:48:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:31 INFO - 'PWD': '/builds/slave/test', 11:48:31 INFO - 'SHELL': '/bin/bash', 11:48:31 INFO - 'SHLVL': '1', 11:48:31 INFO - 'TERM': 'linux', 11:48:31 INFO - 'TMOUT': '86400', 11:48:31 INFO - 'USER': 'cltbld', 11:48:31 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620', 11:48:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:31 INFO - '_': '/tools/buildbot/bin/python'} 11:48:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:31 INFO - Downloading/unpacking blobuploader==1.2.4 11:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:33 INFO - Downloading blobuploader-1.2.4.tar.gz 11:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:48:33 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:48:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:34 INFO - Downloading docopt-0.6.1.tar.gz 11:48:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:48:34 INFO - Installing collected packages: blobuploader, requests, docopt 11:48:34 INFO - Running setup.py install for blobuploader 11:48:34 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:48:34 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:48:34 INFO - Running setup.py install for requests 11:48:34 INFO - Running setup.py install for docopt 11:48:34 INFO - Successfully installed blobuploader requests docopt 11:48:34 INFO - Cleaning up... 11:48:34 INFO - Return code: 0 11:48:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:34 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 0x7f8d09fd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c06090>, '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 0x2c099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c09e40>, '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-1473360484.819581-309660620', '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 11:48:34 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 11:48:34 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 11:48:34 INFO - Using env: {'DISPLAY': ':0', 11:48:34 INFO - 'HOME': '/home/cltbld', 11:48:34 INFO - 'LANG': 'en_US.UTF-8', 11:48:34 INFO - 'LANGUAGE': 'en_US:en', 11:48:34 INFO - 'LOGNAME': 'cltbld', 11:48:34 INFO - 'MAIL': '/var/mail/cltbld', 11:48:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:34 INFO - 'MOZ_NO_REMOTE': '1', 11:48:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:34 INFO - 'NO_EM_RESTART': '1', 11:48:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:34 INFO - 'PWD': '/builds/slave/test', 11:48:34 INFO - 'SHELL': '/bin/bash', 11:48:34 INFO - 'SHLVL': '1', 11:48:34 INFO - 'TERM': 'linux', 11:48:34 INFO - 'TMOUT': '86400', 11:48:34 INFO - 'USER': 'cltbld', 11:48:34 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620', 11:48:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:34 INFO - '_': '/tools/buildbot/bin/python'} 11:48:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:35 INFO - Running setup.py (path:/tmp/pip-L0TRO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:35 INFO - Running setup.py (path:/tmp/pip-RJluLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:35 INFO - Running setup.py (path:/tmp/pip-vdKSmB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:35 INFO - Running setup.py (path:/tmp/pip-xjosgV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:35 INFO - Running setup.py (path:/tmp/pip-13u7Cj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:35 INFO - Running setup.py (path:/tmp/pip-GGs1K7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:35 INFO - Running setup.py (path:/tmp/pip-uIRbq9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:35 INFO - Running setup.py (path:/tmp/pip-qw1U1e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:35 INFO - Running setup.py (path:/tmp/pip-0Po7Hd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:35 INFO - Running setup.py (path:/tmp/pip-1i5oq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:35 INFO - Running setup.py (path:/tmp/pip-RJ6jzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:35 INFO - Running setup.py (path:/tmp/pip-hpTfSm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:36 INFO - Running setup.py (path:/tmp/pip-gGl9O4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:36 INFO - Running setup.py (path:/tmp/pip-bR5ZR0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:36 INFO - Running setup.py (path:/tmp/pip-aeTt_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:36 INFO - Running setup.py (path:/tmp/pip-NkYzjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:36 INFO - Running setup.py (path:/tmp/pip-_DTEdG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:36 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:48:36 INFO - Running setup.py install for manifestparser 11:48:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:48:36 INFO - Running setup.py install for mozcrash 11:48:36 INFO - Running setup.py install for mozdebug 11:48:36 INFO - Running setup.py install for mozdevice 11:48:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:48:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:48:36 INFO - Running setup.py install for mozfile 11:48:36 INFO - Running setup.py install for mozhttpd 11:48:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:48:36 INFO - Running setup.py install for mozinfo 11:48:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:48:37 INFO - Running setup.py install for mozInstall 11:48:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:48:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:48:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:48:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:48:37 INFO - Running setup.py install for mozleak 11:48:37 INFO - Running setup.py install for mozlog 11:48:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:48:37 INFO - Running setup.py install for moznetwork 11:48:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:48:37 INFO - Running setup.py install for mozprocess 11:48:37 INFO - Running setup.py install for mozprofile 11:48:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:48:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:48:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:48:37 INFO - Running setup.py install for mozrunner 11:48:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:48:37 INFO - Running setup.py install for mozscreenshot 11:48:37 INFO - Running setup.py install for moztest 11:48:38 INFO - Running setup.py install for mozversion 11:48:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:48:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:48:38 INFO - Cleaning up... 11:48:38 INFO - Return code: 0 11:48:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:38 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 0x7f8d09fd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c06090>, '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 0x2c099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c09e40>, '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-1473360484.819581-309660620', '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 11:48:38 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 11:48:38 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 11:48:38 INFO - Using env: {'DISPLAY': ':0', 11:48:38 INFO - 'HOME': '/home/cltbld', 11:48:38 INFO - 'LANG': 'en_US.UTF-8', 11:48:38 INFO - 'LANGUAGE': 'en_US:en', 11:48:38 INFO - 'LOGNAME': 'cltbld', 11:48:38 INFO - 'MAIL': '/var/mail/cltbld', 11:48:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:38 INFO - 'MOZ_NO_REMOTE': '1', 11:48:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:38 INFO - 'NO_EM_RESTART': '1', 11:48:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:38 INFO - 'PWD': '/builds/slave/test', 11:48:38 INFO - 'SHELL': '/bin/bash', 11:48:38 INFO - 'SHLVL': '1', 11:48:38 INFO - 'TERM': 'linux', 11:48:38 INFO - 'TMOUT': '86400', 11:48:38 INFO - 'USER': 'cltbld', 11:48:38 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620', 11:48:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:38 INFO - '_': '/tools/buildbot/bin/python'} 11:48:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:48:38 INFO - Running setup.py (path:/tmp/pip-roHmtH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:48:38 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)) 11:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:48:38 INFO - Running setup.py (path:/tmp/pip-1bjjra-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:48:38 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)) 11:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:48:38 INFO - Running setup.py (path:/tmp/pip-rVKnAC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:48:38 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)) 11:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:48:38 INFO - Running setup.py (path:/tmp/pip-Hq0Xhr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:48:38 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)) 11:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:48:38 INFO - Running setup.py (path:/tmp/pip-JfSCWX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:48:38 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)) 11:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:48:38 INFO - Running setup.py (path:/tmp/pip-L_dzQn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:48:38 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)) 11:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:48:38 INFO - Running setup.py (path:/tmp/pip-CCKby6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 11:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:48:38 INFO - Running setup.py (path:/tmp/pip-rsJY09-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:48:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 11:48:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:48:38 INFO - Running setup.py (path:/tmp/pip-w4TSCn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:48:39 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)) 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:48:39 INFO - Running setup.py (path:/tmp/pip-DNkNHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:48:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 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)) 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:48:39 INFO - Running setup.py (path:/tmp/pip-vN70Qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:48:39 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)) 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:48:39 INFO - Running setup.py (path:/tmp/pip-4JsjXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:48:39 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)) 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:48:39 INFO - Running setup.py (path:/tmp/pip-ktwau7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:48:39 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)) 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:48:39 INFO - Running setup.py (path:/tmp/pip-iZ2St1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:48:39 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)) 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:39 INFO - Running setup.py (path:/tmp/pip-irN3vM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:48:39 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)) 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:48:39 INFO - Running setup.py (path:/tmp/pip-r9XnGk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:48:39 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)) 11:48:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:48:39 INFO - Running setup.py (path:/tmp/pip-hFoDmr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:48:39 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)) 11:48:39 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)) 11:48:39 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)) 11:48:39 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)) 11:48:39 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)) 11:48:39 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)) 11:48:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:48:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:48:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:48:41 INFO - Downloading blessings-1.6.tar.gz 11:48:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:48:41 INFO - Installing collected packages: blessings 11:48:41 INFO - Running setup.py install for blessings 11:48:41 INFO - Successfully installed blessings 11:48:41 INFO - Cleaning up... 11:48:41 INFO - Return code: 0 11:48:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:48:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:41 INFO - Reading from file tmpfile_stdout 11:48:41 INFO - Current package versions: 11:48:41 INFO - argparse == 1.2.1 11:48:41 INFO - blessings == 1.6 11:48:41 INFO - blobuploader == 1.2.4 11:48:41 INFO - docopt == 0.6.1 11:48:41 INFO - functools32 == 3.2.3-2 11:48:41 INFO - jsonschema == 2.5.1 11:48:41 INFO - manifestparser == 1.1 11:48:41 INFO - mozInstall == 1.12 11:48:41 INFO - mozcrash == 0.17 11:48:41 INFO - mozdebug == 0.1 11:48:41 INFO - mozdevice == 0.48 11:48:41 INFO - mozfile == 1.2 11:48:41 INFO - mozhttpd == 0.7 11:48:41 INFO - mozinfo == 0.9 11:48:41 INFO - mozleak == 0.1 11:48:41 INFO - mozlog == 3.3 11:48:41 INFO - moznetwork == 0.27 11:48:41 INFO - mozprocess == 0.23 11:48:41 INFO - mozprofile == 0.28 11:48:41 INFO - mozrunner == 6.12 11:48:41 INFO - mozscreenshot == 0.1 11:48:41 INFO - mozsystemmonitor == 0.3 11:48:41 INFO - moztest == 0.7 11:48:41 INFO - mozversion == 1.4 11:48:41 INFO - psutil == 3.1.1 11:48:41 INFO - requests == 1.2.3 11:48:41 INFO - wsgiref == 0.1.2 11:48:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8d09fd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c06090>, '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 0x2c099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c09e40>, '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-1473360484.819581-309660620', '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 11:48:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 11:48:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 11:48:41 INFO - Using env: {'DISPLAY': ':0', 11:48:41 INFO - 'HOME': '/home/cltbld', 11:48:41 INFO - 'LANG': 'en_US.UTF-8', 11:48:41 INFO - 'LANGUAGE': 'en_US:en', 11:48:41 INFO - 'LOGNAME': 'cltbld', 11:48:41 INFO - 'MAIL': '/var/mail/cltbld', 11:48:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:41 INFO - 'MOZ_NO_REMOTE': '1', 11:48:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:41 INFO - 'NO_EM_RESTART': '1', 11:48:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:41 INFO - 'PWD': '/builds/slave/test', 11:48:41 INFO - 'SHELL': '/bin/bash', 11:48:41 INFO - 'SHLVL': '1', 11:48:41 INFO - 'TERM': 'linux', 11:48:41 INFO - 'TMOUT': '86400', 11:48:41 INFO - 'USER': 'cltbld', 11:48:41 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620', 11:48:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:41 INFO - '_': '/tools/buildbot/bin/python'} 11:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:42 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)) 11:48:42 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)) 11:48:42 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)) 11:48:42 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)) 11:48:42 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)) 11:48:42 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)) 11:48:42 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)) 11:48:42 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)) 11:48:42 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)) 11:48:42 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)) 11:48:42 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)) 11:48:42 INFO - Cleaning up... 11:48:42 INFO - Return code: 0 11:48:42 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:48:42 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')]} 11:48:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:48:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:42 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')]} 11:48:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:48:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:48:42 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 0x7f8d09fd7f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b3d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c06090>, '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 0x2c099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c09e40>, '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-1473360484.819581-309660620', '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 11:48:42 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 11:48:42 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 11:48:42 INFO - Using env: {'DISPLAY': ':0', 11:48:42 INFO - 'HOME': '/home/cltbld', 11:48:42 INFO - 'LANG': 'en_US.UTF-8', 11:48:42 INFO - 'LANGUAGE': 'en_US:en', 11:48:42 INFO - 'LOGNAME': 'cltbld', 11:48:42 INFO - 'MAIL': '/var/mail/cltbld', 11:48:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:42 INFO - 'MOZ_NO_REMOTE': '1', 11:48:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:42 INFO - 'NO_EM_RESTART': '1', 11:48:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:42 INFO - 'PWD': '/builds/slave/test', 11:48:42 INFO - 'SHELL': '/bin/bash', 11:48:42 INFO - 'SHLVL': '1', 11:48:42 INFO - 'TERM': 'linux', 11:48:42 INFO - 'TMOUT': '86400', 11:48:42 INFO - 'USER': 'cltbld', 11:48:42 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620', 11:48:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:42 INFO - '_': '/tools/buildbot/bin/python'} 11:48:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:48:42 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 11:48:42 INFO - Cleaning up... 11:48:42 INFO - Return code: 0 11:48:42 INFO - Running post-action listener: _resource_record_post_action 11:48:42 INFO - Running post-action listener: _start_resource_monitoring 11:48:42 INFO - Starting resource monitoring. 11:48:42 INFO - [mozharness: 2016-09-08 18:48:42.417779Z] Finished create-virtualenv step (success) 11:48:42 INFO - [mozharness: 2016-09-08 18:48:42.418298Z] Running install step. 11:48:42 INFO - Running pre-action listener: _resource_record_pre_action 11:48:42 INFO - Running main action method: install 11:48:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:48:42 INFO - Reading from file tmpfile_stdout 11:48:42 INFO - Detecting whether we're running mozinstall >=1.0... 11:48:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:48:42 INFO - Reading from file tmpfile_stdout 11:48:42 INFO - Output received: 11:48:42 INFO - Usage: mozinstall [options] installer 11:48:42 INFO - Options: 11:48:42 INFO - -h, --help show this help message and exit 11:48:42 INFO - -d DEST, --destination=DEST 11:48:42 INFO - Directory to install application into. [default: 11:48:42 INFO - "/builds/slave/test"] 11:48:42 INFO - --app=APP Application being installed. [default: firefox] 11:48:42 INFO - mkdir: /builds/slave/test/build/application 11:48:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 11:48:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 11:48:58 INFO - Reading from file tmpfile_stdout 11:48:58 INFO - Output received: 11:48:58 INFO - /builds/slave/test/build/application/firefox/firefox 11:48:58 INFO - Running post-action listener: _resource_record_post_action 11:48:58 INFO - [mozharness: 2016-09-08 18:48:58.832346Z] Finished install step (success) 11:48:58 INFO - [mozharness: 2016-09-08 18:48:58.832603Z] Running run-tests step. 11:48:58 INFO - Running pre-action listener: _resource_record_pre_action 11:48:58 INFO - Running main action method: run_tests 11:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:48:58 INFO - Python 2.7.3 11:48:58 INFO - Return code: 0 11:48:58 INFO - grabbing minidump binary from tooltool 11:48:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 11:48:58 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c06090>, '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 0x2c099b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c09e40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:48:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 11:48:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 11:48:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 11:48:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:48:58 INFO - Return code: 0 11:48:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:48:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:48:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:48:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:48:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:48:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.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 11:48:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.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 11:48:58 INFO - Using env: {'DISPLAY': ':0', 11:48:58 INFO - 'HOME': '/home/cltbld', 11:48:58 INFO - 'LANG': 'en_US.UTF-8', 11:48:58 INFO - 'LANGUAGE': 'en_US:en', 11:48:58 INFO - 'LOGNAME': 'cltbld', 11:48:58 INFO - 'MAIL': '/var/mail/cltbld', 11:48:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:48:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:48:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:48:58 INFO - 'MOZ_NO_REMOTE': '1', 11:48:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:48:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:48:58 INFO - 'NO_EM_RESTART': '1', 11:48:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:48:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:48:58 INFO - 'PWD': '/builds/slave/test', 11:48:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:48:58 INFO - 'SHELL': '/bin/bash', 11:48:58 INFO - 'SHLVL': '1', 11:48:58 INFO - 'TERM': 'linux', 11:48:58 INFO - 'TMOUT': '86400', 11:48:58 INFO - 'USER': 'cltbld', 11:48:58 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1473360484.819581-309660620', 11:48:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:48:58 INFO - '_': '/tools/buildbot/bin/python'} 11:48:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.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 11:48:59 INFO - mozversion application_buildid: 20160908102019 11:48:59 INFO - mozversion application_changeset: 4969ca354b5c3888a42ec55e5da09420f0f7033e 11:48:59 INFO - mozversion application_display_name: Nightly 11:48:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:48:59 INFO - mozversion application_name: Firefox 11:48:59 INFO - mozversion application_remotingname: firefox 11:48:59 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 11:48:59 INFO - mozversion application_vendor: Mozilla 11:48:59 INFO - mozversion application_version: 51.0a1 11:48:59 INFO - mozversion platform_buildid: 20160908102019 11:48:59 INFO - mozversion platform_changeset: 4969ca354b5c3888a42ec55e5da09420f0f7033e 11:48:59 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 11:48:59 INFO - mozversion platform_version: 51.0a1 11:48:59 INFO - using testdate: 1473360539 11:48:59 INFO - actual date: 1473360539 11:48:59 INFO - starting webserver on 'localhost:45554' 11:48:59 INFO - SUITE-START | Running 2 tests 11:48:59 INFO - TEST-START | dromaeo_css 11:48:59 INFO - operating with platform_type : linux_ 11:48:59 INFO - Initialising browser for dromaeo_css test... 11:48:59 INFO - TEST-INFO | started process 9736 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuwhrVH/profile http://localhost:45554/getInfo.html) 11:49:03 INFO - PROCESS | 9736 | __metrics Screen width/height:1600/1200 11:49:03 INFO - PROCESS | 9736 | colorDepth:24 11:49:03 INFO - PROCESS | 9736 | Browser inner width/height: 1024/697 11:49:03 INFO - PROCESS | 9736 | __metrics 11:49:04 INFO - PROCESS | 9736 | 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" 11:49:04 INFO - PROCESS | 9736 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:49:04 INFO - PROCESS | 9736 | console.error: PushService: 11:49:04 INFO - PROCESS | 9736 | stateChangeProcessEnqueue: Error transitioning state 11:49:04 INFO - PROCESS | 9736 | UnknownError 11:49:05 INFO - TEST-INFO | 9736: exit 0 11:49:05 INFO - Browser initialized. 11:49:05 INFO - Running cycle 1/1 for dromaeo_css test... 11:49:05 INFO - TEST-INFO | started process 9818 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpuwhrVH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 11:49:17 INFO - PROCESS | 9818 | RSS: Main: 179924992 11:49:17 INFO - PROCESS | 9818 | 11:50:08 INFO - PROCESS | 9818 | 1473360608636 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] 11:52:22 INFO - PROCESS | 9818 | Cycle 1(1): loaded http://localhost:45554/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45554/tests/dromaeo/cssquery-ext.html) 11:52:23 INFO - PROCESS | 9818 | RSS: Main: 278630400 11:52:23 INFO - PROCESS | 9818 | 11:55:25 INFO - PROCESS | 9818 | Cycle 1(1): loaded http://localhost:45554/tests/dromaeo/cssquery-ext.html (next: http://localhost:45554/tests/dromaeo/cssquery-jquery.html) 11:55:26 INFO - PROCESS | 9818 | RSS: Main: 276041728 11:55:26 INFO - PROCESS | 9818 | 11:58:28 INFO - PROCESS | 9818 | Cycle 1(1): loaded http://localhost:45554/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45554/tests/dromaeo/cssquery-mootools.html) 11:58:29 INFO - PROCESS | 9818 | RSS: Main: 258985984 11:58:29 INFO - PROCESS | 9818 | 12:01:31 INFO - PROCESS | 9818 | Cycle 1(1): loaded http://localhost:45554/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45554/tests/dromaeo/cssquery-prototype.html) 12:01:32 INFO - PROCESS | 9818 | RSS: Main: 222740480 12:01:32 INFO - PROCESS | 9818 | 12:04:35 INFO - PROCESS | 9818 | Cycle 1(1): loaded http://localhost:45554/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45554/tests/dromaeo/cssquery-yui.html) 12:04:35 INFO - PROCESS | 9818 | RSS: Main: 218632192 12:04:35 INFO - PROCESS | 9818 | 12:07:39 INFO - PROCESS | 9818 | Cycle 1(1): loaded http://localhost:45554/tests/dromaeo/cssquery-yui.html (next: http://localhost:45554/tests/dromaeo/cssquery-dojo.html) 12:07:39 INFO - PROCESS | 9818 | RSS: Main: 307556352 12:07:39 INFO - PROCESS | 9818 | 12:07:39 INFO - PROCESS | 9818 | __start_tp_report 12:07:39 INFO - PROCESS | 9818 | _x_x_mozilla_page_load 12:07:39 INFO - PROCESS | 9818 | _x_x_mozilla_page_load_details 12:07:39 INFO - PROCESS | 9818 | |i|pagename|runs| 12:07:39 INFO - PROCESS | 9818 | |0;dojo.html;2582.0188328435192;2612.5036243113814;2615.450755341378;2624.593188055851;2633.5259653262406;4552.749598772075;4612.0775844831;4633.606143477804;4703.6237101031875;4773.140834649766;4662.8134874604975;4665.230237010889;4666.673332866692;4671.509491503394;4725.881852953687;4179.477565304337;4201.054762678388;4277.144571085795;4368.235558777217;4453.198424283628;4380.036391993772;4408.3167109097985;4427.2916333386665;4446.199684056868;4453.198424283628;4206.600372964564;4238.830446782125;4247.596478334584;4282.207791558571;4340.826366945318;4268.487781466244;4275.46556680415;4281.400603915455;4319.632831209351;4336.869893903188;4235.767032813194;4268.423762792046;4287.164003019412;4288.356746488021;4345.34819777036;4647.9535204647855;4708.176069187913;4709.529047095263;4738.384010078667;4797.328374027639;4863.051704917542;4988.87527811804;4996.975015124937;5042.243663450475;5065.265536497187;5078.13671675816;5095.439501654815;5109.208072748693;5117.7185254810975;5191.922121168185;4579.839705610288;4756.5956893664425;4758.97681998372;4760.09558183944;4805.063012712522;5098.235264710249;5109.310243117206;5116.948830511647;5117.257997590403;5201.895962080813;4944.901101978012;4955.430125535538;4968.552830245295;5020.648554601143;5036.7733451994745;4823.686460380064;5045.470225626256;5047.495250474996;5056.544910957958;5065.6200784941275;4874.8787778810365;4939.876503087452;4944.826931057396;4966.726830024383;5010.899782004412;4925.38432695913;4931.679440836406;4938;4943.604511639061;5004.724740139327;4162.41726158338;4273.166732487135;4275.080857615628;4285.764282964405;4346.826126954887;3646.21606354635;3719.386301260262;3742.6631603155847;3763.7929913854455;3831.827567759402;4400.361947517656;4401.295792673157;4403.515613282536;4427.667924905581;4452.176347375681;5079.238114282887;5083.74581270935;5104.540591346797;5106.310648062538;5139.743012849342;4141.047559061432;4321.395004699345;4341.782910854445;4350.912981740411;4372.300431930876;4550.067236216568;4559.52125026874;4567.771611419482;4609.400777898919;4620.514845941195;4790.592799612003;4805.831795887128;4807.351007613997;4813.181759100891;4864.075825593126;4916.901661966669;5000.224965130411;5057.519535644108;5105.693658380509;5122.948770512247;4848.442429120555;4858.878528036686;4870.025994801124;4907.730074845917;4922.212446008622;5044.798208071636;5047.965167140654;5048.7475626219275;5050.77271522775;5051.419086805065;4912.6561140719805;4994.850154495371;5029.84910452687;5056.241563765465;5163.845084647466;4920.114379411741;4922.606191504599;4925.236588328815;4933.21068629032;4965.528274813887;4918.901621967612;4932.186189278729;4933.407991040955;4933.55597996182;4980.950190498049;4724.976375118103;4817.710937343771;4826.734529600765;4832.1543729846435;4913.140200464833;4960.627952903619;4965.131102057053;4966.130927087817;4969.031038947515;4988.451270360185;4833.154198015403;4834.903301934012;4837.4920633332995;4879.072976134523;4898.8775280618265 12:07:39 INFO - PROCESS | 9818 | |1;ext.html;556.7438978070088;563.1102857485174;566.2610293566894;570.2301892445197;570.4210226619981;28177.859110704445;38870.80564597176;39997.60002399975;40036.79981600088;43702.562974370245;39356.80321598395;39672.40491392624;39781;39801;39826;7027.156741191038;7568.318851303382;7711.460197786158;7715.382769378464;7720.073591169067;7073.646317684121;7283.817904552376;7289.052423185005;9626.278029147807;9926.057024582653;9926.45404502752;9964.501774911261;9970.900290997106;9973.950130249375;9980.650677226298;9758.219342452587;9811.11699947001;9818.90181098194;9830.70507884761;9835;9718.757031074208;9748.26887983404;9774.51127443625;9778.608855645765;9787.951060244724;37334.813325933195;37627;37662.81168594167;37687.62312376869;37717.24565508674;2914.650241970956;3207.695268949446;3568.9107772305642;3593.6406359364114;3633.418653015531;28338.71661283402;28635.14094577145;28797.712022879714;29581.704182958325;29672.109836704934;3446.5174875517446;3559.4126969050076;3591.102224443889;3631.237440137574;3653.1232504199065;281932;285051;285674;394862.99999999715;395177;46631;47087;47108;47178.76410617925;47189.5281047192;32006;33039.83480082632;33100;34730.652693472744;56619.43380566224;13049.086563940433;13211.207327560378;13230.338483075808;13230.73538529224;13231;9696;9789.070038346346;9789.21686265097;9801.460919649346;9809.313348065567;15416.229188540528;17149;17751;17852.642947140983;18080.276788928295;6652.534322597468;6662.367075127855;6754.358335958076;6767.1879374475375;6849.2808255132495;762.9198934111838;833.3916241143999;886.4061079077034;886.778305423644;952.2477242978108;25804.61293080605;27698.5845212322;27809;28236.294092647437;28256.8587157067;932.2914584915513;946.5551190940384;961.4904100826573;985.1478471122571;1007.8891321954579;13896.444142234399;14600.926995364955;14665.92667036658;14832.555023349316;14870.182139982406;392612;396738;398060;398470;399221;48667.513324867;49163.75418122886;49180.75409622929;49244;49350.50649493531;1028.4908970059869;1128.8306753986967;1170.9765804683689;1173.935433551163;1188.5958774016876;26930.59604105979;28639.427211455237;29068.879651484935;29547;29655;40513.59486405098;40991.38512922368;41026.1794764109;41038.1792364157;41065;307069;308035;308674;309375;309526;24257.514849702555;24805.62791558164;24856;25095;25729.228123156336;37904.62095379011;38226.617733822306;41033.589664102976;41263.381049283686;41578;34360.82819585886;34779.130521737156;34885.65114348925;35110;35152.29695406129;34204.48693269653;34539.654603453644;34699.65300347065;34923.825380872935;35001.8249908759;34273;34566.30867382688;34904.65095349115;35012.64987350094;35697.46453803143;30202.24494387658;32424.189395265308;32485.837570811993;32600.83699581487;32644.34711305808;24429.3892652678;24556;24561.263162105166;24958.37604059913;25253.24240272795 12:07:39 INFO - PROCESS | 9818 | |2;jquery.html;341.8361769995926;349.0941008084023;361.10806308418205;363.42941581716707;382.33473755665136;12260.81608775869;14914.403423863047;15035.624109397271;16471.83528164718;16605.335786568554;14876.776848347283;15340.386384544632;15381;15472.458463953764;15553.611159721013;4176.498820141587;4654.6974446661025;4800.879978000543;4802.279658051303;5179.404368497614;5081.5172558607055;5114.846554603368;5116.513931176551;5116.974415127919;5119.001794650045;4897.877553061184;5077.669951453144;5081.263216833557;5087.211482220243;5092.210707340369;5095.949040509585;5137.2037334213255;5141.177411614142;5141.562967147759;5143.074246635604;4431.911361772746;4518.164139634146;4633.953660463386;4647.209974304376;4650.906981860344;12002.339871307162;12098.213616114925;12115.515379384815;12117.39413029345;12176.939115304367;1776.360510216321;1838.6506563752844;1886.7830199527093;1976.9209231630718;2333.1134169015836;9006.414583052081;9049.276057915351;9174.587143578556;9179.842736956809;9395.06049395062;1650.8431698988577;1660.1118401655178;1717.5706073481629;1717.9914100429544;1735.6702226577036;63958;66538.00192997158;66989.66505167443;67355.32644673588;68876;9747.805043899083;9904.257180711475;9922.553485093189;10009.499525023866;10678.893211067945;13604.115732477358;13700.10949288313;13703.725925481434;13708.725825483434;13709.383077761524;6601.075849381091;6729.158855143107;6832.077669514552;7022.157341118997;7023.578585284899;6317.5893566918;6333.778317758856;6515.348465153446;6521.347865213441;6558.606483610999;4196.622303992655;4229.45017147775;4236.576342365739;4250.23495770758;4268.701190916669;1779.288284686136;1815.364622382182;1850.685383484811;1852.5090850924516;1877.4461533847548;760.4258784617579;788.8974433323631;810.2545657994541;850.995745021271;894.3784070071368;16333.591660208589;16802.495925122264;16896.155192240338;17183.65632687339;17279;803.7048102778678;821.1337039423346;839.412411312084;855.3798496090285;868.1622234543696;5599.412061733541;5765.682887441147;6023.6385816851125;9169.35814492979;9203.159368126402;333924;358821;364452;365937;383941;57528.424715752306;73274;75792;76716;77161;403.61858044148;421.652136986987;432.6646848692289;433.22452809470695;436.30627302589033;9367.484788336707;9538.093881081286;9734.610615575297;9806.460644664612;10373.896261037293;33003.20492052434;35942.460863087595;36362.090947726516;38018.75767836266;38780.030499236615;48297.517024830704;48392.5160748388;48398;48561.27158092702;48588.75705621449;7444.590547519939;7475.289847464483;7513;7605.88591171144;7671.961640191764;7888.802779930318;10429.895701042893;11051.28166669196;11122.165837562054;11162.218644694793;9310.441373517611;9343.626254949726;9438.339316247797;9633.42199468006;9676.290638621198;9741.512924353896;9750.268729845147;9863.506824658594;9865.852012219966;9886.209103271578;9788.314817962675;9940.801183976135;9971.950140249251;9994.250431217833;10385.169186464913;7683.116441609063;7746.457747957589;7891.408144389079;7978.523973065002;8134.349252059703;9423.952880235554;9670.56482458277;9802.803943920939;9974.251931105051;10038.447885366375 12:07:39 INFO - PROCESS | 9818 | |3;mootools.html;1300.6358219698482;1357.050064954532;1397.4969011155981;1588.9523314300575;1675.7067513185189;6750.122484077063;7382.48322617417;7419.443541734365;8013.358931285497;8035.3169980551575;7496.475246732731;7867.1739467355965;7867.449278550504;7871.134175240719;7874.842503149934;2154.806067453929;2181.1275489804125;2181.269274792938;2181.5636872625537;2183.3559100065518;1879.7180422936533;2137.2092325839462;2150.193677370986;2172.858764180331;2175.9020844062056;2193.4297082758517;2229.843910926236;2232.7097477327925;2233.3746550965757;2235.5864165129424;2142.3680014395713;2164.1127137873395;2169.0781417897488;2172.1420039084633;2178.9128434862587;2141.6894550290276;2151.752548456932;2156.795104465073;2157.471419502216;2191.9671204931938;7711.691532338699;7872.252136047066;7883.842323153563;7883.960580197119;7891.763247102596;4332.241857674926;4487.52880947499;4489.393931819195;4491.528389519119;4520.11857687751;2924.956125658117;3044.939101217963;3080.9229769255726;3089.196808829698;3115.2679120406688;900.1294240144822;916.7121384989362;917.3440989692402;928.7631653928273;930.6277489004385;10722.731931701692;10760.354378737222;10784.406857622827;10795.136389088933;10813;4092.959070409258;4187.853425130106;4275.294576394922;4285.057287396768;4307.461567304087;9220.170184683411;9228.5847136879;9229.16937475617;9229.95385023084;9235;4478.193925093449;4490.416245888079;4490.797914093873;4491.034427598082;4493.573110554492;3980.980095099564;4087.3255912774653;4088.366303223005;4092.897677558085;4093.672506199497;3539.5752509699;3643.417053271464;3649.087728067983;3679.448082787603;3723.8138093095235;984.9655262065793;1108.817045187535;1131.728385187549;1151.7178291318512;1168.7837750016274;828.4731568715393;832.76682528892;835.4277320035795;859.1108203009854;863.1670438027209;5129.333186685782;5144.948550514522;5262.97368513155;5363.383210930793;5390.056740070472;866.7833041739565;868.1058509734983;873.8077622922947;930.4928813796362;948.8766460360247;3544.397452433041;3727;3830.9616903830606;3874.380099184117;3875.903102422462;8683.392162548562;8939.195472407515;8956.462612243286;9019.729408117766;9423.670171543963;8870.467771933705;9230.769230769285;9236.353455258068;9250.398724082914;9261;7163.3552980232025;7204.675789589481;7326.4505162113055;7377.81555461107;7417.517861338995;5586.078297080936;5605.859853503695;5681.744321505625;5764.106563482667;5941.762329506944;8669.869951950599;8859.557022148996;9021.90978090237;9043.909560904307;9062.909370906207;8554.144585541397;8985.236254918405;9070.81858362816;9073.455592664197;9212.216961558075;7369.4841361106355;7408.444366672414;7494.962525187339;7510.774676759706;7519.135299440634;7080.822979425556;7471.626418679153;7510.361619262424;7519.887201692089;7523.1348394935285;5237.580993520433;6699.933000669931;6784.219814721173;6792.558483698544;7011.544249623758;6228.377162283736;6604.966975165094;6729.0915726376315;6790.083338749206;6808.897866532105;6434.517411194272;6569.9343006569325;6575.572587781779;6581.045748366556;6632.734690612321;4497.5052744198765;4616.184127682044;4701.341812146234;4715.504871988392;4718.811247550059;4536.6824322297125;4643.187442197534;4677.2750223715375;4811.1820990431015;4950.034743225036 12:07:39 INFO - PROCESS | 9818 | |4;prototype.html;287.7338461922721;298.44787143784;303.82378220632035;306.15806532036896;306.5570250987324;4620.953790462095;4799.256115302125;4825.372701548798;4861.9513804861945;4879.194932836082;4648.860534183971;4666.883327916804;4691.7801371643445;4702.553257440546;4765.451228350783;3769.5853456119803;3781.432785082246;3790.2040571480024;3800.9429858552144;3805.9619403805887;3546.3616549021167;3785.0158958670804;3791.791451470168;3794.4498047783054;3802.6007269236748;3344.331133773243;3581.2988830305526;3740.3267411865854;3741.38267185914;3745.906352341186;3750.456183853353;3758.642928921748;3759.473673685686;3761.1725420407465;3770.5286839145106;3323.258311892698;3328.3842489139342;3331.267121233325;3338.699517043478;3342.1143396999814;4471.195184866723;4618.722876627379;4636.44362676481;4649.628029757611;4675.625949923998;4278.850240241577;4283.121959998193;4321.848735294249;4324.200022995725;4329.415528903589;4952.455229924705;4961.2465081879545;4963.528464795839;4976.377952755905;4987.875303117415;3357.6306606273292;3662.34077865984;3675.8162091895565;3679.797611131387;3682.4660424238336;5177.197534382177;5183.14478111115;5193.818216362447;5198.2202669599865;5223.764930578133;3621.94567081494;3622.1487950331652;3631.8184090795353;3634.6547078027547;3637.108908317426;3659.1949771050326;3668.5230919980763;3669.6513831185994;3701.592824789271;3722.1625134344554;4141.378793181047;4186.392973018956;4215.704900656925;4238.385434112098;4262.936055959163;4924.975375123173;4931.16170251051;4960.677555958851;4973.9554693514765;4982.90034199314;1183.828344889986;1216.2459275249403;1221.3893053473264;1239.3555351217317;1259.703969567151;834.8246868157634;844.9860167798544;853.8676505141713;878.2490970220497;885.7741275974586;4412.271975124133;4432.578905004019;4434.667399945017;4442.888927776831;4478.753668548261;5148.9742551287;5159.638825282269;5167.793288268503;5175.430702622709;5195.376554813447;4301.935470967938;4494.4606647202545;4504.635066590066;4516.277395616686;4521.914740462265;2750.546159883637;2756.353900255737;2767.6576860222776;2768.8477133757433;2774.5283301838735;4796.880077998078;4946.554810067111;4955.132851750929;4956.281339205795;4982.501749825061;5256.237845512379;5257.842264732064;5261.815836445706;5272.2355258487305;5292.391374991848;4879.048585525859;4879.731269869789;4892.486288939681;4902.681325713817;4925.926111108408;5013.696438925833;5151.562117220078;5153.149730294459;5161.612879034013;5174.172132458789;5014.674046186986;5017.698938063728;5035.974820125876;5050.696958182521;5073.213651883964;4906.154430430271;4913.550502601813;4919.2129259318335;4956.8760780980765;4990;3442.2943296624635;3687.2256826065754;3693.409054551259;3706.7034637228417;3706.9073273168387;5138.229265610188;5138.614603904797;5140.254663073908;5146.845594632167;5150.562202212854;4953.876153096201;4966.726830024383;4973.950260497349;5030.723310217973;5050.368703912011;4900.950990490192;4982;5068.923966140437;5070.746462676778;5073.619478539051;4724.149653062344;4802.687825291345;4893.559579637849;4905.926411103765;4948.975255123702;5037.219231019198;5041.504455294653;5049;5052.924206136838;5053.949460505348;4909.607231421549;4916.213405855046;4943.65394422387;4945.67853089548;4946.35697359341 12:07:39 INFO - PROCESS | 9818 | |5;yui.html;581.5771061080483;598.0610441606676;667.3393340592814;672.7678950761989;679.3681875855459;13281.269530175836;13879.375428105734;13919.721605567882;13950.372233249516;13951.790723139162;13119.6720081998;13156.802647960289;13383.59849204523;13393.464261429555;13400.128991615538;593.4303069053714;713.2083387439964;721;723.8371366442548;747.8691229034897;752.9021227240479;755.207032615754;756.0549313358302;756.0851369842497;756.3911051603457;780.1886038519932;781.6443518199205;787.106633970442;788.0110461370972;788.0700773087755;625.3777491396067;754.1741792736944;767.8464307138595;772.3589420780738;784.1256998446719;565.124057710547;568.7838621323871;568.8577855536116;569.663898300005;569.9544036477072;12884.935575322157;12916.54792082282;12922.28927408992;12931;12972.286524241163;12744.745105097845;13031.739365212738;13161.934190329082;13604.523841665594;13932;10934.835977460345;10973.50619222137;11230.045446137088;11247.381394023325;11744.354060526668;4068.837246510136;4089.44792453018;4121;4166.395872598487;4268.189044081614;63405.36594634041;63824.68087659532;63914.68042659803;63920.680396597716;64302;10241.07830295277;10322.2258330624;10672.092872105803;10679.038886500251;10762.94618526918;19452.027398630013;19569.706454403196;19637.705434418494;19879.60240795176;20335;6699.732010719516;6726.428253598499;6831.658417079127;6889.931100689029;6916.446684265246;3426.7601267911505;3443.139215196201;3446.4485682290715;3492.650734926487;3512.2448673535314;2844.601755754196;2923.0792300425296;2937.7943543952147;2947.484190266695;2954.054702495181;496.377046806263;498.822917864153;501.8068043803162;503.6449303241206;506.7618219436859;515.7163560041962;519.3196912045233;524.8635354807777;530.7823792245238;561.8342588936274;6921.303755112158;7374.631268436557;7390.260973902674;7545.094588649397;7698.884516732253;450.9143262780061;520.9869753256199;600.2257088356059;611.7430679114782;622.1507642068544;3446.638102999199;3612.9947878926923;3816.542014958223;3876.8836934891997;3877.7091718121255;103235.48382258191;104189.47905260425;104596;106114.16372099455;108182.45908770406;48421.27368089482;48743.75628121837;87760;88620.5568972151;90882;77037;78754.60622696849;81132.59433702794;81733.59133204295;82571;7646.885296720442;7942.523448593103;8085.912194149786;8108.432409731262;8138.796530086558;45706.54293457156;46728.766356168;47689.28466072942;48236.517634823205;48717.26924096212;38535.80732096321;44058.55941440545;59251.1112333324;59332;62415.6879215601;10546.78906421852;10591.523381448007;10698.465076745975;10960.890391095987;11141.554337826721;12398.5660501882;12778.424970876147;12795.680107997374;12906.80639790385;12995.545155919497;10951.521544591378;10954.342739435659;11004;11062.889371106186;11441.942790285995;10616.787664246825;11048.447577621248;11408.144389170679;11501.884981150417;11505.827412588651;11504.53981840717;11523.366214857928;12028.15802893789;12044.337561434206;12057.879421206027;8700.60847261862;9170.358074934957;9194.17252447283;9242.214411775074;9609.90390096118;8452.323814094734;9036.412633178823;9450.905490945002;9875.654352097643;10039.949800250952 12:07:39 INFO - PROCESS | 9818 | __end_tp_report 12:07:39 INFO - PROCESS | 9818 | __start_cc_report 12:07:39 INFO - PROCESS | 9818 | _x_x_mozilla_cycle_collect,940 12:07:39 INFO - PROCESS | 9818 | __end_cc_report 12:07:39 INFO - PROCESS | 9818 | __startTimestamp1473361659776__endTimestamp 12:07:39 INFO - PROCESS | 9818 | 12:07:39 INFO - PROCESS | 9818 | ------- Summary: start ------- 12:07:39 INFO - PROCESS | 9818 | Number of tests: 6 12:07:39 INFO - PROCESS | 9818 | 12:07:39 INFO - PROCESS | 9818 | [#0] dojo.html Cycles:165 Average:4662.06 Median:4826.73 stddev:495.12 (10.3%) stddev-sans-first:468.98 12:07:39 INFO - PROCESS | 9818 | Values: 2582.0 2612.5 2615.5 2624.6 2633.5 4552.7 4612.1 4633.6 4703.6 4773.1 4662.8 4665.2 4666.7 4671.5 4725.9 4179.5 4201.1 4277.1 4368.2 4453.2 4380.0 4408.3 4427.3 4446.2 4453.2 4206.6 4238.8 4247.6 4282.2 4340.8 4268.5 4275.5 4281.4 4319.6 4336.9 4235.8 4268.4 4287.2 4288.4 4345.3 4648.0 4708.2 4709.5 4738.4 4797.3 4863.1 4988.9 4997.0 5042.2 5065.3 5078.1 5095.4 5109.2 5117.7 5191.9 4579.8 4756.6 4759.0 4760.1 4805.1 5098.2 5109.3 5116.9 5117.3 5201.9 4944.9 4955.4 4968.6 5020.6 5036.8 4823.7 5045.5 5047.5 5056.5 5065.6 4874.9 4939.9 4944.8 4966.7 5010.9 4925.4 4931.7 4938.0 4943.6 5004.7 4162.4 4273.2 4275.1 4285.8 4346.8 3646.2 3719.4 3742.7 3763.8 3831.8 4400.4 4401.3 4403.5 4427.7 4452.2 5079.2 5083.7 5104.5 5106.3 5139.7 4141.0 4321.4 4341.8 4350.9 4372.3 4550.1 4559.5 4567.8 4609.4 4620.5 4790.6 4805.8 4807.4 4813.2 4864.1 4916.9 5000.2 5057.5 5105.7 5122.9 4848.4 4858.9 4870.0 4907.7 4922.2 5044.8 5048.0 5048.7 5050.8 5051.4 4912.7 4994.9 5029.8 5056.2 5163.8 4920.1 4922.6 4925.2 4933.2 4965.5 4918.9 4932.2 4933.4 4933.6 4981.0 4725.0 4817.7 4826.7 4832.2 4913.1 4960.6 4965.1 4966.1 4969.0 4988.5 4833.2 4834.9 4837.5 4879.1 4898.9 12:07:39 INFO - PROCESS | 9818 | 12:07:39 INFO - PROCESS | 9818 | [#1] ext.html Cycles:180 Average:48705.77 Median:37644.91 stddev:91817.96 (243.9%) stddev-sans-first:92004.36 12:07:39 INFO - PROCESS | 9818 | Values: 556.7 563.1 566.3 570.2 570.4 28177.9 38870.8 39997.6 40036.8 43702.6 39356.8 39672.4 39781.0 39801.0 39826.0 7027.2 7568.3 7711.5 7715.4 7720.1 7073.6 7283.8 7289.1 9626.3 9926.1 9926.5 9964.5 9970.9 9974.0 9980.7 9758.2 9811.1 9818.9 9830.7 9835.0 9718.8 9748.3 9774.5 9778.6 9788.0 37334.8 37627.0 37662.8 37687.6 37717.2 2914.7 3207.7 3568.9 3593.6 3633.4 28338.7 28635.1 28797.7 29581.7 29672.1 3446.5 3559.4 3591.1 3631.2 3653.1 281932.0 285051.0 285674.0 394863.0 395177.0 46631.0 47087.0 47108.0 47178.8 47189.5 32006.0 33039.8 33100.0 34730.7 56619.4 13049.1 13211.2 13230.3 13230.7 13231.0 9696.0 9789.1 9789.2 9801.5 9809.3 15416.2 17149.0 17751.0 17852.6 18080.3 6652.5 6662.4 6754.4 6767.2 6849.3 762.9 833.4 886.4 886.8 952.2 25804.6 27698.6 27809.0 28236.3 28256.9 932.3 946.6 961.5 985.1 1007.9 13896.4 14600.9 14665.9 14832.6 14870.2 392612.0 396738.0 398060.0 398470.0 399221.0 48667.5 49163.8 49180.8 49244.0 49350.5 1028.5 1128.8 1171.0 1173.9 1188.6 26930.6 28639.4 29068.9 29547.0 29655.0 40513.6 40991.4 41026.2 41038.2 41065.0 307069.0 308035.0 308674.0 309375.0 309526.0 24257.5 24805.6 24856.0 25095.0 25729.2 37904.6 38226.6 41033.6 41263.4 41578.0 34360.8 34779.1 34885.7 35110.0 35152.3 34204.5 34539.7 34699.7 34923.8 35001.8 34273.0 34566.3 34904.7 35012.6 35697.5 30202.2 32424.2 32485.8 32600.8 32644.3 24429.4 24556.0 24561.3 24958.4 25253.2 12:07:39 INFO - PROCESS | 9818 | 12:07:39 INFO - PROCESS | 9818 | [#2] jquery.html Cycles:180 Average:22478.69 Median:5081.39 stddev:59875.33 (1178.3%) stddev-sans-first:60020.23 12:07:39 INFO - PROCESS | 9818 | Values: 341.8 349.1 361.1 363.4 382.3 12260.8 14914.4 15035.6 16471.8 16605.3 14876.8 15340.4 15381.0 15472.5 15553.6 4176.5 4654.7 4800.9 4802.3 5179.4 5081.5 5114.8 5116.5 5117.0 5119.0 4897.9 5077.7 5081.3 5087.2 5092.2 5095.9 5137.2 5141.2 5141.6 5143.1 4431.9 4518.2 4634.0 4647.2 4650.9 12002.3 12098.2 12115.5 12117.4 12176.9 1776.4 1838.7 1886.8 1976.9 2333.1 9006.4 9049.3 9174.6 9179.8 9395.1 1650.8 1660.1 1717.6 1718.0 1735.7 63958.0 66538.0 66989.7 67355.3 68876.0 9747.8 9904.3 9922.6 10009.5 10678.9 13604.1 13700.1 13703.7 13708.7 13709.4 6601.1 6729.2 6832.1 7022.2 7023.6 6317.6 6333.8 6515.3 6521.3 6558.6 4196.6 4229.5 4236.6 4250.2 4268.7 1779.3 1815.4 1850.7 1852.5 1877.4 760.4 788.9 810.3 851.0 894.4 16333.6 16802.5 16896.2 17183.7 17279.0 803.7 821.1 839.4 855.4 868.2 5599.4 5765.7 6023.6 9169.4 9203.2 333924.0 358821.0 364452.0 365937.0 383941.0 57528.4 73274.0 75792.0 76716.0 77161.0 403.6 421.7 432.7 433.2 436.3 9367.5 9538.1 9734.6 9806.5 10373.9 33003.2 35942.5 36362.1 38018.8 38780.0 48297.5 48392.5 48398.0 48561.3 48588.8 7444.6 7475.3 7513.0 7605.9 7672.0 7888.8 10429.9 11051.3 11122.2 11162.2 9310.4 9343.6 9438.3 9633.4 9676.3 9741.5 9750.3 9863.5 9865.9 9886.2 9788.3 9940.8 9972.0 9994.3 10385.2 7683.1 7746.5 7891.4 7978.5 8134.3 9424.0 9670.6 9802.8 9974.3 10038.4 12:07:39 INFO - PROCESS | 9818 | 12:07:39 INFO - PROCESS | 9818 | [#3] mootools.html Cycles:180 Average:5146.10 Median:5595.97 stddev:2853.78 (51.0%) stddev-sans-first:2847.15 12:07:39 INFO - PROCESS | 9818 | Values: 1300.6 1357.1 1397.5 1589.0 1675.7 6750.1 7382.5 7419.4 8013.4 8035.3 7496.5 7867.2 7867.4 7871.1 7874.8 2154.8 2181.1 2181.3 2181.6 2183.4 1879.7 2137.2 2150.2 2172.9 2175.9 2193.4 2229.8 2232.7 2233.4 2235.6 2142.4 2164.1 2169.1 2172.1 2178.9 2141.7 2151.8 2156.8 2157.5 2192.0 7711.7 7872.3 7883.8 7884.0 7891.8 4332.2 4487.5 4489.4 4491.5 4520.1 2925.0 3044.9 3080.9 3089.2 3115.3 900.1 916.7 917.3 928.8 930.6 10722.7 10760.4 10784.4 10795.1 10813.0 4093.0 4187.9 4275.3 4285.1 4307.5 9220.2 9228.6 9229.2 9230.0 9235.0 4478.2 4490.4 4490.8 4491.0 4493.6 3981.0 4087.3 4088.4 4092.9 4093.7 3539.6 3643.4 3649.1 3679.4 3723.8 985.0 1108.8 1131.7 1151.7 1168.8 828.5 832.8 835.4 859.1 863.2 5129.3 5144.9 5263.0 5363.4 5390.1 866.8 868.1 873.8 930.5 948.9 3544.4 3727.0 3831.0 3874.4 3875.9 8683.4 8939.2 8956.5 9019.7 9423.7 8870.5 9230.8 9236.4 9250.4 9261.0 7163.4 7204.7 7326.5 7377.8 7417.5 5586.1 5605.9 5681.7 5764.1 5941.8 8669.9 8859.6 9021.9 9043.9 9062.9 8554.1 8985.2 9070.8 9073.5 9212.2 7369.5 7408.4 7495.0 7510.8 7519.1 7080.8 7471.6 7510.4 7519.9 7523.1 5237.6 6699.9 6784.2 6792.6 7011.5 6228.4 6605.0 6729.1 6790.1 6808.9 6434.5 6569.9 6575.6 6581.0 6632.7 4497.5 4616.2 4701.3 4715.5 4718.8 4536.7 4643.2 4677.3 4811.2 4950.0 12:07:39 INFO - PROCESS | 9818 | 12:07:39 INFO - PROCESS | 9818 | [#4] prototype.html Cycles:180 Average:4166.17 Median:4744.80 stddev:1209.69 (25.5%) stddev-sans-first:1177.53 12:07:39 INFO - PROCESS | 9818 | Values: 287.7 298.4 303.8 306.2 306.6 4621.0 4799.3 4825.4 4862.0 4879.2 4648.9 4666.9 4691.8 4702.6 4765.5 3769.6 3781.4 3790.2 3800.9 3806.0 3546.4 3785.0 3791.8 3794.4 3802.6 3344.3 3581.3 3740.3 3741.4 3745.9 3750.5 3758.6 3759.5 3761.2 3770.5 3323.3 3328.4 3331.3 3338.7 3342.1 4471.2 4618.7 4636.4 4649.6 4675.6 4278.9 4283.1 4321.8 4324.2 4329.4 4952.5 4961.2 4963.5 4976.4 4987.9 3357.6 3662.3 3675.8 3679.8 3682.5 5177.2 5183.1 5193.8 5198.2 5223.8 3621.9 3622.1 3631.8 3634.7 3637.1 3659.2 3668.5 3669.7 3701.6 3722.2 4141.4 4186.4 4215.7 4238.4 4262.9 4925.0 4931.2 4960.7 4974.0 4982.9 1183.8 1216.2 1221.4 1239.4 1259.7 834.8 845.0 853.9 878.2 885.8 4412.3 4432.6 4434.7 4442.9 4478.8 5149.0 5159.6 5167.8 5175.4 5195.4 4301.9 4494.5 4504.6 4516.3 4521.9 2750.5 2756.4 2767.7 2768.8 2774.5 4796.9 4946.6 4955.1 4956.3 4982.5 5256.2 5257.8 5261.8 5272.2 5292.4 4879.0 4879.7 4892.5 4902.7 4925.9 5013.7 5151.6 5153.1 5161.6 5174.2 5014.7 5017.7 5036.0 5050.7 5073.2 4906.2 4913.6 4919.2 4956.9 4990.0 3442.3 3687.2 3693.4 3706.7 3706.9 5138.2 5138.6 5140.3 5146.8 5150.6 4953.9 4966.7 4974.0 5030.7 5050.4 4901.0 4982.0 5068.9 5070.7 5073.6 4724.1 4802.7 4893.6 4905.9 4949.0 5037.2 5041.5 5049.0 5052.9 5053.9 4909.6 4916.2 4943.7 4945.7 4946.4 12:07:39 INFO - PROCESS | 9818 | 12:07:39 INFO - PROCESS | 9818 | [#5] yui.html Cycles:180 Average:17658.75 Median:47209.03 stddev:25679.99 (54.4%) stddev-sans-first:25720.02 12:07:39 INFO - PROCESS | 9818 | Values: 581.6 598.1 667.3 672.8 679.4 13281.3 13879.4 13919.7 13950.4 13951.8 13119.7 13156.8 13383.6 13393.5 13400.1 593.4 713.2 721.0 723.8 747.9 752.9 755.2 756.1 756.1 756.4 780.2 781.6 787.1 788.0 788.1 625.4 754.2 767.8 772.4 784.1 565.1 568.8 568.9 569.7 570.0 12884.9 12916.5 12922.3 12931.0 12972.3 12744.7 13031.7 13161.9 13604.5 13932.0 10934.8 10973.5 11230.0 11247.4 11744.4 4068.8 4089.4 4121.0 4166.4 4268.2 63405.4 63824.7 63914.7 63920.7 64302.0 10241.1 10322.2 10672.1 10679.0 10762.9 19452.0 19569.7 19637.7 19879.6 20335.0 6699.7 6726.4 6831.7 6889.9 6916.4 3426.8 3443.1 3446.4 3492.7 3512.2 2844.6 2923.1 2937.8 2947.5 2954.1 496.4 498.8 501.8 503.6 506.8 515.7 519.3 524.9 530.8 561.8 6921.3 7374.6 7390.3 7545.1 7698.9 450.9 521.0 600.2 611.7 622.2 3446.6 3613.0 3816.5 3876.9 3877.7 103235.5 104189.5 104596.0 106114.2 108182.5 48421.3 48743.8 87760.0 88620.6 90882.0 77037.0 78754.6 81132.6 81733.6 82571.0 7646.9 7942.5 8085.9 8108.4 8138.8 45706.5 46728.8 47689.3 48236.5 48717.3 38535.8 44058.6 59251.1 59332.0 62415.7 10546.8 10591.5 10698.5 10960.9 11141.6 12398.6 12778.4 12795.7 12906.8 12995.5 10951.5 10954.3 11004.0 11062.9 11441.9 10616.8 11048.4 11408.1 11501.9 11505.8 11504.5 11523.4 12028.2 12044.3 12057.9 8700.6 9170.4 9194.2 9242.2 9609.9 8452.3 9036.4 9450.9 9875.7 10039.9 12:07:39 INFO - PROCESS | 9818 | -------- Summary: end -------- 12:07:39 INFO - PROCESS | 9818 | 12:07:40 INFO - TEST-INFO | 9818: exit 0 12:07:40 INFO - TEST-OK | dromaeo_css | took 1121605ms 12:07:40 INFO - TEST-START | kraken 12:07:40 INFO - operating with platform_type : linux_ 12:07:40 INFO - Initialising browser for kraken test... 12:07:40 INFO - TEST-INFO | started process 10123 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNCWhIy/profile http://localhost:45554/getInfo.html) 12:07:45 INFO - PROCESS | 10123 | __metrics Screen width/height:1600/1200 12:07:45 INFO - PROCESS | 10123 | colorDepth:24 12:07:45 INFO - PROCESS | 10123 | Browser inner width/height: 1024/697 12:07:45 INFO - PROCESS | 10123 | __metrics 12:07:45 INFO - PROCESS | 10123 | 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" 12:07:45 INFO - PROCESS | 10123 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:07:46 INFO - TEST-INFO | 10123: exit 0 12:07:46 INFO - Browser initialized. 12:07:46 INFO - Running cycle 1/1 for kraken test... 12:07:46 INFO - TEST-INFO | started process 10206 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNCWhIy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 12:07:59 INFO - PROCESS | 10206 | RSS: Main: 180076544 12:07:59 INFO - PROCESS | 10206 | 12:08:01 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45554/tests/kraken/driver.html?testName=audio-beat-detection) 12:08:02 INFO - PROCESS | 10206 | RSS: Main: 238792704 12:08:02 INFO - PROCESS | 10206 | 12:08:05 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45554/tests/kraken/driver.html?testName=audio-dft) 12:08:06 INFO - PROCESS | 10206 | RSS: Main: 222752768 12:08:06 INFO - PROCESS | 10206 | 12:08:09 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45554/tests/kraken/driver.html?testName=audio-fft) 12:08:10 INFO - PROCESS | 10206 | RSS: Main: 303529984 12:08:10 INFO - PROCESS | 10206 | 12:08:12 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45554/tests/kraken/driver.html?testName=audio-oscillator) 12:08:12 INFO - PROCESS | 10206 | RSS: Main: 213831680 12:08:12 INFO - PROCESS | 10206 | 12:08:14 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45554/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:08:15 INFO - PROCESS | 10206 | RSS: Main: 215724032 12:08:15 INFO - PROCESS | 10206 | 12:08:18 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45554/tests/kraken/driver.html?testName=imaging-darkroom) 12:08:19 INFO - PROCESS | 10206 | RSS: Main: 253145088 12:08:19 INFO - PROCESS | 10206 | 12:08:22 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45554/tests/kraken/driver.html?testName=imaging-desaturate) 12:08:23 INFO - PROCESS | 10206 | RSS: Main: 247881728 12:08:23 INFO - PROCESS | 10206 | 12:08:26 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45554/tests/kraken/driver.html?testName=json-parse-financial) 12:08:27 INFO - PROCESS | 10206 | RSS: Main: 250699776 12:08:27 INFO - PROCESS | 10206 | 12:08:28 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45554/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:08:29 INFO - PROCESS | 10206 | RSS: Main: 214446080 12:08:29 INFO - PROCESS | 10206 | 12:08:31 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45554/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:08:32 INFO - PROCESS | 10206 | RSS: Main: 222105600 12:08:32 INFO - PROCESS | 10206 | 12:08:34 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45554/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:08:34 INFO - PROCESS | 10206 | RSS: Main: 224215040 12:08:34 INFO - PROCESS | 10206 | 12:08:37 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:08:38 INFO - PROCESS | 10206 | RSS: Main: 217677824 12:08:38 INFO - PROCESS | 10206 | 12:08:41 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:08:41 INFO - PROCESS | 10206 | RSS: Main: 221327360 12:08:41 INFO - PROCESS | 10206 | 12:08:43 INFO - PROCESS | 10206 | Cycle 1(1): loaded http://localhost:45554/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45554/tests/kraken/driver.html?testName=ai-astar) 12:08:44 INFO - PROCESS | 10206 | RSS: Main: 272424960 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | __start_tp_report 12:08:44 INFO - PROCESS | 10206 | _x_x_mozilla_page_load 12:08:44 INFO - PROCESS | 10206 | _x_x_mozilla_page_load_details 12:08:44 INFO - PROCESS | 10206 | |i|pagename|runs| 12:08:44 INFO - PROCESS | 10206 | |0;ai-astar;117;116;121;114;115;115;114;120;113;129 12:08:44 INFO - PROCESS | 10206 | |1;audio-beat-detection;170;123;160;193;129;147;154;123;189;129 12:08:44 INFO - PROCESS | 10206 | |2;audio-dft;162;160;163;163;161;163;163;162;161;166 12:08:44 INFO - PROCESS | 10206 | |3;audio-fft;77;75;76;164;79;77;75;76;158;78 12:08:44 INFO - PROCESS | 10206 | |4;audio-oscillator;83;84;133;84;84;84;144;84;85;143 12:08:44 INFO - PROCESS | 10206 | |5;imaging-gaussian-blur;117;118;118;118;118;118;117;119;118;118 12:08:44 INFO - PROCESS | 10206 | |6;imaging-darkroom;148;146;147;147;146;146;147;148;146;146 12:08:44 INFO - PROCESS | 10206 | |7;imaging-desaturate;94;95;96;94;95;95;96;96;95;96 12:08:44 INFO - PROCESS | 10206 | |8;json-parse-financial;65;66;67;66;67;68;67;67;67;66 12:08:44 INFO - PROCESS | 10206 | |9;json-stringify-tinderbox;66;73;67;67;66;66;66;67;66;67 12:08:44 INFO - PROCESS | 10206 | |10;stanford-crypto-aes;84;83;82;84;88;86;83;82;81;81 12:08:44 INFO - PROCESS | 10206 | |11;stanford-crypto-ccm;133;140;131;135;133;133;133;133;221;132 12:08:44 INFO - PROCESS | 10206 | |12;stanford-crypto-pbkdf2;177;174;176;174;176;174;183;171;176;172 12:08:44 INFO - PROCESS | 10206 | |13;stanford-crypto-sha256-iterative;72;69;71;69;68;69;69;70;69;68 12:08:44 INFO - PROCESS | 10206 | __end_tp_report 12:08:44 INFO - PROCESS | 10206 | __start_cc_report 12:08:44 INFO - PROCESS | 10206 | _x_x_mozilla_cycle_collect,1980 12:08:44 INFO - PROCESS | 10206 | __end_cc_report 12:08:44 INFO - PROCESS | 10206 | __startTimestamp1473361724014__endTimestamp 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | ------- Summary: start ------- 12:08:44 INFO - PROCESS | 10206 | Number of tests: 14 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#0] ai-astar Cycles:10 Average:117.40 Median:116.50 stddev:4.84 (4.2%) stddev-sans-first:5.13 12:08:44 INFO - PROCESS | 10206 | Values: 117.0 116.0 121.0 114.0 115.0 115.0 114.0 120.0 113.0 129.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#1] audio-beat-detection Cycles:10 Average:151.70 Median:157.00 stddev:26.26 (16.7%) stddev-sans-first:27.00 12:08:44 INFO - PROCESS | 10206 | Values: 170.0 123.0 160.0 193.0 129.0 147.0 154.0 123.0 189.0 129.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:1.65 (1.0%) stddev-sans-first:1.74 12:08:44 INFO - PROCESS | 10206 | Values: 162.0 160.0 163.0 163.0 161.0 163.0 163.0 162.0 161.0 166.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#3] audio-fft Cycles:10 Average:93.50 Median:76.50 stddev:35.63 (46.6%) stddev-sans-first:37.28 12:08:44 INFO - PROCESS | 10206 | Values: 77.0 75.0 76.0 164.0 79.0 77.0 75.0 76.0 158.0 78.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#4] audio-oscillator Cycles:10 Average:100.80 Median:84.00 stddev:27.21 (32.4%) stddev-sans-first:28.08 12:08:44 INFO - PROCESS | 10206 | Values: 83.0 84.0 133.0 84.0 84.0 84.0 144.0 84.0 85.0 143.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#5] imaging-gaussian-blur Cycles:10 Average:117.90 Median:118.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 12:08:44 INFO - PROCESS | 10206 | Values: 117.0 118.0 118.0 118.0 118.0 118.0 117.0 119.0 118.0 118.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 12:08:44 INFO - PROCESS | 10206 | Values: 148.0 146.0 147.0 147.0 146.0 146.0 147.0 148.0 146.0 146.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.50 stddev:0.79 (0.8%) stddev-sans-first:0.71 12:08:44 INFO - PROCESS | 10206 | Values: 94.0 95.0 96.0 94.0 95.0 95.0 96.0 96.0 95.0 96.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:67.00 stddev:0.84 (1.3%) stddev-sans-first:0.67 12:08:44 INFO - PROCESS | 10206 | Values: 65.0 66.0 67.0 66.0 67.0 68.0 67.0 67.0 67.0 66.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#9] json-stringify-tinderbox Cycles:10 Average:67.10 Median:67.00 stddev:2.13 (3.2%) stddev-sans-first:2.22 12:08:44 INFO - PROCESS | 10206 | Values: 66.0 73.0 67.0 67.0 66.0 66.0 66.0 67.0 66.0 67.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.50 stddev:2.22 (2.7%) stddev-sans-first:2.35 12:08:44 INFO - PROCESS | 10206 | Values: 84.0 83.0 82.0 84.0 88.0 86.0 83.0 82.0 81.0 81.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#11] stanford-crypto-ccm Cycles:10 Average:142.40 Median:133.00 stddev:27.73 (20.8%) stddev-sans-first:29.20 12:08:44 INFO - PROCESS | 10206 | Values: 133.0 140.0 131.0 135.0 133.0 133.0 133.0 133.0 221.0 132.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.30 Median:176.00 stddev:3.30 (1.9%) stddev-sans-first:3.44 12:08:44 INFO - PROCESS | 10206 | Values: 177.0 174.0 176.0 174.0 176.0 174.0 183.0 171.0 176.0 172.0 12:08:44 INFO - PROCESS | 10206 | 12:08:44 INFO - PROCESS | 10206 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:1.26 (1.8%) stddev-sans-first:0.93 12:08:44 INFO - PROCESS | 10206 | Values: 72.0 69.0 71.0 69.0 68.0 69.0 69.0 70.0 69.0 68.0 12:08:44 INFO - PROCESS | 10206 | -------- Summary: end -------- 12:08:44 INFO - PROCESS | 10206 | 12:08:45 INFO - TEST-INFO | 10206: exit 0 12:08:45 INFO - TEST-OK | kraken | took 64519ms 12:08:45 INFO - SUITE-END | took 1186s 12:08:45 INFO - Completed test suite (00:19:46) 12:08:45 INFO - javascript benchmark 12:08:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2582.0188328435192, 2612.5036243113814, 2615.450755341378, 2624.593188055851, 2633.5259653262406, 4552.749598772075, 4612.0775844831, 4633.606143477804, 4703.6237101031875, 4773.140834649766, 4662.8134874604975, 4665.230237010889, 4666.673332866692, 4671.509491503394, 4725.881852953687, 4179.477565304337, 4201.054762678388, 4277.144571085795, 4368.235558777217, 4453.198424283628, 4380.036391993772, 4408.3167109097985, 4427.2916333386665, 4446.199684056868, 4453.198424283628, 4206.600372964564, 4238.830446782125, 4247.596478334584, 4282.207791558571, 4340.826366945318, 4268.487781466244, 4275.46556680415, 4281.400603915455, 4319.632831209351, 4336.869893903188, 4235.767032813194, 4268.423762792046, 4287.164003019412, 4288.356746488021, 4345.34819777036, 4647.9535204647855, 4708.176069187913, 4709.529047095263, 4738.384010078667, 4797.328374027639, 4863.051704917542, 4988.87527811804, 4996.975015124937, 5042.243663450475, 5065.265536497187, 5078.13671675816, 5095.439501654815, 5109.208072748693, 5117.7185254810975, 5191.922121168185, 4579.839705610288, 4756.5956893664425, 4758.97681998372, 4760.09558183944, 4805.063012712522, 5098.235264710249, 5109.310243117206, 5116.948830511647, 5117.257997590403, 5201.895962080813, 4944.901101978012, 4955.430125535538, 4968.552830245295, 5020.648554601143, 5036.7733451994745, 4823.686460380064, 5045.470225626256, 5047.495250474996, 5056.544910957958, 5065.6200784941275, 4874.8787778810365, 4939.876503087452, 4944.826931057396, 4966.726830024383, 5010.899782004412, 4925.38432695913, 4931.679440836406, 4938.0, 4943.604511639061, 5004.724740139327, 4162.41726158338, 4273.166732487135, 4275.080857615628, 4285.764282964405, 4346.826126954887, 3646.21606354635, 3719.386301260262, 3742.6631603155847, 3763.7929913854455, 3831.827567759402, 4400.361947517656, 4401.295792673157, 4403.515613282536, 4427.667924905581, 4452.176347375681, 5079.238114282887, 5083.74581270935, 5104.540591346797, 5106.310648062538, 5139.743012849342, 4141.047559061432, 4321.395004699345, 4341.782910854445, 4350.912981740411, 4372.300431930876, 4550.067236216568, 4559.52125026874, 4567.771611419482, 4609.400777898919, 4620.514845941195, 4790.592799612003, 4805.831795887128, 4807.351007613997, 4813.181759100891, 4864.075825593126, 4916.901661966669, 5000.224965130411, 5057.519535644108, 5105.693658380509, 5122.948770512247, 4848.442429120555, 4858.878528036686, 4870.025994801124, 4907.730074845917, 4922.212446008622, 5044.798208071636, 5047.965167140654, 5048.7475626219275, 5050.77271522775, 5051.419086805065, 4912.6561140719805, 4994.850154495371, 5029.84910452687, 5056.241563765465, 5163.845084647466, 4920.114379411741, 4922.606191504599, 4925.236588328815, 4933.21068629032, 4965.528274813887, 4918.901621967612, 4932.186189278729, 4933.407991040955, 4933.55597996182, 4980.950190498049, 4724.976375118103, 4817.710937343771, 4826.734529600765, 4832.1543729846435, 4913.140200464833, 4960.627952903619, 4965.131102057053, 4966.130927087817, 4969.031038947515, 4988.451270360185, 4833.154198015403, 4834.903301934012, 4837.4920633332995, 4879.072976134523, 4898.8775280618265], "value": 4629.980665075819, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [556.7438978070088, 563.1102857485174, 566.2610293566894, 570.2301892445197, 570.4210226619981, 28177.859110704445, 38870.80564597176, 39997.60002399975, 40036.79981600088, 43702.562974370245, 39356.80321598395, 39672.40491392624, 39781.0, 39801.0, 39826.0, 7027.156741191038, 7568.318851303382, 7711.460197786158, 7715.382769378464, 7720.073591169067, 7073.646317684121, 7283.817904552376, 7289.052423185005, 9626.278029147807, 9926.057024582653, 9926.45404502752, 9964.501774911261, 9970.900290997106, 9973.950130249375, 9980.650677226298, 9758.219342452587, 9811.11699947001, 9818.90181098194, 9830.70507884761, 9835.0, 9718.757031074208, 9748.26887983404, 9774.51127443625, 9778.608855645765, 9787.951060244724, 37334.813325933195, 37627.0, 37662.81168594167, 37687.62312376869, 37717.24565508674, 2914.650241970956, 3207.695268949446, 3568.9107772305642, 3593.6406359364114, 3633.418653015531, 28338.71661283402, 28635.14094577145, 28797.712022879714, 29581.704182958325, 29672.109836704934, 3446.5174875517446, 3559.4126969050076, 3591.102224443889, 3631.237440137574, 3653.1232504199065, 281932.0, 285051.0, 285674.0, 394862.99999999715, 395177.0, 46631.0, 47087.0, 47108.0, 47178.76410617925, 47189.5281047192, 32006.0, 33039.83480082632, 33100.0, 34730.652693472744, 56619.43380566224, 13049.086563940433, 13211.207327560378, 13230.338483075808, 13230.73538529224, 13231.0, 9696.0, 9789.070038346346, 9789.21686265097, 9801.460919649346, 9809.313348065567, 15416.229188540528, 17149.0, 17751.0, 17852.642947140983, 18080.276788928295, 6652.534322597468, 6662.367075127855, 6754.358335958076, 6767.1879374475375, 6849.2808255132495, 762.9198934111838, 833.3916241143999, 886.4061079077034, 886.778305423644, 952.2477242978108, 25804.61293080605, 27698.5845212322, 27809.0, 28236.294092647437, 28256.8587157067, 932.2914584915513, 946.5551190940384, 961.4904100826573, 985.1478471122571, 1007.8891321954579, 13896.444142234399, 14600.926995364955, 14665.92667036658, 14832.555023349316, 14870.182139982406, 392612.0, 396738.0, 398060.0, 398470.0, 399221.0, 48667.513324867, 49163.75418122886, 49180.75409622929, 49244.0, 49350.50649493531, 1028.4908970059869, 1128.8306753986967, 1170.9765804683689, 1173.935433551163, 1188.5958774016876, 26930.59604105979, 28639.427211455237, 29068.879651484935, 29547.0, 29655.0, 40513.59486405098, 40991.38512922368, 41026.1794764109, 41038.1792364157, 41065.0, 307069.0, 308035.0, 308674.0, 309375.0, 309526.0, 24257.514849702555, 24805.62791558164, 24856.0, 25095.0, 25729.228123156336, 37904.62095379011, 38226.617733822306, 41033.589664102976, 41263.381049283686, 41578.0, 34360.82819585886, 34779.130521737156, 34885.65114348925, 35110.0, 35152.29695406129, 34204.48693269653, 34539.654603453644, 34699.65300347065, 34923.825380872935, 35001.8249908759, 34273.0, 34566.30867382688, 34904.65095349115, 35012.64987350094, 35697.46453803143, 30202.24494387658, 32424.189395265308, 32485.837570811993, 32600.83699581487, 32644.34711305808, 24429.3892652678, 24556.0, 24561.263162105166, 24958.37604059913, 25253.24240272795], "value": 17476.32843599838, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.8361769995926, 349.0941008084023, 361.10806308418205, 363.42941581716707, 382.33473755665136, 12260.81608775869, 14914.403423863047, 15035.624109397271, 16471.83528164718, 16605.335786568554, 14876.776848347283, 15340.386384544632, 15381.0, 15472.458463953764, 15553.611159721013, 4176.498820141587, 4654.6974446661025, 4800.879978000543, 4802.279658051303, 5179.404368497614, 5081.5172558607055, 5114.846554603368, 5116.513931176551, 5116.974415127919, 5119.001794650045, 4897.877553061184, 5077.669951453144, 5081.263216833557, 5087.211482220243, 5092.210707340369, 5095.949040509585, 5137.2037334213255, 5141.177411614142, 5141.562967147759, 5143.074246635604, 4431.911361772746, 4518.164139634146, 4633.953660463386, 4647.209974304376, 4650.906981860344, 12002.339871307162, 12098.213616114925, 12115.515379384815, 12117.39413029345, 12176.939115304367, 1776.360510216321, 1838.6506563752844, 1886.7830199527093, 1976.9209231630718, 2333.1134169015836, 9006.414583052081, 9049.276057915351, 9174.587143578556, 9179.842736956809, 9395.06049395062, 1650.8431698988577, 1660.1118401655178, 1717.5706073481629, 1717.9914100429544, 1735.6702226577036, 63958.0, 66538.00192997158, 66989.66505167443, 67355.32644673588, 68876.0, 9747.805043899083, 9904.257180711475, 9922.553485093189, 10009.499525023866, 10678.893211067945, 13604.115732477358, 13700.10949288313, 13703.725925481434, 13708.725825483434, 13709.383077761524, 6601.075849381091, 6729.158855143107, 6832.077669514552, 7022.157341118997, 7023.578585284899, 6317.5893566918, 6333.778317758856, 6515.348465153446, 6521.347865213441, 6558.606483610999, 4196.622303992655, 4229.45017147775, 4236.576342365739, 4250.23495770758, 4268.701190916669, 1779.288284686136, 1815.364622382182, 1850.685383484811, 1852.5090850924516, 1877.4461533847548, 760.4258784617579, 788.8974433323631, 810.2545657994541, 850.995745021271, 894.3784070071368, 16333.591660208589, 16802.495925122264, 16896.155192240338, 17183.65632687339, 17279.0, 803.7048102778678, 821.1337039423346, 839.412411312084, 855.3798496090285, 868.1622234543696, 5599.412061733541, 5765.682887441147, 6023.6385816851125, 9169.35814492979, 9203.159368126402, 333924.0, 358821.0, 364452.0, 365937.0, 383941.0, 57528.424715752306, 73274.0, 75792.0, 76716.0, 77161.0, 403.61858044148, 421.652136986987, 432.6646848692289, 433.22452809470695, 436.30627302589033, 9367.484788336707, 9538.093881081286, 9734.610615575297, 9806.460644664612, 10373.896261037293, 33003.20492052434, 35942.460863087595, 36362.090947726516, 38018.75767836266, 38780.030499236615, 48297.517024830704, 48392.5160748388, 48398.0, 48561.27158092702, 48588.75705621449, 7444.590547519939, 7475.289847464483, 7513.0, 7605.88591171144, 7671.961640191764, 7888.802779930318, 10429.895701042893, 11051.28166669196, 11122.165837562054, 11162.218644694793, 9310.441373517611, 9343.626254949726, 9438.339316247797, 9633.42199468006, 9676.290638621198, 9741.512924353896, 9750.268729845147, 9863.506824658594, 9865.852012219966, 9886.209103271578, 9788.314817962675, 9940.801183976135, 9971.950140249251, 9994.250431217833, 10385.169186464913, 7683.116441609063, 7746.457747957589, 7891.408144389079, 7978.523973065002, 8134.349252059703, 9423.952880235554, 9670.56482458277, 9802.803943920939, 9974.251931105051, 10038.447885366375], "value": 7447.985803634338, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1300.6358219698482, 1357.050064954532, 1397.4969011155981, 1588.9523314300575, 1675.7067513185189, 6750.122484077063, 7382.48322617417, 7419.443541734365, 8013.358931285497, 8035.3169980551575, 7496.475246732731, 7867.1739467355965, 7867.449278550504, 7871.134175240719, 7874.842503149934, 2154.806067453929, 2181.1275489804125, 2181.269274792938, 2181.5636872625537, 2183.3559100065518, 1879.7180422936533, 2137.2092325839462, 2150.193677370986, 2172.858764180331, 2175.9020844062056, 2193.4297082758517, 2229.843910926236, 2232.7097477327925, 2233.3746550965757, 2235.5864165129424, 2142.3680014395713, 2164.1127137873395, 2169.0781417897488, 2172.1420039084633, 2178.9128434862587, 2141.6894550290276, 2151.752548456932, 2156.795104465073, 2157.471419502216, 2191.9671204931938, 7711.691532338699, 7872.252136047066, 7883.842323153563, 7883.960580197119, 7891.763247102596, 4332.241857674926, 4487.52880947499, 4489.393931819195, 4491.528389519119, 4520.11857687751, 2924.956125658117, 3044.939101217963, 3080.9229769255726, 3089.196808829698, 3115.2679120406688, 900.1294240144822, 916.7121384989362, 917.3440989692402, 928.7631653928273, 930.6277489004385, 10722.731931701692, 10760.354378737222, 10784.406857622827, 10795.136389088933, 10813.0, 4092.959070409258, 4187.853425130106, 4275.294576394922, 4285.057287396768, 4307.461567304087, 9220.170184683411, 9228.5847136879, 9229.16937475617, 9229.95385023084, 9235.0, 4478.193925093449, 4490.416245888079, 4490.797914093873, 4491.034427598082, 4493.573110554492, 3980.980095099564, 4087.3255912774653, 4088.366303223005, 4092.897677558085, 4093.672506199497, 3539.5752509699, 3643.417053271464, 3649.087728067983, 3679.448082787603, 3723.8138093095235, 984.9655262065793, 1108.817045187535, 1131.728385187549, 1151.7178291318512, 1168.7837750016274, 828.4731568715393, 832.76682528892, 835.4277320035795, 859.1108203009854, 863.1670438027209, 5129.333186685782, 5144.948550514522, 5262.97368513155, 5363.383210930793, 5390.056740070472, 866.7833041739565, 868.1058509734983, 873.8077622922947, 930.4928813796362, 948.8766460360247, 3544.397452433041, 3727.0, 3830.9616903830606, 3874.380099184117, 3875.903102422462, 8683.392162548562, 8939.195472407515, 8956.462612243286, 9019.729408117766, 9423.670171543963, 8870.467771933705, 9230.769230769285, 9236.353455258068, 9250.398724082914, 9261.0, 7163.3552980232025, 7204.675789589481, 7326.4505162113055, 7377.81555461107, 7417.517861338995, 5586.078297080936, 5605.859853503695, 5681.744321505625, 5764.106563482667, 5941.762329506944, 8669.869951950599, 8859.557022148996, 9021.90978090237, 9043.909560904307, 9062.909370906207, 8554.144585541397, 8985.236254918405, 9070.81858362816, 9073.455592664197, 9212.216961558075, 7369.4841361106355, 7408.444366672414, 7494.962525187339, 7510.774676759706, 7519.135299440634, 7080.822979425556, 7471.626418679153, 7510.361619262424, 7519.887201692089, 7523.1348394935285, 5237.580993520433, 6699.933000669931, 6784.219814721173, 6792.558483698544, 7011.544249623758, 6228.377162283736, 6604.966975165094, 6729.0915726376315, 6790.083338749206, 6808.897866532105, 6434.517411194272, 6569.9343006569325, 6575.572587781779, 6581.045748366556, 6632.734690612321, 4497.5052744198765, 4616.184127682044, 4701.341812146234, 4715.504871988392, 4718.811247550059, 4536.6824322297125, 4643.187442197534, 4677.2750223715375, 4811.1820990431015, 4950.034743225036], "value": 4150.591904141577, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [287.7338461922721, 298.44787143784, 303.82378220632035, 306.15806532036896, 306.5570250987324, 4620.953790462095, 4799.256115302125, 4825.372701548798, 4861.9513804861945, 4879.194932836082, 4648.860534183971, 4666.883327916804, 4691.7801371643445, 4702.553257440546, 4765.451228350783, 3769.5853456119803, 3781.432785082246, 3790.2040571480024, 3800.9429858552144, 3805.9619403805887, 3546.3616549021167, 3785.0158958670804, 3791.791451470168, 3794.4498047783054, 3802.6007269236748, 3344.331133773243, 3581.2988830305526, 3740.3267411865854, 3741.38267185914, 3745.906352341186, 3750.456183853353, 3758.642928921748, 3759.473673685686, 3761.1725420407465, 3770.5286839145106, 3323.258311892698, 3328.3842489139342, 3331.267121233325, 3338.699517043478, 3342.1143396999814, 4471.195184866723, 4618.722876627379, 4636.44362676481, 4649.628029757611, 4675.625949923998, 4278.850240241577, 4283.121959998193, 4321.848735294249, 4324.200022995725, 4329.415528903589, 4952.455229924705, 4961.2465081879545, 4963.528464795839, 4976.377952755905, 4987.875303117415, 3357.6306606273292, 3662.34077865984, 3675.8162091895565, 3679.797611131387, 3682.4660424238336, 5177.197534382177, 5183.14478111115, 5193.818216362447, 5198.2202669599865, 5223.764930578133, 3621.94567081494, 3622.1487950331652, 3631.8184090795353, 3634.6547078027547, 3637.108908317426, 3659.1949771050326, 3668.5230919980763, 3669.6513831185994, 3701.592824789271, 3722.1625134344554, 4141.378793181047, 4186.392973018956, 4215.704900656925, 4238.385434112098, 4262.936055959163, 4924.975375123173, 4931.16170251051, 4960.677555958851, 4973.9554693514765, 4982.90034199314, 1183.828344889986, 1216.2459275249403, 1221.3893053473264, 1239.3555351217317, 1259.703969567151, 834.8246868157634, 844.9860167798544, 853.8676505141713, 878.2490970220497, 885.7741275974586, 4412.271975124133, 4432.578905004019, 4434.667399945017, 4442.888927776831, 4478.753668548261, 5148.9742551287, 5159.638825282269, 5167.793288268503, 5175.430702622709, 5195.376554813447, 4301.935470967938, 4494.4606647202545, 4504.635066590066, 4516.277395616686, 4521.914740462265, 2750.546159883637, 2756.353900255737, 2767.6576860222776, 2768.8477133757433, 2774.5283301838735, 4796.880077998078, 4946.554810067111, 4955.132851750929, 4956.281339205795, 4982.501749825061, 5256.237845512379, 5257.842264732064, 5261.815836445706, 5272.2355258487305, 5292.391374991848, 4879.048585525859, 4879.731269869789, 4892.486288939681, 4902.681325713817, 4925.926111108408, 5013.696438925833, 5151.562117220078, 5153.149730294459, 5161.612879034013, 5174.172132458789, 5014.674046186986, 5017.698938063728, 5035.974820125876, 5050.696958182521, 5073.213651883964, 4906.154430430271, 4913.550502601813, 4919.2129259318335, 4956.8760780980765, 4990.0, 3442.2943296624635, 3687.2256826065754, 3693.409054551259, 3706.7034637228417, 3706.9073273168387, 5138.229265610188, 5138.614603904797, 5140.254663073908, 5146.845594632167, 5150.562202212854, 4953.876153096201, 4966.726830024383, 4973.950260497349, 5030.723310217973, 5050.368703912011, 4900.950990490192, 4982.0, 5068.923966140437, 5070.746462676778, 5073.619478539051, 4724.149653062344, 4802.687825291345, 4893.559579637849, 4905.926411103765, 4948.975255123702, 5037.219231019198, 5041.504455294653, 5049.0, 5052.924206136838, 5053.949460505348, 4909.607231421549, 4916.213405855046, 4943.65394422387, 4945.67853089548, 4946.35697359341], "value": 3781.0412877638505, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.5771061080483, 598.0610441606676, 667.3393340592814, 672.7678950761989, 679.3681875855459, 13281.269530175836, 13879.375428105734, 13919.721605567882, 13950.372233249516, 13951.790723139162, 13119.6720081998, 13156.802647960289, 13383.59849204523, 13393.464261429555, 13400.128991615538, 593.4303069053714, 713.2083387439964, 721.0, 723.8371366442548, 747.8691229034897, 752.9021227240479, 755.207032615754, 756.0549313358302, 756.0851369842497, 756.3911051603457, 780.1886038519932, 781.6443518199205, 787.106633970442, 788.0110461370972, 788.0700773087755, 625.3777491396067, 754.1741792736944, 767.8464307138595, 772.3589420780738, 784.1256998446719, 565.124057710547, 568.7838621323871, 568.8577855536116, 569.663898300005, 569.9544036477072, 12884.935575322157, 12916.54792082282, 12922.28927408992, 12931.0, 12972.286524241163, 12744.745105097845, 13031.739365212738, 13161.934190329082, 13604.523841665594, 13932.0, 10934.835977460345, 10973.50619222137, 11230.045446137088, 11247.381394023325, 11744.354060526668, 4068.837246510136, 4089.44792453018, 4121.0, 4166.395872598487, 4268.189044081614, 63405.36594634041, 63824.68087659532, 63914.68042659803, 63920.680396597716, 64302.0, 10241.07830295277, 10322.2258330624, 10672.092872105803, 10679.038886500251, 10762.94618526918, 19452.027398630013, 19569.706454403196, 19637.705434418494, 19879.60240795176, 20335.0, 6699.732010719516, 6726.428253598499, 6831.658417079127, 6889.931100689029, 6916.446684265246, 3426.7601267911505, 3443.139215196201, 3446.4485682290715, 3492.650734926487, 3512.2448673535314, 2844.601755754196, 2923.0792300425296, 2937.7943543952147, 2947.484190266695, 2954.054702495181, 496.377046806263, 498.822917864153, 501.8068043803162, 503.6449303241206, 506.7618219436859, 515.7163560041962, 519.3196912045233, 524.8635354807777, 530.7823792245238, 561.8342588936274, 6921.303755112158, 7374.631268436557, 7390.260973902674, 7545.094588649397, 7698.884516732253, 450.9143262780061, 520.9869753256199, 600.2257088356059, 611.7430679114782, 622.1507642068544, 3446.638102999199, 3612.9947878926923, 3816.542014958223, 3876.8836934891997, 3877.7091718121255, 103235.48382258191, 104189.47905260425, 104596.0, 106114.16372099455, 108182.45908770406, 48421.27368089482, 48743.75628121837, 87760.0, 88620.5568972151, 90882.0, 77037.0, 78754.60622696849, 81132.59433702794, 81733.59133204295, 82571.0, 7646.885296720442, 7942.523448593103, 8085.912194149786, 8108.432409731262, 8138.796530086558, 45706.54293457156, 46728.766356168, 47689.28466072942, 48236.517634823205, 48717.26924096212, 38535.80732096321, 44058.55941440545, 59251.1112333324, 59332.0, 62415.6879215601, 10546.78906421852, 10591.523381448007, 10698.465076745975, 10960.890391095987, 11141.554337826721, 12398.5660501882, 12778.424970876147, 12795.680107997374, 12906.80639790385, 12995.545155919497, 10951.521544591378, 10954.342739435659, 11004.0, 11062.889371106186, 11441.942790285995, 10616.787664246825, 11048.447577621248, 11408.144389170679, 11501.884981150417, 11505.827412588651, 11504.53981840717, 11523.366214857928, 12028.15802893789, 12044.337561434206, 12057.879421206027, 8700.60847261862, 9170.358074934957, 9194.17252447283, 9242.214411775074, 9609.90390096118, 8452.323814094734, 9036.412633178823, 9450.905490945002, 9875.654352097643, 10039.949800250952], "value": 6442.907472300946, "unit": "score"}], "name": "dromaeo_css", "value": 6273.1644351694285, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 121.0, 114.0, 115.0, 115.0, 114.0, 120.0, 113.0, 129.0], "value": 117.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 123.0, 160.0, 193.0, 129.0, 147.0, 154.0, 123.0, 189.0, 129.0], "value": 151.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 160.0, 163.0, 163.0, 161.0, 163.0, 163.0, 162.0, 161.0, 166.0], "value": 162.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 76.0, 164.0, 79.0, 77.0, 75.0, 76.0, 158.0, 78.0], "value": 93.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 133.0, 84.0, 84.0, 84.0, 144.0, 84.0, 85.0, 143.0], "value": 100.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 118.0, 118.0], "value": 117.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 148.0, 146.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 96.0, 94.0, 95.0, 95.0, 96.0, 96.0, 95.0, 96.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 67.0, 66.0, 67.0, 68.0, 67.0, 67.0, 67.0, 66.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 73.0, 67.0, 67.0, 66.0, 66.0, 66.0, 67.0, 66.0, 67.0], "value": 67.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 83.0, 82.0, 84.0, 88.0, 86.0, 83.0, 82.0, 81.0, 81.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 140.0, 131.0, 135.0, 133.0, 133.0, 133.0, 133.0, 221.0, 132.0], "value": 142.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [177.0, 174.0, 176.0, 174.0, 176.0, 174.0, 183.0, 171.0, 176.0, 172.0], "value": 175.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 69.0, 71.0, 69.0, 68.0, 69.0, 69.0, 70.0, 69.0, 68.0], "value": 69.4, "unit": "score"}], "name": "kraken", "value": 1589.8, "alertThreshold": 2.0}]} 12:08:45 INFO - Return code: 0 12:08:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 12:08:45 INFO - # TBPL SUCCESS # 12:08:45 INFO - Running post-action listener: _resource_record_post_action 12:08:45 INFO - [mozharness: 2016-09-08 19:08:45.836399Z] Finished run-tests step (success) 12:08:45 INFO - Running post-run listener: _resource_record_post_run 12:08:45 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 4096; Write bytes: 394149888; Read time: 16; Write time: 240780 12:08:45 INFO - TinderboxPrint: CPU usage
13.0% 12:08:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 12:08:45 INFO - TinderboxPrint: I/O write bytes / time
394,149,888 / 240,780 12:08:45 INFO - TinderboxPrint: CPU idle
8,349.9 (87.0%) 12:08:45 INFO - TinderboxPrint: CPU user
1,201.7 (12.5%) 12:08:45 INFO - TinderboxPrint: Swap in / out
0 / 0 12:08:45 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99827712; Read time: 0; Write time: 80576 12:08:45 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 0; Write bytes: 294322176; Read time: 0; Write time: 160204 12:08:46 INFO - Running post-run listener: _upload_blobber_files 12:08:46 INFO - Blob upload gear active. 12:08:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 12:08:46 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 12:08:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 12:08:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 12:08:46 INFO - (blobuploader) - INFO - Open directory for files ... 12:08:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 12:08:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 12:08:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:47 INFO - (blobuploader) - INFO - Done attempting. 12:08:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 12:08:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 12:08:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:49 INFO - (blobuploader) - INFO - Done attempting. 12:08:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 12:08:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 12:08:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 12:08:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 12:08:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 12:08:54 INFO - (blobuploader) - INFO - Done attempting. 12:08:54 INFO - (blobuploader) - INFO - Iteration through files over. 12:08:54 INFO - Return code: 0 12:08:54 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 12:08:54 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 12:08:54 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1a3575d7120af113a5e1c4143d5b75c3c407eda9e432b6ccb1acf72e37a2d9cbbe0e8ea412172f7d2e21e14cc805fbfeded1a4cb891e0013d2b68cc25ccc89e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/64a95d1ff76c9f9bc8d115fe105b1b884a49433da5591b40421cb48d42b4ab41cb7e6ff961746d3471f4f4f352498ab7ad3227c3fbc25fe5e23f1991a23d63fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c47f1bbc25df6989f22a3151d5030800b083d20c6b0c3e139f5d2ce13c89ae71234484c6ccafbcb2d077888bdbd0ec498311efc7bc3377504326fa4ad65acf0"} 12:08:54 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 12:08:54 INFO - Writing to file /builds/slave/test/properties/blobber_files 12:08:54 INFO - Contents: 12:08:54 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1a3575d7120af113a5e1c4143d5b75c3c407eda9e432b6ccb1acf72e37a2d9cbbe0e8ea412172f7d2e21e14cc805fbfeded1a4cb891e0013d2b68cc25ccc89e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/64a95d1ff76c9f9bc8d115fe105b1b884a49433da5591b40421cb48d42b4ab41cb7e6ff961746d3471f4f4f352498ab7ad3227c3fbc25fe5e23f1991a23d63fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c47f1bbc25df6989f22a3151d5030800b083d20c6b0c3e139f5d2ce13c89ae71234484c6ccafbcb2d077888bdbd0ec498311efc7bc3377504326fa4ad65acf0"} 12:08:54 INFO - Running post-run listener: copy_logs_to_upload_dir 12:08:54 INFO - Copying logs to upload dir... 12:08:54 INFO - mkdir: /builds/slave/test/build/upload/logs 12:08:54 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.513427 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 47 secs) (at 2016-09-08 12:08:53.572462) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 12:08:53.576682) ========= 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-1473360484.819581-309660620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1a3575d7120af113a5e1c4143d5b75c3c407eda9e432b6ccb1acf72e37a2d9cbbe0e8ea412172f7d2e21e14cc805fbfeded1a4cb891e0013d2b68cc25ccc89e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/64a95d1ff76c9f9bc8d115fe105b1b884a49433da5591b40421cb48d42b4ab41cb7e6ff961746d3471f4f4f352498ab7ad3227c3fbc25fe5e23f1991a23d63fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c47f1bbc25df6989f22a3151d5030800b083d20c6b0c3e139f5d2ce13c89ae71234484c6ccafbcb2d077888bdbd0ec498311efc7bc3377504326fa4ad65acf0"} build_url:https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011429 build_url: 'https://queue.taskcluster.net/v1/task/YT0_hxkdTqKg0qZp6X4otw/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1a3575d7120af113a5e1c4143d5b75c3c407eda9e432b6ccb1acf72e37a2d9cbbe0e8ea412172f7d2e21e14cc805fbfeded1a4cb891e0013d2b68cc25ccc89e8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/64a95d1ff76c9f9bc8d115fe105b1b884a49433da5591b40421cb48d42b4ab41cb7e6ff961746d3471f4f4f352498ab7ad3227c3fbc25fe5e23f1991a23d63fa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/1c47f1bbc25df6989f22a3151d5030800b083d20c6b0c3e139f5d2ce13c89ae71234484c6ccafbcb2d077888bdbd0ec498311efc7bc3377504326fa4ad65acf0"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-08 12:08:53.607637) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 12:08:53.608411) ========= 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-1473360484.819581-309660620 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-08 12:08:53.690455) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 12:08:53.690818) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-08 12:08:53.691159) ========= ========= Total master_lag: 0.18 =========