builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-011 starttime: 1474558930.19 results: success (0) buildid: 20160922080000 builduid: 3948316ffe2549d2b2a9c3c12acca023 revision: 9ff18f836877e1bacb3c2d48c19f5068cc217433 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:10.188379) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:10.189050) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:10.189329) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:10.232090) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:10.232378) ========= 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=5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-22 08:42:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 20.6M=0.001s 2016-09-22 08:42:10 (20.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.134741 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:10.386010) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:10.386295) ========= 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=5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017777 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:10.435085) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:10.435391) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 9ff18f836877e1bacb3c2d48c19f5068cc217433 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 9ff18f836877e1bacb3c2d48c19f5068cc217433 --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=5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-22 08:42:10,998 truncating revision to first 12 chars 2016-09-22 08:42:10,998 Setting DEBUG logging. 2016-09-22 08:42:10,998 attempt 1/10 2016-09-22 08:42:10,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/9ff18f836877?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-22 08:42:11,288 unpacking tar archive at: fx-team-9ff18f836877/testing/mozharness/ program finished with exit code 0 elapsedTime=0.607562 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:11.059402) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:11.059726) ========= script_repo_revision: 9ff18f836877e1bacb3c2d48c19f5068cc217433 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:11.060140) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:11.060416) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-22 08:42:11.076988) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 39 secs) (at 2016-09-22 08:42:11.077268) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:42:11 INFO - MultiFileLogger online at 20160922 08:42:11 in /builds/slave/test 08:42:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:42:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:42:11 INFO - {'append_to_log': False, 08:42:11 INFO - 'base_work_dir': '/builds/slave/test', 08:42:11 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:42:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:42:11 INFO - 'branch': 'Fx-Team-Non-PGO', 08:42:11 INFO - 'buildbot_json_path': 'buildprops.json', 08:42:11 INFO - 'config_files': ('talos/linux_config.py',), 08:42:11 INFO - 'default_actions': ('clobber', 08:42:11 INFO - 'read-buildbot-config', 08:42:11 INFO - 'download-and-extract', 08:42:11 INFO - 'populate-webroot', 08:42:11 INFO - 'create-virtualenv', 08:42:11 INFO - 'install', 08:42:11 INFO - 'run-tests'), 08:42:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:42:11 INFO - 'download_minidump_stackwalk': True, 08:42:11 INFO - 'download_symbols': 'ondemand', 08:42:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:42:11 INFO - 'tooltool.py': '/tools/tooltool.py', 08:42:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:42:11 INFO - '/tools/misc-python/virtualenv.py')}, 08:42:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:42:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:42:11 INFO - 'installer_path': 'installer.exe', 08:42:11 INFO - 'log_level': 'info', 08:42:11 INFO - 'log_name': 'talos', 08:42:11 INFO - 'log_to_console': True, 08:42:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:42:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:42:11 INFO - 'opt_config_files': (), 08:42:11 INFO - 'pip_index': False, 08:42:11 INFO - 'sps_profile': False, 08:42:11 INFO - 'sps_profile_interval': 0, 08:42:11 INFO - 'suite': 'dromaeojs', 08:42:11 INFO - 'system_bits': '32', 08:42:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:42:11 INFO - 'title': 'talos-linux64-ix-011', 08:42:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:42:11 INFO - 'use_talos_json': True, 08:42:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:42:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:42:11 INFO - 'work_dir': 'build'} 08:42:11 INFO - [mozharness: 2016-09-22 15:42:11.734942Z] Running clobber step. 08:42:11 INFO - Running pre-action listener: _resource_record_pre_action 08:42:11 INFO - Running main action method: clobber 08:42:11 INFO - rmtree: /builds/slave/test/build 08:42:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:42:12 INFO - Running post-action listener: _resource_record_post_action 08:42:12 INFO - [mozharness: 2016-09-22 15:42:12.713628Z] Finished clobber step (success) 08:42:12 INFO - [mozharness: 2016-09-22 15:42:12.713727Z] Running read-buildbot-config step. 08:42:12 INFO - Running pre-action listener: _resource_record_pre_action 08:42:12 INFO - Running main action method: read_buildbot_config 08:42:12 INFO - Using buildbot properties: 08:42:12 INFO - { 08:42:12 INFO - "project": "", 08:42:12 INFO - "product": "firefox", 08:42:12 INFO - "script_repo_revision": "production", 08:42:12 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:42:12 INFO - "repository": "", 08:42:12 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:42:12 INFO - "buildid": "20160922080000", 08:42:12 INFO - "pgo_build": "False", 08:42:12 INFO - "basedir": "/builds/slave/test", 08:42:12 INFO - "buildnumber": 3344, 08:42:12 INFO - "slavename": "talos-linux64-ix-011", 08:42:12 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:42:12 INFO - "platform": "ubuntu64_hw", 08:42:12 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:42:12 INFO - "branch": "fx-team", 08:42:12 INFO - "repo_path": "integration/fx-team", 08:42:12 INFO - "revision": "9ff18f836877e1bacb3c2d48c19f5068cc217433", 08:42:12 INFO - "stage_platform": "linux64", 08:42:12 INFO - "builduid": "3948316ffe2549d2b2a9c3c12acca023", 08:42:12 INFO - "slavebuilddir": "test" 08:42:12 INFO - } 08:42:12 INFO - Found installer url https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:42:12 INFO - Running post-action listener: _resource_record_post_action 08:42:12 INFO - [mozharness: 2016-09-22 15:42:12.716163Z] Finished read-buildbot-config step (success) 08:42:12 INFO - [mozharness: 2016-09-22 15:42:12.716253Z] Running download-and-extract step. 08:42:12 INFO - Running pre-action listener: _resource_record_pre_action 08:42:12 INFO - Running main action method: download_and_extract 08:42:12 INFO - mkdir: /builds/slave/test/build/tests 08:42:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:12 INFO - trying https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:42:12 INFO - Downloading https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:42:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 08:42:13 INFO - Downloaded 1361 bytes. 08:42:13 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:42:13 INFO - Using the following test package requirements: 08:42:13 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:13 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:42:13 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:42:13 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'jsshell-linux-x86_64.zip'], 08:42:13 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:42:13 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:42:13 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:42:13 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:42:13 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:42:13 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:42:13 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:42:13 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:42:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:42:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:13 INFO - Fetch https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:42:13 INFO - Expected file size: 20373210 08:42:19 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 08:42:19 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:42:19 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:42:19 INFO - Fetch https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:42:19 INFO - Expected file size: 20373210 08:42:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:42:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:42:24 INFO - Fetch https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:42:25 INFO - Expected file size: 14414059 08:42: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')]} 08:42:26 INFO - trying https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:42:26 INFO - Downloading https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:42:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 08:42:28 INFO - Downloaded 55703933 bytes. 08:42:28 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:42:28 INFO - mkdir: /builds/slave/test/properties 08:42:28 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:42:28 INFO - Writing to file /builds/slave/test/properties/build_url 08:42:28 INFO - Contents: 08:42:28 INFO - build_url:https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:42:28 INFO - Running post-action listener: _resource_record_post_action 08:42:28 INFO - Running post-action listener: set_extra_try_arguments 08:42:28 INFO - [mozharness: 2016-09-22 15:42:28.911337Z] Finished download-and-extract step (success) 08:42:28 INFO - [mozharness: 2016-09-22 15:42:28.911565Z] Running populate-webroot step. 08:42:28 INFO - Running pre-action listener: _resource_record_pre_action 08:42:28 INFO - Running main action method: populate_webroot 08:42:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:42:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:42:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:42:28 INFO - '--tppagecycles', 08:42:28 INFO - '7'], 08:42:28 INFO - 'tests': ['tsvgm']}}, 08:42:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:42:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:42:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:42:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:42:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:42:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:42:28 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:28 INFO - 'talos_options': ['--disable-e10s'], 08:42:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:28 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:42:28 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:28 INFO - 'talos_options': ['--disable-e10s'], 08:42:28 INFO - 'tests': ['damp', 'tps']}, 08:42:28 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:28 INFO - 'tests': ['damp', 'tps']}, 08:42:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:42:28 INFO - 'tests': ['dromaeo_dom']}, 08:42:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:42:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:42:28 INFO - 'tests': ['basic_compositor_video']}, 08:42:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:42:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:42:28 INFO - 'tests': ['a11yr', 08:42:28 INFO - 'ts_paint', 08:42:28 INFO - 'tpaint', 08:42:28 INFO - 'sessionrestore', 08:42:28 INFO - 'sessionrestore_no_auto_restore', 08:42:28 INFO - 'tabpaint']}, 08:42:28 INFO - 'other-e10s': {'tests': ['a11yr', 08:42:28 INFO - 'ts_paint', 08:42:28 INFO - 'tpaint', 08:42:28 INFO - 'sessionrestore', 08:42:28 INFO - 'sessionrestore_no_auto_restore', 08:42:28 INFO - 'tabpaint']}, 08:42:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:42:28 INFO - 'ts_paint', 08:42:28 INFO - 'tpaint', 08:42:28 INFO - 'sessionrestore', 08:42:28 INFO - 'sessionrestore_no_auto_restore', 08:42:28 INFO - 'tabpaint']}, 08:42:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:42:28 INFO - 'ts_paint', 08:42:28 INFO - 'tpaint', 08:42:28 INFO - 'sessionrestore', 08:42:28 INFO - 'sessionrestore_no_auto_restore', 08:42:28 INFO - 'tabpaint']}, 08:42:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:42:28 INFO - 'tests': ['a11yr', 08:42:28 INFO - 'ts_paint', 08:42:28 INFO - 'tpaint', 08:42:28 INFO - 'sessionrestore', 08:42:28 INFO - 'sessionrestore_no_auto_restore', 08:42:28 INFO - 'tabpaint']}, 08:42:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:42:28 INFO - 'tests': ['a11yr', 08:42:28 INFO - 'ts_paint', 08:42:28 INFO - 'tpaint', 08:42:28 INFO - 'sessionrestore', 08:42:28 INFO - 'sessionrestore_no_auto_restore', 08:42:28 INFO - 'tabpaint']}, 08:42:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:42:28 INFO - 'tests': ['tsvgx', 08:42:28 INFO - 'tsvgr_opacity', 08:42:28 INFO - 'tart', 08:42:28 INFO - 'tscrollx', 08:42:28 INFO - 'cart']}, 08:42:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:42:28 INFO - 'tsvgr_opacity', 08:42:28 INFO - 'tart', 08:42:28 INFO - 'tscrollx', 08:42:28 INFO - 'cart']}, 08:42:28 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:28 INFO - 'talos_options': ['--disable-e10s'], 08:42:28 INFO - 'tests': ['tp5o']}, 08:42:28 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:28 INFO - 'tests': ['tp5o']}, 08:42:28 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:28 INFO - 'talos_options': ['--disable-e10s', 08:42:28 INFO - '--xperf_path', 08:42:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:28 INFO - 'tests': ['tp5n']}, 08:42:28 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:42:28 INFO - 'talos_options': ['--xperf_path', 08:42:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:42:28 INFO - 'tests': ['tp5n']}}, 08:42:28 INFO - 'talos.zip': {'path': '', 08:42:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:42:28 INFO - Running post-action listener: _resource_record_post_action 08:42:28 INFO - [mozharness: 2016-09-22 15:42:28.935945Z] Finished populate-webroot step (success) 08:42:28 INFO - [mozharness: 2016-09-22 15:42:28.936033Z] Running create-virtualenv step. 08:42:28 INFO - Running pre-action listener: _resource_record_pre_action 08:42:28 INFO - Running main action method: create_virtualenv 08:42:28 INFO - Creating virtualenv /builds/slave/test/build/venv 08:42:28 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 08:42:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:42:29 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:42:29 INFO - Using real prefix '/usr' 08:42:29 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:42:29 INFO - Installing distribute.............................................................................................................................................................................................done. 08:42:31 INFO - Installing pip.................done. 08:42:31 INFO - Return code: 0 08:42:31 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa263d8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3f60>, '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 0x1ce4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce51d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', '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 08:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 08:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 08:42:31 INFO - Using env: {'DISPLAY': ':0', 08:42:31 INFO - 'HOME': '/home/cltbld', 08:42:31 INFO - 'LANG': 'en_US.UTF-8', 08:42:31 INFO - 'LANGUAGE': 'en_US:en', 08:42:31 INFO - 'LOGNAME': 'cltbld', 08:42:31 INFO - 'MAIL': '/var/mail/cltbld', 08:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:31 INFO - 'MOZ_NO_REMOTE': '1', 08:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:31 INFO - 'NO_EM_RESTART': '1', 08:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:31 INFO - 'PWD': '/builds/slave/test', 08:42:31 INFO - 'SHELL': '/bin/bash', 08:42:31 INFO - 'SHLVL': '1', 08:42:31 INFO - 'TERM': 'linux', 08:42:31 INFO - 'TMOUT': '86400', 08:42:31 INFO - 'USER': 'cltbld', 08:42:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', 08:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:31 INFO - '_': '/tools/buildbot/bin/python'} 08:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:31 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 08:42:31 INFO - Cleaning up... 08:42:31 INFO - Return code: 0 08:42:31 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:31 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa263d8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3f60>, '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 0x1ce4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce51d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', '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 08:42:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 08:42:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 08:42:31 INFO - Using env: {'DISPLAY': ':0', 08:42:31 INFO - 'HOME': '/home/cltbld', 08:42:31 INFO - 'LANG': 'en_US.UTF-8', 08:42:31 INFO - 'LANGUAGE': 'en_US:en', 08:42:31 INFO - 'LOGNAME': 'cltbld', 08:42:31 INFO - 'MAIL': '/var/mail/cltbld', 08:42:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:31 INFO - 'MOZ_NO_REMOTE': '1', 08:42:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:31 INFO - 'NO_EM_RESTART': '1', 08:42:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:31 INFO - 'PWD': '/builds/slave/test', 08:42:31 INFO - 'SHELL': '/bin/bash', 08:42:31 INFO - 'SHLVL': '1', 08:42:31 INFO - 'TERM': 'linux', 08:42:31 INFO - 'TMOUT': '86400', 08:42:31 INFO - 'USER': 'cltbld', 08:42:31 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', 08:42:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:31 INFO - '_': '/tools/buildbot/bin/python'} 08:42:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:31 INFO - Downloading/unpacking psutil>=3.1.1 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:42:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:34 INFO - Installing collected packages: psutil 08:42:34 INFO - Running setup.py install for psutil 08:42:34 INFO - building 'psutil._psutil_linux' extension 08:42:34 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 08:42:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:42:34 INFO - building 'psutil._psutil_posix' extension 08:42:34 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 08:42:34 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 08:42:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:42:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:42:34 INFO - Successfully installed psutil 08:42:34 INFO - Cleaning up... 08:42:34 INFO - Return code: 0 08:42:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:42: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')]} 08:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42: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')]} 08:42:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa263d8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3f60>, '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 0x1ce4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce51d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', '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 08:42:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 08:42:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 08:42:34 INFO - Using env: {'DISPLAY': ':0', 08:42:34 INFO - 'HOME': '/home/cltbld', 08:42:34 INFO - 'LANG': 'en_US.UTF-8', 08:42:34 INFO - 'LANGUAGE': 'en_US:en', 08:42:34 INFO - 'LOGNAME': 'cltbld', 08:42:34 INFO - 'MAIL': '/var/mail/cltbld', 08:42:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:34 INFO - 'MOZ_NO_REMOTE': '1', 08:42:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:34 INFO - 'NO_EM_RESTART': '1', 08:42:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:34 INFO - 'PWD': '/builds/slave/test', 08:42:34 INFO - 'SHELL': '/bin/bash', 08:42:34 INFO - 'SHLVL': '1', 08:42:34 INFO - 'TERM': 'linux', 08:42:34 INFO - 'TMOUT': '86400', 08:42:34 INFO - 'USER': 'cltbld', 08:42:34 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', 08:42:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:34 INFO - '_': '/tools/buildbot/bin/python'} 08:42:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:36 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:42:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:42:36 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:42:36 INFO - Installing collected packages: mozsystemmonitor 08:42:36 INFO - Running setup.py install for mozsystemmonitor 08:42:36 INFO - Successfully installed mozsystemmonitor 08:42:36 INFO - Cleaning up... 08:42:36 INFO - Return code: 0 08:42:36 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa263d8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3f60>, '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 0x1ce4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce51d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', '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 08:42:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:42:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:42:36 INFO - Using env: {'DISPLAY': ':0', 08:42:36 INFO - 'HOME': '/home/cltbld', 08:42:36 INFO - 'LANG': 'en_US.UTF-8', 08:42:36 INFO - 'LANGUAGE': 'en_US:en', 08:42:36 INFO - 'LOGNAME': 'cltbld', 08:42:36 INFO - 'MAIL': '/var/mail/cltbld', 08:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:36 INFO - 'MOZ_NO_REMOTE': '1', 08:42:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:36 INFO - 'NO_EM_RESTART': '1', 08:42:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:36 INFO - 'PWD': '/builds/slave/test', 08:42:36 INFO - 'SHELL': '/bin/bash', 08:42:36 INFO - 'SHLVL': '1', 08:42:36 INFO - 'TERM': 'linux', 08:42:36 INFO - 'TMOUT': '86400', 08:42:36 INFO - 'USER': 'cltbld', 08:42:36 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', 08:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:36 INFO - '_': '/tools/buildbot/bin/python'} 08:42:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:37 INFO - Downloading/unpacking jsonschema==2.5.1 08:42:37 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 08:42:37 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 08:42:37 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 08:42:37 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 08:42:37 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 08:42:37 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 08:42:38 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:42:38 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:39 INFO - Downloading functools32-3.2.3-2.tar.gz 08:42:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:42:39 INFO - warning: no files found matching '*.txt' 08:42:39 INFO - no previously-included directories found matching 'build' 08:42:39 INFO - no previously-included directories found matching 'dist' 08:42:39 INFO - no previously-included directories found matching '.git*' 08:42:39 INFO - Installing collected packages: jsonschema, functools32 08:42:39 INFO - Running setup.py install for functools32 08:42:39 INFO - warning: no files found matching '*.txt' 08:42:39 INFO - no previously-included directories found matching 'build' 08:42:39 INFO - no previously-included directories found matching 'dist' 08:42:39 INFO - no previously-included directories found matching '.git*' 08:42:39 INFO - Successfully installed jsonschema functools32 08:42:39 INFO - Cleaning up... 08:42:39 INFO - Return code: 0 08:42:39 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa263d8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3f60>, '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 0x1ce4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce51d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', '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 08:42:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 08:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 08:42:39 INFO - Using env: {'DISPLAY': ':0', 08:42:39 INFO - 'HOME': '/home/cltbld', 08:42:39 INFO - 'LANG': 'en_US.UTF-8', 08:42:39 INFO - 'LANGUAGE': 'en_US:en', 08:42:39 INFO - 'LOGNAME': 'cltbld', 08:42:39 INFO - 'MAIL': '/var/mail/cltbld', 08:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:39 INFO - 'MOZ_NO_REMOTE': '1', 08:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:39 INFO - 'NO_EM_RESTART': '1', 08:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:39 INFO - 'PWD': '/builds/slave/test', 08:42:39 INFO - 'SHELL': '/bin/bash', 08:42:39 INFO - 'SHLVL': '1', 08:42:39 INFO - 'TERM': 'linux', 08:42:39 INFO - 'TMOUT': '86400', 08:42:39 INFO - 'USER': 'cltbld', 08:42:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', 08:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:39 INFO - '_': '/tools/buildbot/bin/python'} 08:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:39 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:42:39 INFO - Cleaning up... 08:42:39 INFO - Return code: 0 08:42:39 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:39 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa263d8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3f60>, '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 0x1ce4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce51d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', '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 08:42:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:42:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:42:39 INFO - Using env: {'DISPLAY': ':0', 08:42:39 INFO - 'HOME': '/home/cltbld', 08:42:39 INFO - 'LANG': 'en_US.UTF-8', 08:42:39 INFO - 'LANGUAGE': 'en_US:en', 08:42:39 INFO - 'LOGNAME': 'cltbld', 08:42:39 INFO - 'MAIL': '/var/mail/cltbld', 08:42:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:39 INFO - 'MOZ_NO_REMOTE': '1', 08:42:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:39 INFO - 'NO_EM_RESTART': '1', 08:42:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:39 INFO - 'PWD': '/builds/slave/test', 08:42:39 INFO - 'SHELL': '/bin/bash', 08:42:39 INFO - 'SHLVL': '1', 08:42:39 INFO - 'TERM': 'linux', 08:42:39 INFO - 'TMOUT': '86400', 08:42:39 INFO - 'USER': 'cltbld', 08:42:39 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', 08:42:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:39 INFO - '_': '/tools/buildbot/bin/python'} 08:42:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:39 INFO - Downloading/unpacking blobuploader==1.2.4 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42: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 08:42:41 INFO - Downloading blobuploader-1.2.4.tar.gz 08:42:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:42:41 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:42:42 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:42 INFO - Downloading docopt-0.6.1.tar.gz 08:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:42:42 INFO - Installing collected packages: blobuploader, requests, docopt 08:42:42 INFO - Running setup.py install for blobuploader 08:42:42 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:42:42 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:42:42 INFO - Running setup.py install for requests 08:42:42 INFO - Running setup.py install for docopt 08:42:43 INFO - Successfully installed blobuploader requests docopt 08:42:43 INFO - Cleaning up... 08:42:43 INFO - Return code: 0 08:42:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa263d8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3f60>, '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 0x1ce4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce51d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', '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 08:42:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:42:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:43 INFO - Using env: {'DISPLAY': ':0', 08:42:43 INFO - 'HOME': '/home/cltbld', 08:42:43 INFO - 'LANG': 'en_US.UTF-8', 08:42:43 INFO - 'LANGUAGE': 'en_US:en', 08:42:43 INFO - 'LOGNAME': 'cltbld', 08:42:43 INFO - 'MAIL': '/var/mail/cltbld', 08:42:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:43 INFO - 'MOZ_NO_REMOTE': '1', 08:42:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:43 INFO - 'NO_EM_RESTART': '1', 08:42:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:43 INFO - 'PWD': '/builds/slave/test', 08:42:43 INFO - 'SHELL': '/bin/bash', 08:42:43 INFO - 'SHLVL': '1', 08:42:43 INFO - 'TERM': 'linux', 08:42:43 INFO - 'TMOUT': '86400', 08:42:43 INFO - 'USER': 'cltbld', 08:42:43 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', 08:42:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:43 INFO - '_': '/tools/buildbot/bin/python'} 08:42:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:43 INFO - Running setup.py (path:/tmp/pip-TbkbQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:43 INFO - Running setup.py (path:/tmp/pip-M6hxA4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:43 INFO - Running setup.py (path:/tmp/pip-IYkisY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:43 INFO - Running setup.py (path:/tmp/pip-uVAGeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:43 INFO - Running setup.py (path:/tmp/pip-FqIoT1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:43 INFO - Running setup.py (path:/tmp/pip-q_ZWa9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:43 INFO - Running setup.py (path:/tmp/pip-2lnQ8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:43 INFO - Running setup.py (path:/tmp/pip-Az5JRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:43 INFO - Running setup.py (path:/tmp/pip-9xBaeX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:44 INFO - Running setup.py (path:/tmp/pip-xEBKd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:44 INFO - Running setup.py (path:/tmp/pip-HUv_Kx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:44 INFO - Running setup.py (path:/tmp/pip-SSe2QT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:44 INFO - Running setup.py (path:/tmp/pip-Rap3X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:44 INFO - Running setup.py (path:/tmp/pip-z2PsZt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:44 INFO - Running setup.py (path:/tmp/pip-Uzpx1T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:44 INFO - Running setup.py (path:/tmp/pip-swLuHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:44 INFO - Running setup.py (path:/tmp/pip-zlXZ2N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:44 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:42:44 INFO - Running setup.py install for manifestparser 08:42:44 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:42:44 INFO - Running setup.py install for mozcrash 08:42:44 INFO - Running setup.py install for mozdebug 08:42:44 INFO - Running setup.py install for mozdevice 08:42:45 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Running setup.py install for mozfile 08:42:45 INFO - Running setup.py install for mozhttpd 08:42:45 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Running setup.py install for mozinfo 08:42:45 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Running setup.py install for mozInstall 08:42:45 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Running setup.py install for mozleak 08:42:45 INFO - Running setup.py install for mozlog 08:42:45 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Running setup.py install for moznetwork 08:42:45 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Running setup.py install for mozprocess 08:42:45 INFO - Running setup.py install for mozprofile 08:42:45 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:42:45 INFO - Running setup.py install for mozrunner 08:42:46 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:42:46 INFO - Running setup.py install for mozscreenshot 08:42:46 INFO - Running setup.py install for moztest 08:42:46 INFO - Running setup.py install for mozversion 08:42:46 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:42:46 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:42:46 INFO - Cleaning up... 08:42:46 INFO - Return code: 0 08:42:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa263d8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3f60>, '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 0x1ce4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce51d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', '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 08:42:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 08:42:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:46 INFO - Using env: {'DISPLAY': ':0', 08:42:46 INFO - 'HOME': '/home/cltbld', 08:42:46 INFO - 'LANG': 'en_US.UTF-8', 08:42:46 INFO - 'LANGUAGE': 'en_US:en', 08:42:46 INFO - 'LOGNAME': 'cltbld', 08:42:46 INFO - 'MAIL': '/var/mail/cltbld', 08:42:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:46 INFO - 'MOZ_NO_REMOTE': '1', 08:42:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:46 INFO - 'NO_EM_RESTART': '1', 08:42:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:46 INFO - 'PWD': '/builds/slave/test', 08:42:46 INFO - 'SHELL': '/bin/bash', 08:42:46 INFO - 'SHLVL': '1', 08:42:46 INFO - 'TERM': 'linux', 08:42:46 INFO - 'TMOUT': '86400', 08:42:46 INFO - 'USER': 'cltbld', 08:42:46 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', 08:42:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:46 INFO - '_': '/tools/buildbot/bin/python'} 08:42:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:42:46 INFO - Running setup.py (path:/tmp/pip-8KAVpk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:42:46 INFO - Running setup.py (path:/tmp/pip-1rxssE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:42:46 INFO - Running setup.py (path:/tmp/pip-comEVo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:42:46 INFO - Running setup.py (path:/tmp/pip-_2hns9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:42:46 INFO - Running setup.py (path:/tmp/pip-ff_eIN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:42:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 08:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:42:46 INFO - Running setup.py (path:/tmp/pip-86wJro-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:42:47 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)) 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:42:47 INFO - Running setup.py (path:/tmp/pip-zoxRei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:42:47 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)) 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:42:47 INFO - Running setup.py (path:/tmp/pip-O4VPFH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:42:47 INFO - Running setup.py (path:/tmp/pip-MzqCVu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:42:47 INFO - Running setup.py (path:/tmp/pip-ehJTaI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:42:47 INFO - Running setup.py (path:/tmp/pip-4lF8Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:42:47 INFO - Running setup.py (path:/tmp/pip-4q0hPV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:42:47 INFO - Running setup.py (path:/tmp/pip-BLsk8_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:42:47 INFO - Running setup.py (path:/tmp/pip-TjBVUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:47 INFO - Running setup.py (path:/tmp/pip-HjvJJU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:42:47 INFO - Running setup.py (path:/tmp/pip-1_wTe8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 08:42:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:42:47 INFO - Running setup.py (path:/tmp/pip-Gb1Uyd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 08:42:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:42:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:42:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:42:49 INFO - Downloading blessings-1.6.tar.gz 08:42:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:42:49 INFO - Installing collected packages: blessings 08:42:49 INFO - Running setup.py install for blessings 08:42:49 INFO - Successfully installed blessings 08:42:49 INFO - Cleaning up... 08:42:50 INFO - Return code: 0 08:42:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:50 INFO - Reading from file tmpfile_stdout 08:42:50 INFO - Current package versions: 08:42:50 INFO - argparse == 1.2.1 08:42:50 INFO - blessings == 1.6 08:42:50 INFO - blobuploader == 1.2.4 08:42:50 INFO - docopt == 0.6.1 08:42:50 INFO - functools32 == 3.2.3-2 08:42:50 INFO - jsonschema == 2.5.1 08:42:50 INFO - manifestparser == 1.1 08:42:50 INFO - mozInstall == 1.12 08:42:50 INFO - mozcrash == 0.17 08:42:50 INFO - mozdebug == 0.1 08:42:50 INFO - mozdevice == 0.48 08:42:50 INFO - mozfile == 1.2 08:42:50 INFO - mozhttpd == 0.7 08:42:50 INFO - mozinfo == 0.9 08:42:50 INFO - mozleak == 0.1 08:42:50 INFO - mozlog == 3.4 08:42:50 INFO - moznetwork == 0.27 08:42:50 INFO - mozprocess == 0.23 08:42:50 INFO - mozprofile == 0.28 08:42:50 INFO - mozrunner == 6.12 08:42:50 INFO - mozscreenshot == 0.1 08:42:50 INFO - mozsystemmonitor == 0.3 08:42:50 INFO - moztest == 0.7 08:42:50 INFO - mozversion == 1.4 08:42:50 INFO - psutil == 3.1.1 08:42:50 INFO - requests == 1.2.3 08:42:50 INFO - wsgiref == 0.1.2 08:42:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa263d8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3f60>, '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 0x1ce4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce51d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', '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 08:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 08:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 08:42:50 INFO - Using env: {'DISPLAY': ':0', 08:42:50 INFO - 'HOME': '/home/cltbld', 08:42:50 INFO - 'LANG': 'en_US.UTF-8', 08:42:50 INFO - 'LANGUAGE': 'en_US:en', 08:42:50 INFO - 'LOGNAME': 'cltbld', 08:42:50 INFO - 'MAIL': '/var/mail/cltbld', 08:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:50 INFO - 'MOZ_NO_REMOTE': '1', 08:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:50 INFO - 'NO_EM_RESTART': '1', 08:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:50 INFO - 'PWD': '/builds/slave/test', 08:42:50 INFO - 'SHELL': '/bin/bash', 08:42:50 INFO - 'SHLVL': '1', 08:42:50 INFO - 'TERM': 'linux', 08:42:50 INFO - 'TMOUT': '86400', 08:42:50 INFO - 'USER': 'cltbld', 08:42:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', 08:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:50 INFO - '_': '/tools/buildbot/bin/python'} 08:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 08:42:50 INFO - Cleaning up... 08:42:50 INFO - Return code: 0 08:42:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:42:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:42:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:42:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa263d8ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1ce6ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ce3f60>, '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 0x1ce4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce51d0>, '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': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', '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 08:42:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:42:50 INFO - Using env: {'DISPLAY': ':0', 08:42:50 INFO - 'HOME': '/home/cltbld', 08:42:50 INFO - 'LANG': 'en_US.UTF-8', 08:42:50 INFO - 'LANGUAGE': 'en_US:en', 08:42:50 INFO - 'LOGNAME': 'cltbld', 08:42:50 INFO - 'MAIL': '/var/mail/cltbld', 08:42:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:42:50 INFO - 'MOZ_NO_REMOTE': '1', 08:42:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:42:50 INFO - 'NO_EM_RESTART': '1', 08:42:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:42:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:42:50 INFO - 'PWD': '/builds/slave/test', 08:42:50 INFO - 'SHELL': '/bin/bash', 08:42:50 INFO - 'SHLVL': '1', 08:42:50 INFO - 'TERM': 'linux', 08:42:50 INFO - 'TMOUT': '86400', 08:42:50 INFO - 'USER': 'cltbld', 08:42:50 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', 08:42:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:42:50 INFO - '_': '/tools/buildbot/bin/python'} 08:42:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:42:50 INFO - Cleaning up... 08:42:50 INFO - Return code: 0 08:42:50 INFO - Running post-action listener: _resource_record_post_action 08:42:50 INFO - Running post-action listener: _start_resource_monitoring 08:42:50 INFO - Starting resource monitoring. 08:42:50 INFO - [mozharness: 2016-09-22 15:42:50.702511Z] Finished create-virtualenv step (success) 08:42:50 INFO - [mozharness: 2016-09-22 15:42:50.703016Z] Running install step. 08:42:50 INFO - Running pre-action listener: _resource_record_pre_action 08:42:50 INFO - Running main action method: install 08:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:42:50 INFO - Reading from file tmpfile_stdout 08:42:50 INFO - Detecting whether we're running mozinstall >=1.0... 08:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:42:50 INFO - Reading from file tmpfile_stdout 08:42:50 INFO - Output received: 08:42:50 INFO - Usage: mozinstall [options] installer 08:42:50 INFO - Options: 08:42:50 INFO - -h, --help show this help message and exit 08:42:50 INFO - -d DEST, --destination=DEST 08:42:50 INFO - Directory to install application into. [default: 08:42:50 INFO - "/builds/slave/test"] 08:42:50 INFO - --app=APP Application being installed. [default: firefox] 08:42:50 INFO - mkdir: /builds/slave/test/build/application 08:42:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 08:42:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 08:43:07 INFO - Reading from file tmpfile_stdout 08:43:07 INFO - Output received: 08:43:07 INFO - /builds/slave/test/build/application/firefox/firefox 08:43:07 INFO - Running post-action listener: _resource_record_post_action 08:43:07 INFO - [mozharness: 2016-09-22 15:43:07.070306Z] Finished install step (success) 08:43:07 INFO - [mozharness: 2016-09-22 15:43:07.070548Z] Running run-tests step. 08:43:07 INFO - Running pre-action listener: _resource_record_pre_action 08:43:07 INFO - Running main action method: run_tests 08:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:43:07 INFO - Python 2.7.3 08:43:07 INFO - Return code: 0 08:43:07 INFO - grabbing minidump binary from tooltool 08:43: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')]} 08:43:07 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 0x1ce3f60>, '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 0x1ce4d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1ce51d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:43:07 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 08:43:07 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 08:43:07 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 08:43:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:43:07 INFO - Return code: 0 08:43:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:43:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:43:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:43:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:43:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:43:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 08:43:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --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 08:43:07 INFO - Using env: {'DISPLAY': ':0', 08:43:07 INFO - 'HOME': '/home/cltbld', 08:43:07 INFO - 'LANG': 'en_US.UTF-8', 08:43:07 INFO - 'LANGUAGE': 'en_US:en', 08:43:07 INFO - 'LOGNAME': 'cltbld', 08:43:07 INFO - 'MAIL': '/var/mail/cltbld', 08:43:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:43:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:43:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:43:07 INFO - 'MOZ_NO_REMOTE': '1', 08:43:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:43:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:43:07 INFO - 'NO_EM_RESTART': '1', 08:43:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:43:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:43:07 INFO - 'PWD': '/builds/slave/test', 08:43:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:43:07 INFO - 'SHELL': '/bin/bash', 08:43:07 INFO - 'SHLVL': '1', 08:43:07 INFO - 'TERM': 'linux', 08:43:07 INFO - 'TMOUT': '86400', 08:43:07 INFO - 'USER': 'cltbld', 08:43:07 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864', 08:43:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:43:07 INFO - '_': '/tools/buildbot/bin/python'} 08:43:07 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--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 08:43:07 INFO - mozversion application_buildid: 20160922080000 08:43:07 INFO - mozversion application_changeset: 9ff18f836877e1bacb3c2d48c19f5068cc217433 08:43:07 INFO - mozversion application_display_name: Nightly 08:43:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:43:07 INFO - mozversion application_name: Firefox 08:43:07 INFO - mozversion application_remotingname: firefox 08:43:07 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:43:07 INFO - mozversion application_vendor: Mozilla 08:43:07 INFO - mozversion application_version: 52.0a1 08:43:07 INFO - mozversion platform_buildid: 20160922080000 08:43:07 INFO - mozversion platform_changeset: 9ff18f836877e1bacb3c2d48c19f5068cc217433 08:43:07 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:43:07 INFO - mozversion platform_version: 52.0a1 08:43:07 INFO - using testdate: 1474558987 08:43:07 INFO - actual date: 1474558987 08:43:07 INFO - starting webserver on 'localhost:34149' 08:43:07 INFO - SUITE-START | Running 2 tests 08:43:07 INFO - TEST-START | dromaeo_css 08:43:07 INFO - operating with platform_type : linux_ 08:43:07 INFO - Initialising browser for dromaeo_css test... 08:43:07 INFO - TEST-INFO | started process 30386 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcyC2gF/profile http://localhost:34149/getInfo.html) 08:43:12 INFO - PROCESS | 30386 | __metrics Screen width/height:1600/1200 08:43:12 INFO - PROCESS | 30386 | colorDepth:24 08:43:12 INFO - PROCESS | 30386 | Browser inner width/height: 1024/697 08:43:12 INFO - PROCESS | 30386 | __metrics 08:43:13 INFO - PROCESS | 30386 | 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" 08:43:13 INFO - PROCESS | 30386 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:43:14 INFO - PROCESS | 30386 | console.error: PushService: 08:43:14 INFO - PROCESS | 30386 | stateChangeProcessEnqueue: Error transitioning state 08:43:14 INFO - PROCESS | 30386 | UnknownError 08:43:15 INFO - TEST-INFO | 30386: exit 0 08:43:15 INFO - Browser initialized. 08:43:15 INFO - Running cycle 1/1 for dromaeo_css test... 08:43:15 INFO - TEST-INFO | started process 30468 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcyC2gF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:43:27 INFO - PROCESS | 30468 | RSS: Main: 174972928 08:43:27 INFO - PROCESS | 30468 | 08:44:19 INFO - PROCESS | 30468 | 1474559059268 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] 08:46:31 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34149/tests/dromaeo/cssquery-ext.html) 08:46:32 INFO - PROCESS | 30468 | RSS: Main: 306827264 08:46:32 INFO - PROCESS | 30468 | 08:49:35 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-ext.html (next: http://localhost:34149/tests/dromaeo/cssquery-jquery.html) 08:49:36 INFO - PROCESS | 30468 | RSS: Main: 278831104 08:49:36 INFO - PROCESS | 30468 | 08:52:38 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34149/tests/dromaeo/cssquery-mootools.html) 08:52:39 INFO - PROCESS | 30468 | RSS: Main: 260771840 08:52:39 INFO - PROCESS | 30468 | 08:55:41 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34149/tests/dromaeo/cssquery-prototype.html) 08:55:42 INFO - PROCESS | 30468 | RSS: Main: 220454912 08:55:42 INFO - PROCESS | 30468 | 08:58:45 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34149/tests/dromaeo/cssquery-yui.html) 08:58:45 INFO - PROCESS | 30468 | RSS: Main: 220282880 08:58:45 INFO - PROCESS | 30468 | 09:01:48 INFO - PROCESS | 30468 | Cycle 1(1): loaded http://localhost:34149/tests/dromaeo/cssquery-yui.html (next: http://localhost:34149/tests/dromaeo/cssquery-dojo.html) 09:01:49 INFO - PROCESS | 30468 | RSS: Main: 310353920 09:01:49 INFO - PROCESS | 30468 | 09:01:49 INFO - PROCESS | 30468 | __start_tp_report 09:01:49 INFO - PROCESS | 30468 | _x_x_mozilla_page_load 09:01:49 INFO - PROCESS | 30468 | _x_x_mozilla_page_load_details 09:01:49 INFO - PROCESS | 30468 | |i|pagename|runs| 09:01:49 INFO - PROCESS | 30468 | |0;dojo.html;2542.7330130336313;2593.7406259374075;2626.1990093021627;2635.2884721125297;2645.563482025466;4465.397171381863;4539.818407263706;4676.719396836193;4695.694779839312;4703.929441058387;4560.680752347337;4578.3819184410095;4584.931226031612;4591.88520286993;4629.189891768944;4213.705040647156;4247.044415006614;4269.380939763732;4275.700700950934;4339.891502712426;4278.1871444425615;4319.892002699926;4327.891802704926;4328.502222244435;4390.40729501518;4145.66834653227;4209.768462734548;4210.663146948237;4270.829166833323;4322.805473753673;4226.429432026668;4243.745375277463;4272.188284225987;4273;4342.326939324378;4216.304309788881;4237.915241695179;4245.087306229145;4246.447961764981;4298.20483210607;4638.652101092398;4664.137134630104;4670.743109128996;4698.859034228979;4729.337892695025;4815.759212039419;4831.4202295724735;4846.442659094178;4853.830115945961;4905.215165573527;4870.318155458239;4907.631927605444;4908.410990681105;4955.628327875388;4957.380327459067;4577.816887324503;4579.9084018319445;4583.060472603109;4632.2819962905805;4639.37368455261;4909.459959404463;4964.751762411865;4964.851054468371;5014.2979982802435;5016.523430274191;4810.436608102311;4821.63837712173;4827.686200396963;4887.36464259644;4890.510948905081;4888.340074089952;4895.73073480962;4898.21628539432;4901.044296362175;4953.455119936804;4737.336772851803;4789.401324834395;4843.878903027453;4845.394325709286;4907.33750943618;4777.0684716479955;4802.591779698765;4804.95195048052;4869.537393947569;4903.313536104948;4229.302165142717;4234.1108367242605;4239.109786944715;4279.914401711948;4310.612044915973;3712.3132220539287;3728.981355093207;3755.6807671347697;3781.357169281174;3821.140243445258;4217.135487225111;4271.551487093872;4285.742855428622;4290.806913688892;4332.761698106571;4980.178270585386;4982.526659967298;4983.152864013126;4988.551030407209;5036.622253331015;4284.207421627009;4286.828526858953;4316.6330861877095;4345.196138714348;4355.978220108879;4420.84527041552;4479.193745125844;4481.148581769454;4504.572065653758;4588.334691469785;4768.833090841804;4790.449098353734;4791.257355109963;4824.734639594786;4834.709917404967;5025.145725226647;5028.296038554532;5033.597312215087;5035.144025515598;5091.821786237612;4638;4665.4168228971375;4679.625629949664;4778.737169455713;4847.709137451764;4821.590164835888;4855.36880205571;4858.58702010333;4914.385701787277;4916.262560615936;4904.435989861069;4905.337779399735;4909.607231421549;4910.656254062182;4983.377077865267;4760.16697078003;4777.570018698334;4795.160846851857;4802.639802014793;4861.562459378673;4805.6155507558615;4861.149298872754;4871.074495845778;4873.537013983666;4934.087193869145;4760.404949381327;4792.832250871203;4794.065157294294;4799.400074990626;4843.75781210931;4723.480417154179;4761.428628564595;4766.499517550746;4772.093302272557;4837.395325584302;4616.653750968758;4650.093231819763;4659.906801864012;4668.673192876466;4734.834280800155 09:01:49 INFO - PROCESS | 30468 | |1;ext.html;569.3168198162207;571.7170000849579;573.2919843992671;582.1675004743215;585.5315747402077;27747.890084396626;38341.42487862681;39544.40683389751;39754.60245397545;43400;39852.601473985254;40434.39348409776;40435.393469097915;40456.79771601145;40492;7728.188540203282;7872.488288261274;7872.5670088145125;7879.054513458364;7885;7619.961900190491;7631.732889348874;7639.541627502367;7642.350400215988;7722.884156737653;7624.771256862303;7640.044994375703;7668.463207575472;7677.654505547263;7680.654370553339;7612.505187162845;7641.732539361151;7643.159252482223;7656.349210317129;7656.770296891074;7574.35617972473;7636.3890888728765;7641.426892982993;7642.388608911274;7644.617769111522;37461.438078428575;37778.055548611504;37931.39651733081;37933.62066379356;37950.62049379499;2780.207640822376;2830.3631682871187;2868.7991840571167;2994.6705862355125;3235.563198968156;27752.722472775215;28678.426431471253;28890.855545722137;29443.411131777244;30148.54777178344;3271.558339624144;3333.2500187457626;3387.4241378965635;3410.2667926395698;3427.4405145658916;237232;238268;238435;238525;239816;30346.393072138875;49975.50024499781;50255.74872125689;50320.496795031584;50356.244656330186;30970.22574435612;32647.510287345707;32648;32695.346093078006;32769.18077048045;12740.490380384681;12863.29251891155;12867.935660321826;12895.419706113247;12897.48410063587;10605.84091238632;10708.1433485321;10709.357438553556;10712.143028557697;10714.46427678613;7478.4765066444825;7534.284242996907;7564.0923089228545;7585.810354741176;7595.164531901486;2997.415503976747;3005.4289684959786;3024.470717624451;3036.271294889211;3099.9380012399624;779.4972242903409;779.5361759752938;782.7025730222479;950.5104870991445;951.5765484359532;25435;27712.168634940983;27825.86087069592;27987.860060699568;28038.579421308696;871.9520426376483;878.2798105553512;884.9867251991225;946.4983558713755;1011.600417834951;14117.78823317651;14626.195559244132;14799.334029968677;14934.850651493563;14948;356819;362408;363617;363729;363775;48432.30486933011;48957.510424896005;48963.51036489661;48972.510274897504;49142.508574913794;1041.578160844859;1084.1164450972433;1109.1237922041657;1156.248438514972;1174.3717111345388;27006.594901076107;28386.85806570954;28867.56698649564;29154.472436469787;29479.705202947694;41114.383284250165;41852.162956741304;41864.3720344189;41866.8599855006;41995.37006944959;277614;277800;278360.3803581645;278644;280568;20704.275350362666;21707;22365.66451503261;24962.500749984534;26430.603540947286;39861.60138398695;40780.65110382666;41114.79442602768;41406.585934140276;41742;34423.655763442046;34498.31003379969;35013.649863501036;35253.823730882206;35662;33826.32347353089;34712;34771.478427824106;34824;35229.47155792614;33620;34206.65793342035;34246.828765856015;34360.65639343575;35007.824960875034;29913.551296730133;31923.201919952186;32228.516572250966;32391.19022024374;32448.83775581107;24348.391290217885;24523.509529808947;24733.87633061823;24874;25183.24450266495 09:01:49 INFO - PROCESS | 30468 | |2;jquery.html;338.18461309597603;359.7068389262752;366.8294243176922;367.86021311901476;385.718425549349;12051;12978.480860765558;14397.208153551564;16222.918885405586;16852.325906963706;15506.14716190609;15942.601434964132;16076.758848617252;16079.919600401981;16242.675146497093;4870.902581948359;4910.140725373063;4995.675281106716;4998.200287953928;5005;3570.071781336845;3775;4896.657233993604;5002.924956125661;5006.098902197603;5484.945150548503;5750.884982300372;5792.6524408535415;5863.472287494124;5887.970560147193;5710.77156913723;5854.795082172125;5859.501942334907;5908.054711246223;5952.761889524414;5230.137027390476;5239.79040838366;5243.344581927259;5245.1869960155855;5246.055709972242;19486.80513194864;20039.899800500905;20260.898695506574;20413;20422.795772042387;1781.3320004998125;1907.7710674718983;1956.5793354428865;2143.5498545305504;2347.859128452298;12636.368181590975;13075.150115242574;13105.737885242337;13335.466581336736;13666.863331366758;1701.2174399776118;1704.9744253836202;1718.682043821897;1753.395078697847;1769.40724857173;64758.676206618664;65335.34664653388;67289.66355168192;68190.65904670494;68320.6583967082;8620.026090998721;8861.556922153995;9027.548622568846;9125.498097604695;9198.492738558058;12207.75584488323;13201.273929933946;13226.206427614374;13261.403236854365;13273.734525309439;6718.395344418928;6853.17761868579;6938.375546200866;6981.406580440719;6997.825054373681;6477.902831457532;6504.284528701839;6563.310852360529;6759.763408280686;6769.120014398097;5721.485066344049;5773.278340207474;5830.067189249699;5832.696085046383;5908.675022873697;1652.3308060235624;1660.609756707173;1677.9328826847034;1684.1158391844135;1702.9744553831702;808.2806302390877;825.5129473610599;880.7181701855473;894.6063731957918;924.1543987251724;16456.506304810635;16667.416640417527;16806.075665838252;17147.142642867806;17727.911360443373;785.1951749456853;797.6809276289531;824.9546274954935;845.2519520224646;857.5969294431607;9371.531423428802;9846.29226962591;9997.272028370933;10009.949950250348;10128.493575321205;279687;281726;282367;352265;358316;72505.6374718123;76048.23951760412;78753;79538;81622;402.1554735056417;424.73878564682497;425.5042875050593;427.2331165557769;428.4087958617151;9244.815103698023;9871.950640246752;9878.753031174278;9962.252831037556;10059.597616095274;26775.732242678103;35257;35350.646493535765;36309;36892.63107368999;47482.28776568423;50564.49435505745;51651;52955.470445295054;53999.46000539944;7328.670209840463;7429.777106686808;7495.512791668524;7657.770266892002;7701.073592034991;10079;11725.765484690088;11970.820437693268;11975.682674905927;12244.816327754912;9620.518974051409;9641.084097010773;9717.80564388694;10188.643397481053;10873.347599144077;8700.260477859452;10048.346857454242;10593.576256949944;10643.94678026605;10778.191635627203;9748.512574371394;10367.429791361246;10372.377657340583;10492.685219443429;10550.323646399564;7315.670794814139;7417.703291868264;7475.215102414386;7488.625568721651;7872.488288261245;10138.188944884245;10289;10372.429516376369;10794.244402891722;10902.50938707776 09:01:49 INFO - PROCESS | 30468 | |3;mootools.html;1206.1797977375381;1325.8342707161605;1330.6806366472047;1365.3309878159698;1633.2078941713266;6410.358964103593;6917.89623155653;7205.243449437812;7523.736669216579;7536.133344665365;7665.693372265103;7722.459427840039;7744.341730952876;7746.302832745052;7747.92252077479;2001.0395010395018;2008.9296874609317;2011.9899400502977;2017.3544465770958;2023.8684485508468;1949.3274820187012;1992.9402117936486;2000.3898810862681;2006.8595198336122;2017.2939471185114;1973.437570292467;1990.6615875301234;1991.442396129086;2000.5698774763423;2003.3689387842783;1963.7250784889984;1963.980360196394;1966.3314473079222;1968.3110911181116;1970.4679736471217;1898.8670793044491;1899.040984302932;1904.0384605773995;1928.7106933959878;1936.0900376822872;7507.249275072503;7654.387648988068;7662;7672.46292759507;7688.730894418724;4044.2720310344125;4170.791460426997;4181.0592616661315;4210.221109094828;4211.684123690736;2547.4777670577487;2651.058874099686;2677.477891811098;2679.8124131310815;2691.0984820085296;821.5276216175663;825.2613910550024;841.4824882697159;843.7679638099572;847.229021590356;10241.590336386536;10387.220958428072;10415.427151506665;10494.895051049545;10495.947520262502;3568.7561732398244;3703.2778608171147;3843.5195600549932;3851.4993050903204;3907.5701672815967;8150.144234855255;8179.95910020458;8232.753017409488;8235.752927412188;8243.876341854877;4365.563443655673;4367.868963931087;4369.825206991684;4370.672199585044;4375.059362237134;3492.89521314361;3618.511500947391;3828.9042773930873;4087.6321131098343;4090.570490098556;3047.9085627431214;3048.6951304869335;3147.3075923296838;3181.66592507788;3198.296374797541;946.8769060022291;950.705281362766;953.5184731710442;955.5317894231915;958.0371726414909;615.3292910727239;762.8398036412416;775.4688038693513;776.97669069928;782.5930516131693;5078.162103252996;5091.465396133427;5135.998480296306;5188.610854185951;5370.865728356823;364.39146625136084;367.937450633393;372.2814967113497;373.4864561228311;376.149901223232;3430.16008073296;3520.1102781426666;3627.818609069536;3658.140337020798;3658.158623516553;8995.370324077383;9307.674231401868;9383.780108585841;9387.953060234791;9405.623775049058;9274.95362523183;9284.489353085644;9287;9291.396059256127;9334.533273336307;7053.964730176419;7129.322714342129;7131.92868071323;7136.964315178391;7144.499885007999;4945.307656928105;4973.378327709036;4981.676191047571;5103.464136265638;5115.769790359517;8532.914670853212;8634.913650863662;8638.17937295981;8722.302215822592;8738.91261087381;8576.142385761623;8616.310695144499;8701.825963480822;8743.300535956982;8873.822523549621;6145.569810113249;6214.968925155526;6215.098810672517;6220.471259942956;6222.28443728977;6672.232693240339;6853.314668533107;6881.65591720402;7049.400800931979;7058.752943646948;6229.595076320024;6353.809385718251;6377;6383.1382763326355;6526.543141980016;6154.384561543989;6181.84545386369;6262.874742505215;6316.968415157895;6395.520335974914;5888.411158884249;6085.726142323518;6145.262568491809;6269.937300626935;6273.96863015682;4404.295312749945;4555.362249285169;4588.747618880993;4659;4751.218293140072;4455.398521199597;4492.438445194351;4529.84145554904;4611.077784443058;4642.14314274293 09:01:49 INFO - PROCESS | 30468 | |4;prototype.html;254.10428240452404;258.61853765695594;261.486179656974;267.8781154574669;272.2974725208961;4718.386609740737;4729.74661714645;4763.833265835697;4775.47469778325;4810.206315957871;4669.883252918678;4687.437507499097;4701.683528611994;4709.788059537321;4755;3508.456189290664;3587.3722098632766;3614.5301110855553;3669.3578623740873;3673.8897833065053;3673.3204357194004;3682.1531047858875;3693.9815300923456;3701.907452313687;3703.2223233121076;3643.5627724673077;3645.2891686121216;3647.288778688157;3651.1054791576103;3676.7426280160266;3481.617022127564;3562.3257069177703;3610.2418492116685;3648.1609229877013;3671.3391589513876;3207.3264614430996;3207.957413840488;3215.565898603705;3217.1635374802486;3218.2598002459567;4648.3259927310355;4665;4694.24892017279;4695.567851805198;4733;3862.9613703862883;4112.753234805921;4173.874783756492;4175.248455278049;4176.853810116661;4967.882226499045;4968.950310496885;4979.327790748239;4985.576226020793;4990.575801056914;3417.0773891049525;3431;3438.948415773765;3439.5356626855305;3445;5078.619103567247;5288.048151332759;5314.963582101492;5327.706976116351;5332.146856502941;3492.738044646662;3524.3303772283184;3528.947065794015;3531.841067151984;3534.3991521440903;3575.2123938030986;3576.5350504434778;3586.7130629549574;3588.802615856153;3596.956882504097;4146.937795933063;4155.376693495939;4156.085661154541;4158.688098392572;4171.395147703566;4750.334953106568;4947.455779864212;5054.671446355975;5059.544640982329;5067.619928505377;1236.789745743226;1258.5783762439685;1259.7102666386781;1260.8108783682521;1263.4946021591254;798.9760307190794;810.7932477218271;825.6706702209437;830.6262182018116;832.1470492744863;4279.486461624625;4405.885175115963;4427.977860110679;4551.385562949025;4554.817807287738;5255.580993131833;5256.159014557652;5264.394594621591;5265.894162225975;5269;4531.592156705847;4535.9773201133785;4539.72761634303;4552.613027892667;4559.749213793273;2635.8023148263956;2747.8213916095788;2759.365345970438;2779.958300625492;2796.2523422860713;4980.879302157058;4984.352034235526;4991.351124353883;4995.375578052744;5033.874153146127;5012.972340670154;5338.332708411449;5367.087595108841;5377.139657654757;5382.892342153135;4907.779149938261;4908.214685650279;4911.9754401227765;4929.827456039093;5002.349694539686;5130.692158470503;5131.332926719502;5146.941223510626;5226.268322434787;5231.189165679326;4947.802087916443;5098.311727916832;5111.830664987583;5118.206677964921;5125.411122552021;4935.629827763004;4959.776810043484;4976.353074100344;4979.751012449436;4986.301917731593;3766.510353654117;3770.3024940386117;3786.6213378661914;3799.4422286862255;3800.771953682788;5031.7735701894235;5221.869453263699;5245.842624721265;5248.58011359098;5250.159974404077;5031.396232452129;5037.672551284155;5049.444561098203;5049.677148511726;5049.8737531562;5011.173156429149;5026.246063090565;5095.87260318495;5115.18157094863;5128.58971282304;4876.892302373334;4900.632452566;5010.947700982834;5011.574016208663;5038.571721403721;4804.591609713214;4907.312976183266;4913.943502147055;5068.214426763858;5092.516210959953;4867.829625963216;4895.241237608034;4914.508549145057;4920.335754673073;4940.802367905244 09:01:49 INFO - PROCESS | 30468 | |5;yui.html;581.2240658720608;588.2617315269337;657.7730682914392;685.8971154326849;699.3426179391369;11716.355600441972;12220.205686630374;12309.876901230997;12686.61940141795;13816.101953373049;13740.862591374083;14363.210023448706;14419.062760920559;14474.276286185675;14571.052881562691;723.8660847743158;741.3846507398873;744.0996394362827;744.5160645580389;744.6723441685641;595.4670569839991;612.0788213738317;718.7735863203101;740.2930201657431;747.6934456872656;777.2965466253022;779.3842864137325;779.7582749347692;780.0795061827042;780.2158830375465;773.7949443397504;773.9264769846856;774.3804956035177;774.4927072767347;774.5391492062214;459.8827299038757;466.8412739668529;469.4859129253462;471.1260611565531;545.4463719324889;12761.425735841816;13217.14088584239;13230.933845330808;13241;13254;12160.209586376857;12440.315782631951;12620.747585048339;12744.490220391173;13278.66803329915;11600.477978490904;11613;11703.824442633368;11799.233049851731;12252.509899604094;4136.875893723193;4158.792060396968;4215.388768628532;4255.5957184067465;4333.06839029607;64876;64928;67975.32024679739;68029.9999999995;68089.31910680929;10076.345037572535;10262.127719143808;10299;10553.472326383804;10664.200184986157;16855.325786968384;16896.155192240338;16913.661726765396;16937.237824297936;16947;6526.347365263436;6608.537402381787;6703.597784132968;6825.385715285648;6909.1018167637885;3495.8601655933476;3531.7174626029855;3590.084528445282;3594.6045934947656;3637.217998130415;2688.5967104934416;2771.528840097188;2778.9305267368477;2781.22125804775;3050.100220434977;512.6488355476511;512.7205672908274;514.9948500515022;522.8091746512496;523.9371275446971;519.7946811009706;541.2557733116964;541.8103663717667;547.1764993684479;552.6545908806995;7669.693212271447;7703.513025432349;8084.7574572762915;8131.9186808132345;8132.227438393344;432.3860118631488;529.1982646290872;543.1011675676762;543.74987505747;545.498141709628;3525.050080228029;3772.245550889833;3797.373433383461;3846.942295865564;4013.8795836124964;101652.49173754084;102319;102723.48638256761;104936;106160;85966;86202.56898715592;86386;87288;89338.10661893428;44197;50327.24509132366;60872;60985.69507152436;79692;7850.882236766567;8242.29940455044;8316.209960053786;8404.705835295736;8462.830743384975;34499;36294.27411451809;40586.391204131374;40714.59285407108;43816;56733.432665672815;59438.40561594329;62206.0669089955;62258.688706556175;63641.681791590745;10809.891901080888;10934.507947142556;10977.560897564328;11299.039581635325;11452.198346116025;12014.279143251433;12023.879761202626;12240.87759122433;12310.446029928495;12354.135210535176;10727.356358618508;11209.943950280196;11556.826647600461;11693.707657308296;11739.706507337043;10691.94654026756;11362.772744544898;11874.346910919983;11922.880771192524;11941.104417168921;10748.140148787921;11255;11836.171467997157;11886.821697674715;11901.10741694359;9059.864102038606;9195.402298850553;9408;9517.143457088896;9524.761880953032;8169.632366543638;8954.731358059269;9649.614015439303;9823.754406139618;9849.901500984899 09:01:49 INFO - PROCESS | 30468 | __end_tp_report 09:01:49 INFO - PROCESS | 30468 | __start_cc_report 09:01:49 INFO - PROCESS | 30468 | _x_x_mozilla_cycle_collect,1061 09:01:49 INFO - PROCESS | 30468 | __end_cc_report 09:01:49 INFO - PROCESS | 30468 | __startTimestamp1474560109246__endTimestamp 09:01:49 INFO - PROCESS | 30468 | 09:01:49 INFO - PROCESS | 30468 | ------- Summary: start ------- 09:01:49 INFO - PROCESS | 30468 | Number of tests: 6 09:01:49 INFO - PROCESS | 30468 | 09:01:49 INFO - PROCESS | 30468 | [#0] dojo.html Cycles:165 Average:4575.00 Median:4729.34 stddev:458.98 (9.7%) stddev-sans-first:431.81 09:01:49 INFO - PROCESS | 30468 | Values: 2542.7 2593.7 2626.2 2635.3 2645.6 4465.4 4539.8 4676.7 4695.7 4703.9 4560.7 4578.4 4584.9 4591.9 4629.2 4213.7 4247.0 4269.4 4275.7 4339.9 4278.2 4319.9 4327.9 4328.5 4390.4 4145.7 4209.8 4210.7 4270.8 4322.8 4226.4 4243.7 4272.2 4273.0 4342.3 4216.3 4237.9 4245.1 4246.4 4298.2 4638.7 4664.1 4670.7 4698.9 4729.3 4815.8 4831.4 4846.4 4853.8 4905.2 4870.3 4907.6 4908.4 4955.6 4957.4 4577.8 4579.9 4583.1 4632.3 4639.4 4909.5 4964.8 4964.9 5014.3 5016.5 4810.4 4821.6 4827.7 4887.4 4890.5 4888.3 4895.7 4898.2 4901.0 4953.5 4737.3 4789.4 4843.9 4845.4 4907.3 4777.1 4802.6 4805.0 4869.5 4903.3 4229.3 4234.1 4239.1 4279.9 4310.6 3712.3 3729.0 3755.7 3781.4 3821.1 4217.1 4271.6 4285.7 4290.8 4332.8 4980.2 4982.5 4983.2 4988.6 5036.6 4284.2 4286.8 4316.6 4345.2 4356.0 4420.8 4479.2 4481.1 4504.6 4588.3 4768.8 4790.4 4791.3 4824.7 4834.7 5025.1 5028.3 5033.6 5035.1 5091.8 4638.0 4665.4 4679.6 4778.7 4847.7 4821.6 4855.4 4858.6 4914.4 4916.3 4904.4 4905.3 4909.6 4910.7 4983.4 4760.2 4777.6 4795.2 4802.6 4861.6 4805.6 4861.1 4871.1 4873.5 4934.1 4760.4 4792.8 4794.1 4799.4 4843.8 4723.5 4761.4 4766.5 4772.1 4837.4 4616.7 4650.1 4659.9 4668.7 4734.8 09:01:49 INFO - PROCESS | 30468 | 09:01:49 INFO - PROCESS | 30468 | [#1] ext.html Cycles:180 Average:43635.57 Median:34741.74 stddev:78331.91 (225.5%) stddev-sans-first:78484.92 09:01:49 INFO - PROCESS | 30468 | Values: 569.3 571.7 573.3 582.2 585.5 27747.9 38341.4 39544.4 39754.6 43400.0 39852.6 40434.4 40435.4 40456.8 40492.0 7728.2 7872.5 7872.6 7879.1 7885.0 7620.0 7631.7 7639.5 7642.4 7722.9 7624.8 7640.0 7668.5 7677.7 7680.7 7612.5 7641.7 7643.2 7656.3 7656.8 7574.4 7636.4 7641.4 7642.4 7644.6 37461.4 37778.1 37931.4 37933.6 37950.6 2780.2 2830.4 2868.8 2994.7 3235.6 27752.7 28678.4 28890.9 29443.4 30148.5 3271.6 3333.3 3387.4 3410.3 3427.4 237232.0 238268.0 238435.0 238525.0 239816.0 30346.4 49975.5 50255.7 50320.5 50356.2 30970.2 32647.5 32648.0 32695.3 32769.2 12740.5 12863.3 12867.9 12895.4 12897.5 10605.8 10708.1 10709.4 10712.1 10714.5 7478.5 7534.3 7564.1 7585.8 7595.2 2997.4 3005.4 3024.5 3036.3 3099.9 779.5 779.5 782.7 950.5 951.6 25435.0 27712.2 27825.9 27987.9 28038.6 872.0 878.3 885.0 946.5 1011.6 14117.8 14626.2 14799.3 14934.9 14948.0 356819.0 362408.0 363617.0 363729.0 363775.0 48432.3 48957.5 48963.5 48972.5 49142.5 1041.6 1084.1 1109.1 1156.2 1174.4 27006.6 28386.9 28867.6 29154.5 29479.7 41114.4 41852.2 41864.4 41866.9 41995.4 277614.0 277800.0 278360.4 278644.0 280568.0 20704.3 21707.0 22365.7 24962.5 26430.6 39861.6 40780.7 41114.8 41406.6 41742.0 34423.7 34498.3 35013.6 35253.8 35662.0 33826.3 34712.0 34771.5 34824.0 35229.5 33620.0 34206.7 34246.8 34360.7 35007.8 29913.6 31923.2 32228.5 32391.2 32448.8 24348.4 24523.5 24733.9 24874.0 25183.2 09:01:49 INFO - PROCESS | 30468 | 09:01:49 INFO - PROCESS | 30468 | [#2] jquery.html Cycles:180 Average:21785.60 Median:26176.60 stddev:52300.57 (199.8%) stddev-sans-first:52422.50 09:01:49 INFO - PROCESS | 30468 | Values: 338.2 359.7 366.8 367.9 385.7 12051.0 12978.5 14397.2 16222.9 16852.3 15506.1 15942.6 16076.8 16079.9 16242.7 4870.9 4910.1 4995.7 4998.2 5005.0 3570.1 3775.0 4896.7 5002.9 5006.1 5484.9 5750.9 5792.7 5863.5 5888.0 5710.8 5854.8 5859.5 5908.1 5952.8 5230.1 5239.8 5243.3 5245.2 5246.1 19486.8 20039.9 20260.9 20413.0 20422.8 1781.3 1907.8 1956.6 2143.5 2347.9 12636.4 13075.2 13105.7 13335.5 13666.9 1701.2 1705.0 1718.7 1753.4 1769.4 64758.7 65335.3 67289.7 68190.7 68320.7 8620.0 8861.6 9027.5 9125.5 9198.5 12207.8 13201.3 13226.2 13261.4 13273.7 6718.4 6853.2 6938.4 6981.4 6997.8 6477.9 6504.3 6563.3 6759.8 6769.1 5721.5 5773.3 5830.1 5832.7 5908.7 1652.3 1660.6 1677.9 1684.1 1703.0 808.3 825.5 880.7 894.6 924.2 16456.5 16667.4 16806.1 17147.1 17727.9 785.2 797.7 825.0 845.3 857.6 9371.5 9846.3 9997.3 10009.9 10128.5 279687.0 281726.0 282367.0 352265.0 358316.0 72505.6 76048.2 78753.0 79538.0 81622.0 402.2 424.7 425.5 427.2 428.4 9244.8 9872.0 9878.8 9962.3 10059.6 26775.7 35257.0 35350.6 36309.0 36892.6 47482.3 50564.5 51651.0 52955.5 53999.5 7328.7 7429.8 7495.5 7657.8 7701.1 10079.0 11725.8 11970.8 11975.7 12244.8 9620.5 9641.1 9717.8 10188.6 10873.3 8700.3 10048.3 10593.6 10643.9 10778.2 9748.5 10367.4 10372.4 10492.7 10550.3 7315.7 7417.7 7475.2 7488.6 7872.5 10138.2 10289.0 10372.4 10794.2 10902.5 09:01:49 INFO - PROCESS | 30468 | 09:01:49 INFO - PROCESS | 30468 | [#3] mootools.html Cycles:180 Average:4861.39 Median:5109.62 stddev:2816.82 (55.1%) stddev-sans-first:2811.33 09:01:49 INFO - PROCESS | 30468 | Values: 1206.2 1325.8 1330.7 1365.3 1633.2 6410.4 6917.9 7205.2 7523.7 7536.1 7665.7 7722.5 7744.3 7746.3 7747.9 2001.0 2008.9 2012.0 2017.4 2023.9 1949.3 1992.9 2000.4 2006.9 2017.3 1973.4 1990.7 1991.4 2000.6 2003.4 1963.7 1964.0 1966.3 1968.3 1970.5 1898.9 1899.0 1904.0 1928.7 1936.1 7507.2 7654.4 7662.0 7672.5 7688.7 4044.3 4170.8 4181.1 4210.2 4211.7 2547.5 2651.1 2677.5 2679.8 2691.1 821.5 825.3 841.5 843.8 847.2 10241.6 10387.2 10415.4 10494.9 10495.9 3568.8 3703.3 3843.5 3851.5 3907.6 8150.1 8180.0 8232.8 8235.8 8243.9 4365.6 4367.9 4369.8 4370.7 4375.1 3492.9 3618.5 3828.9 4087.6 4090.6 3047.9 3048.7 3147.3 3181.7 3198.3 946.9 950.7 953.5 955.5 958.0 615.3 762.8 775.5 777.0 782.6 5078.2 5091.5 5136.0 5188.6 5370.9 364.4 367.9 372.3 373.5 376.1 3430.2 3520.1 3627.8 3658.1 3658.2 8995.4 9307.7 9383.8 9388.0 9405.6 9275.0 9284.5 9287.0 9291.4 9334.5 7054.0 7129.3 7131.9 7137.0 7144.5 4945.3 4973.4 4981.7 5103.5 5115.8 8532.9 8634.9 8638.2 8722.3 8738.9 8576.1 8616.3 8701.8 8743.3 8873.8 6145.6 6215.0 6215.1 6220.5 6222.3 6672.2 6853.3 6881.7 7049.4 7058.8 6229.6 6353.8 6377.0 6383.1 6526.5 6154.4 6181.8 6262.9 6317.0 6395.5 5888.4 6085.7 6145.3 6269.9 6274.0 4404.3 4555.4 4588.7 4659.0 4751.2 4455.4 4492.4 4529.8 4611.1 4642.1 09:01:49 INFO - PROCESS | 30468 | 09:01:49 INFO - PROCESS | 30468 | [#4] prototype.html Cycles:180 Average:4156.97 Median:4741.67 stddev:1238.44 (26.1%) stddev-sans-first:1206.77 09:01:49 INFO - PROCESS | 30468 | Values: 254.1 258.6 261.5 267.9 272.3 4718.4 4729.7 4763.8 4775.5 4810.2 4669.9 4687.4 4701.7 4709.8 4755.0 3508.5 3587.4 3614.5 3669.4 3673.9 3673.3 3682.2 3694.0 3701.9 3703.2 3643.6 3645.3 3647.3 3651.1 3676.7 3481.6 3562.3 3610.2 3648.2 3671.3 3207.3 3208.0 3215.6 3217.2 3218.3 4648.3 4665.0 4694.2 4695.6 4733.0 3863.0 4112.8 4173.9 4175.2 4176.9 4967.9 4969.0 4979.3 4985.6 4990.6 3417.1 3431.0 3438.9 3439.5 3445.0 5078.6 5288.0 5315.0 5327.7 5332.1 3492.7 3524.3 3528.9 3531.8 3534.4 3575.2 3576.5 3586.7 3588.8 3597.0 4146.9 4155.4 4156.1 4158.7 4171.4 4750.3 4947.5 5054.7 5059.5 5067.6 1236.8 1258.6 1259.7 1260.8 1263.5 799.0 810.8 825.7 830.6 832.1 4279.5 4405.9 4428.0 4551.4 4554.8 5255.6 5256.2 5264.4 5265.9 5269.0 4531.6 4536.0 4539.7 4552.6 4559.7 2635.8 2747.8 2759.4 2780.0 2796.3 4980.9 4984.4 4991.4 4995.4 5033.9 5013.0 5338.3 5367.1 5377.1 5382.9 4907.8 4908.2 4912.0 4929.8 5002.3 5130.7 5131.3 5146.9 5226.3 5231.2 4947.8 5098.3 5111.8 5118.2 5125.4 4935.6 4959.8 4976.4 4979.8 4986.3 3766.5 3770.3 3786.6 3799.4 3800.8 5031.8 5221.9 5245.8 5248.6 5250.2 5031.4 5037.7 5049.4 5049.7 5049.9 5011.2 5026.2 5095.9 5115.2 5128.6 4876.9 4900.6 5010.9 5011.6 5038.6 4804.6 4907.3 4913.9 5068.2 5092.5 4867.8 4895.2 4914.5 4920.3 4940.8 09:01:49 INFO - PROCESS | 30468 | 09:01:49 INFO - PROCESS | 30468 | [#5] yui.html Cycles:180 Average:17436.82 Median:44006.50 stddev:25364.73 (57.6%) stddev-sans-first:25404.31 09:01:49 INFO - PROCESS | 30468 | Values: 581.2 588.3 657.8 685.9 699.3 11716.4 12220.2 12309.9 12686.6 13816.1 13740.9 14363.2 14419.1 14474.3 14571.1 723.9 741.4 744.1 744.5 744.7 595.5 612.1 718.8 740.3 747.7 777.3 779.4 779.8 780.1 780.2 773.8 773.9 774.4 774.5 774.5 459.9 466.8 469.5 471.1 545.4 12761.4 13217.1 13230.9 13241.0 13254.0 12160.2 12440.3 12620.7 12744.5 13278.7 11600.5 11613.0 11703.8 11799.2 12252.5 4136.9 4158.8 4215.4 4255.6 4333.1 64876.0 64928.0 67975.3 68030.0 68089.3 10076.3 10262.1 10299.0 10553.5 10664.2 16855.3 16896.2 16913.7 16937.2 16947.0 6526.3 6608.5 6703.6 6825.4 6909.1 3495.9 3531.7 3590.1 3594.6 3637.2 2688.6 2771.5 2778.9 2781.2 3050.1 512.6 512.7 515.0 522.8 523.9 519.8 541.3 541.8 547.2 552.7 7669.7 7703.5 8084.8 8131.9 8132.2 432.4 529.2 543.1 543.7 545.5 3525.1 3772.2 3797.4 3846.9 4013.9 101652.5 102319.0 102723.5 104936.0 106160.0 85966.0 86202.6 86386.0 87288.0 89338.1 44197.0 50327.2 60872.0 60985.7 79692.0 7850.9 8242.3 8316.2 8404.7 8462.8 34499.0 36294.3 40586.4 40714.6 43816.0 56733.4 59438.4 62206.1 62258.7 63641.7 10809.9 10934.5 10977.6 11299.0 11452.2 12014.3 12023.9 12240.9 12310.4 12354.1 10727.4 11209.9 11556.8 11693.7 11739.7 10691.9 11362.8 11874.3 11922.9 11941.1 10748.1 11255.0 11836.2 11886.8 11901.1 9059.9 9195.4 9408.0 9517.1 9524.8 8169.6 8954.7 9649.6 9823.8 9849.9 09:01:49 INFO - PROCESS | 30468 | -------- Summary: end -------- 09:01:49 INFO - PROCESS | 30468 | 09:01:50 INFO - TEST-INFO | 30468: exit 0 09:01:50 INFO - TEST-OK | dromaeo_css | took 1122992ms 09:01:50 INFO - TEST-START | kraken 09:01:50 INFO - operating with platform_type : linux_ 09:01:50 INFO - Initialising browser for kraken test... 09:01:50 INFO - TEST-INFO | started process 30777 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNYAKIz/profile http://localhost:34149/getInfo.html) 09:01:55 INFO - PROCESS | 30777 | __metrics Screen width/height:1600/1200 09:01:55 INFO - PROCESS | 30777 | colorDepth:24 09:01:55 INFO - PROCESS | 30777 | Browser inner width/height: 1024/697 09:01:55 INFO - PROCESS | 30777 | __metrics 09:01:56 INFO - PROCESS | 30777 | 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" 09:01:56 INFO - PROCESS | 30777 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:01:57 INFO - PROCESS | 30777 | console.error: PushService: 09:01:57 INFO - PROCESS | 30777 | stateChangeProcessEnqueue: Error transitioning state 09:01:57 INFO - PROCESS | 30777 | UnknownError 09:01:58 INFO - TEST-INFO | 30777: exit 0 09:01:58 INFO - Browser initialized. 09:01:58 INFO - Running cycle 1/1 for kraken test... 09:01:58 INFO - TEST-INFO | started process 30861 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpNYAKIz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:02:10 INFO - PROCESS | 30861 | RSS: Main: 174968832 09:02:10 INFO - PROCESS | 30861 | 09:02:13 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34149/tests/kraken/driver.html?testName=audio-beat-detection) 09:02:14 INFO - PROCESS | 30861 | RSS: Main: 233459712 09:02:14 INFO - PROCESS | 30861 | 09:02:16 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34149/tests/kraken/driver.html?testName=audio-dft) 09:02:17 INFO - PROCESS | 30861 | RSS: Main: 218628096 09:02:17 INFO - PROCESS | 30861 | 09:02:20 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34149/tests/kraken/driver.html?testName=audio-fft) 09:02:21 INFO - PROCESS | 30861 | RSS: Main: 299864064 09:02:21 INFO - PROCESS | 30861 | 09:02:23 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34149/tests/kraken/driver.html?testName=audio-oscillator) 09:02:24 INFO - PROCESS | 30861 | RSS: Main: 208236544 09:02:24 INFO - PROCESS | 30861 | 09:02:26 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34149/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:02:26 INFO - PROCESS | 30861 | RSS: Main: 213819392 09:02:26 INFO - PROCESS | 30861 | 09:02:30 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34149/tests/kraken/driver.html?testName=imaging-darkroom) 09:02:30 INFO - PROCESS | 30861 | RSS: Main: 249966592 09:02:30 INFO - PROCESS | 30861 | 09:02:34 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34149/tests/kraken/driver.html?testName=imaging-desaturate) 09:02:34 INFO - PROCESS | 30861 | RSS: Main: 244965376 09:02:34 INFO - PROCESS | 30861 | 09:02:37 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34149/tests/kraken/driver.html?testName=json-parse-financial) 09:02:38 INFO - PROCESS | 30861 | RSS: Main: 248033280 09:02:38 INFO - PROCESS | 30861 | 09:02:40 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34149/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:02:40 INFO - PROCESS | 30861 | RSS: Main: 210976768 09:02:40 INFO - PROCESS | 30861 | 09:02:42 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:02:43 INFO - PROCESS | 30861 | RSS: Main: 217567232 09:02:43 INFO - PROCESS | 30861 | 09:02:45 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:02:46 INFO - PROCESS | 30861 | RSS: Main: 222855168 09:02:46 INFO - PROCESS | 30861 | 09:02:48 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:02:49 INFO - PROCESS | 30861 | RSS: Main: 223227904 09:02:49 INFO - PROCESS | 30861 | 09:02:52 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:02:53 INFO - PROCESS | 30861 | RSS: Main: 221609984 09:02:53 INFO - PROCESS | 30861 | 09:02:54 INFO - PROCESS | 30861 | Cycle 1(1): loaded http://localhost:34149/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34149/tests/kraken/driver.html?testName=ai-astar) 09:02:55 INFO - PROCESS | 30861 | RSS: Main: 272977920 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | __start_tp_report 09:02:55 INFO - PROCESS | 30861 | _x_x_mozilla_page_load 09:02:55 INFO - PROCESS | 30861 | _x_x_mozilla_page_load_details 09:02:55 INFO - PROCESS | 30861 | |i|pagename|runs| 09:02:55 INFO - PROCESS | 30861 | |0;ai-astar;114;116;116;118;116;116;116;119;115;114 09:02:55 INFO - PROCESS | 30861 | |1;audio-beat-detection;151;127;128;167;126;124;122;123;177;126 09:02:55 INFO - PROCESS | 30861 | |2;audio-dft;162;163;162;161;163;161;162;163;161;162 09:02:55 INFO - PROCESS | 30861 | |3;audio-fft;77;76;75;104;77;76;77;77;102;76 09:02:55 INFO - PROCESS | 30861 | |4;audio-oscillator;83;83;108;84;84;84;106;84;83;116 09:02:55 INFO - PROCESS | 30861 | |5;imaging-gaussian-blur;118;118;118;117;117;117;117;118;118;117 09:02:55 INFO - PROCESS | 30861 | |6;imaging-darkroom;148;148;146;146;146;146;147;146;148;145 09:02:55 INFO - PROCESS | 30861 | |7;imaging-desaturate;95;96;96;95;95;96;95;94;95;95 09:02:55 INFO - PROCESS | 30861 | |8;json-parse-financial;63;62;62;62;65;64;65;66;64;64 09:02:55 INFO - PROCESS | 30861 | |9;json-stringify-tinderbox;66;66;67;66;66;66;67;67;66;67 09:02:55 INFO - PROCESS | 30861 | |10;stanford-crypto-aes;83;88;85;93;86;91;82;82;82;81 09:02:55 INFO - PROCESS | 30861 | |11;stanford-crypto-ccm;137;131;133;133;132;139;132;139;170;134 09:02:55 INFO - PROCESS | 30861 | |12;stanford-crypto-pbkdf2;175;176;176;177;173;174;173;175;175;175 09:02:55 INFO - PROCESS | 30861 | |13;stanford-crypto-sha256-iterative;70;71;71;72;73;70;71;72;70;70 09:02:55 INFO - PROCESS | 30861 | __end_tp_report 09:02:55 INFO - PROCESS | 30861 | __start_cc_report 09:02:55 INFO - PROCESS | 30861 | _x_x_mozilla_cycle_collect,1936 09:02:55 INFO - PROCESS | 30861 | __end_cc_report 09:02:55 INFO - PROCESS | 30861 | __startTimestamp1474560175207__endTimestamp 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | ------- Summary: start ------- 09:02:55 INFO - PROCESS | 30861 | Number of tests: 14 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#0] ai-astar Cycles:10 Average:116.00 Median:116.00 stddev:1.56 (1.3%) stddev-sans-first:1.48 09:02:55 INFO - PROCESS | 30861 | Values: 114.0 116.0 116.0 118.0 116.0 116.0 116.0 119.0 115.0 114.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#1] audio-beat-detection Cycles:10 Average:137.10 Median:127.50 stddev:20.30 (15.9%) stddev-sans-first:20.90 09:02:55 INFO - PROCESS | 30861 | Values: 151.0 127.0 128.0 167.0 126.0 124.0 122.0 123.0 177.0 126.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:0.82 (0.5%) stddev-sans-first:0.87 09:02:55 INFO - PROCESS | 30861 | Values: 162.0 163.0 162.0 161.0 163.0 161.0 162.0 163.0 161.0 162.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#3] audio-fft Cycles:10 Average:81.70 Median:76.50 stddev:11.26 (14.7%) stddev-sans-first:11.81 09:02:55 INFO - PROCESS | 30861 | Values: 77.0 76.0 75.0 104.0 77.0 76.0 77.0 77.0 102.0 76.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#4] audio-oscillator Cycles:10 Average:91.50 Median:83.50 stddev:13.01 (15.6%) stddev-sans-first:13.44 09:02:55 INFO - PROCESS | 30861 | Values: 83.0 83.0 108.0 84.0 84.0 84.0 106.0 84.0 83.0 116.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 09:02:55 INFO - PROCESS | 30861 | Values: 118.0 118.0 118.0 117.0 117.0 117.0 117.0 118.0 118.0 117.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#6] imaging-darkroom Cycles:10 Average:146.60 Median:146.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 09:02:55 INFO - PROCESS | 30861 | Values: 148.0 148.0 146.0 146.0 146.0 146.0 147.0 146.0 148.0 145.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 09:02:55 INFO - PROCESS | 30861 | Values: 95.0 96.0 96.0 95.0 95.0 96.0 95.0 94.0 95.0 95.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#8] json-parse-financial Cycles:10 Average:63.70 Median:64.00 stddev:1.42 (2.2%) stddev-sans-first:1.48 09:02:55 INFO - PROCESS | 30861 | Values: 63.0 62.0 62.0 62.0 65.0 64.0 65.0 66.0 64.0 64.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#9] json-stringify-tinderbox Cycles:10 Average:66.40 Median:66.50 stddev:0.52 (0.8%) stddev-sans-first:0.53 09:02:55 INFO - PROCESS | 30861 | Values: 66.0 66.0 67.0 66.0 66.0 66.0 67.0 67.0 66.0 67.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#10] stanford-crypto-aes Cycles:10 Average:85.30 Median:85.50 stddev:4.16 (4.9%) stddev-sans-first:4.33 09:02:55 INFO - PROCESS | 30861 | Values: 83.0 88.0 85.0 93.0 86.0 91.0 82.0 82.0 82.0 81.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#11] stanford-crypto-ccm Cycles:10 Average:138.00 Median:135.50 stddev:11.61 (8.6%) stddev-sans-first:12.31 09:02:55 INFO - PROCESS | 30861 | Values: 137.0 131.0 133.0 133.0 132.0 139.0 132.0 139.0 170.0 134.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.90 Median:175.00 stddev:1.29 (0.7%) stddev-sans-first:1.36 09:02:55 INFO - PROCESS | 30861 | Values: 175.0 176.0 176.0 177.0 173.0 174.0 173.0 175.0 175.0 175.0 09:02:55 INFO - PROCESS | 30861 | 09:02:55 INFO - PROCESS | 30861 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:71.00 stddev:1.05 (1.5%) stddev-sans-first:1.05 09:02:55 INFO - PROCESS | 30861 | Values: 70.0 71.0 71.0 72.0 73.0 70.0 71.0 72.0 70.0 70.0 09:02:55 INFO - PROCESS | 30861 | -------- Summary: end -------- 09:02:55 INFO - PROCESS | 30861 | 09:02:56 INFO - TEST-INFO | 30861: exit 0 09:02:56 INFO - TEST-OK | kraken | took 66258ms 09:02:56 INFO - SUITE-END | took 1189s 09:02:56 INFO - Completed test suite (00:19:49) 09:02:56 INFO - javascript benchmark 09:02:56 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2542.7330130336313, 2593.7406259374075, 2626.1990093021627, 2635.2884721125297, 2645.563482025466, 4465.397171381863, 4539.818407263706, 4676.719396836193, 4695.694779839312, 4703.929441058387, 4560.680752347337, 4578.3819184410095, 4584.931226031612, 4591.88520286993, 4629.189891768944, 4213.705040647156, 4247.044415006614, 4269.380939763732, 4275.700700950934, 4339.891502712426, 4278.1871444425615, 4319.892002699926, 4327.891802704926, 4328.502222244435, 4390.40729501518, 4145.66834653227, 4209.768462734548, 4210.663146948237, 4270.829166833323, 4322.805473753673, 4226.429432026668, 4243.745375277463, 4272.188284225987, 4273.0, 4342.326939324378, 4216.304309788881, 4237.915241695179, 4245.087306229145, 4246.447961764981, 4298.20483210607, 4638.652101092398, 4664.137134630104, 4670.743109128996, 4698.859034228979, 4729.337892695025, 4815.759212039419, 4831.4202295724735, 4846.442659094178, 4853.830115945961, 4905.215165573527, 4870.318155458239, 4907.631927605444, 4908.410990681105, 4955.628327875388, 4957.380327459067, 4577.816887324503, 4579.9084018319445, 4583.060472603109, 4632.2819962905805, 4639.37368455261, 4909.459959404463, 4964.751762411865, 4964.851054468371, 5014.2979982802435, 5016.523430274191, 4810.436608102311, 4821.63837712173, 4827.686200396963, 4887.36464259644, 4890.510948905081, 4888.340074089952, 4895.73073480962, 4898.21628539432, 4901.044296362175, 4953.455119936804, 4737.336772851803, 4789.401324834395, 4843.878903027453, 4845.394325709286, 4907.33750943618, 4777.0684716479955, 4802.591779698765, 4804.95195048052, 4869.537393947569, 4903.313536104948, 4229.302165142717, 4234.1108367242605, 4239.109786944715, 4279.914401711948, 4310.612044915973, 3712.3132220539287, 3728.981355093207, 3755.6807671347697, 3781.357169281174, 3821.140243445258, 4217.135487225111, 4271.551487093872, 4285.742855428622, 4290.806913688892, 4332.761698106571, 4980.178270585386, 4982.526659967298, 4983.152864013126, 4988.551030407209, 5036.622253331015, 4284.207421627009, 4286.828526858953, 4316.6330861877095, 4345.196138714348, 4355.978220108879, 4420.84527041552, 4479.193745125844, 4481.148581769454, 4504.572065653758, 4588.334691469785, 4768.833090841804, 4790.449098353734, 4791.257355109963, 4824.734639594786, 4834.709917404967, 5025.145725226647, 5028.296038554532, 5033.597312215087, 5035.144025515598, 5091.821786237612, 4638.0, 4665.4168228971375, 4679.625629949664, 4778.737169455713, 4847.709137451764, 4821.590164835888, 4855.36880205571, 4858.58702010333, 4914.385701787277, 4916.262560615936, 4904.435989861069, 4905.337779399735, 4909.607231421549, 4910.656254062182, 4983.377077865267, 4760.16697078003, 4777.570018698334, 4795.160846851857, 4802.639802014793, 4861.562459378673, 4805.6155507558615, 4861.149298872754, 4871.074495845778, 4873.537013983666, 4934.087193869145, 4760.404949381327, 4792.832250871203, 4794.065157294294, 4799.400074990626, 4843.75781210931, 4723.480417154179, 4761.428628564595, 4766.499517550746, 4772.093302272557, 4837.395325584302, 4616.653750968758, 4650.093231819763, 4659.906801864012, 4668.673192876466, 4734.834280800155], "value": 4546.738684074211, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [569.3168198162207, 571.7170000849579, 573.2919843992671, 582.1675004743215, 585.5315747402077, 27747.890084396626, 38341.42487862681, 39544.40683389751, 39754.60245397545, 43400.0, 39852.601473985254, 40434.39348409776, 40435.393469097915, 40456.79771601145, 40492.0, 7728.188540203282, 7872.488288261274, 7872.5670088145125, 7879.054513458364, 7885.0, 7619.961900190491, 7631.732889348874, 7639.541627502367, 7642.350400215988, 7722.884156737653, 7624.771256862303, 7640.044994375703, 7668.463207575472, 7677.654505547263, 7680.654370553339, 7612.505187162845, 7641.732539361151, 7643.159252482223, 7656.349210317129, 7656.770296891074, 7574.35617972473, 7636.3890888728765, 7641.426892982993, 7642.388608911274, 7644.617769111522, 37461.438078428575, 37778.055548611504, 37931.39651733081, 37933.62066379356, 37950.62049379499, 2780.207640822376, 2830.3631682871187, 2868.7991840571167, 2994.6705862355125, 3235.563198968156, 27752.722472775215, 28678.426431471253, 28890.855545722137, 29443.411131777244, 30148.54777178344, 3271.558339624144, 3333.2500187457626, 3387.4241378965635, 3410.2667926395698, 3427.4405145658916, 237232.0, 238268.0, 238435.0, 238525.0, 239816.0, 30346.393072138875, 49975.50024499781, 50255.74872125689, 50320.496795031584, 50356.244656330186, 30970.22574435612, 32647.510287345707, 32648.0, 32695.346093078006, 32769.18077048045, 12740.490380384681, 12863.29251891155, 12867.935660321826, 12895.419706113247, 12897.48410063587, 10605.84091238632, 10708.1433485321, 10709.357438553556, 10712.143028557697, 10714.46427678613, 7478.4765066444825, 7534.284242996907, 7564.0923089228545, 7585.810354741176, 7595.164531901486, 2997.415503976747, 3005.4289684959786, 3024.470717624451, 3036.271294889211, 3099.9380012399624, 779.4972242903409, 779.5361759752938, 782.7025730222479, 950.5104870991445, 951.5765484359532, 25435.0, 27712.168634940983, 27825.86087069592, 27987.860060699568, 28038.579421308696, 871.9520426376483, 878.2798105553512, 884.9867251991225, 946.4983558713755, 1011.600417834951, 14117.78823317651, 14626.195559244132, 14799.334029968677, 14934.850651493563, 14948.0, 356819.0, 362408.0, 363617.0, 363729.0, 363775.0, 48432.30486933011, 48957.510424896005, 48963.51036489661, 48972.510274897504, 49142.508574913794, 1041.578160844859, 1084.1164450972433, 1109.1237922041657, 1156.248438514972, 1174.3717111345388, 27006.594901076107, 28386.85806570954, 28867.56698649564, 29154.472436469787, 29479.705202947694, 41114.383284250165, 41852.162956741304, 41864.3720344189, 41866.8599855006, 41995.37006944959, 277614.0, 277800.0, 278360.3803581645, 278644.0, 280568.0, 20704.275350362666, 21707.0, 22365.66451503261, 24962.500749984534, 26430.603540947286, 39861.60138398695, 40780.65110382666, 41114.79442602768, 41406.585934140276, 41742.0, 34423.655763442046, 34498.31003379969, 35013.649863501036, 35253.823730882206, 35662.0, 33826.32347353089, 34712.0, 34771.478427824106, 34824.0, 35229.47155792614, 33620.0, 34206.65793342035, 34246.828765856015, 34360.65639343575, 35007.824960875034, 29913.551296730133, 31923.201919952186, 32228.516572250966, 32391.19022024374, 32448.83775581107, 24348.391290217885, 24523.509529808947, 24733.87633061823, 24874.0, 25183.24450266495], "value": 15915.202053735016, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [338.18461309597603, 359.7068389262752, 366.8294243176922, 367.86021311901476, 385.718425549349, 12051.0, 12978.480860765558, 14397.208153551564, 16222.918885405586, 16852.325906963706, 15506.14716190609, 15942.601434964132, 16076.758848617252, 16079.919600401981, 16242.675146497093, 4870.902581948359, 4910.140725373063, 4995.675281106716, 4998.200287953928, 5005.0, 3570.071781336845, 3775.0, 4896.657233993604, 5002.924956125661, 5006.098902197603, 5484.945150548503, 5750.884982300372, 5792.6524408535415, 5863.472287494124, 5887.970560147193, 5710.77156913723, 5854.795082172125, 5859.501942334907, 5908.054711246223, 5952.761889524414, 5230.137027390476, 5239.79040838366, 5243.344581927259, 5245.1869960155855, 5246.055709972242, 19486.80513194864, 20039.899800500905, 20260.898695506574, 20413.0, 20422.795772042387, 1781.3320004998125, 1907.7710674718983, 1956.5793354428865, 2143.5498545305504, 2347.859128452298, 12636.368181590975, 13075.150115242574, 13105.737885242337, 13335.466581336736, 13666.863331366758, 1701.2174399776118, 1704.9744253836202, 1718.682043821897, 1753.395078697847, 1769.40724857173, 64758.676206618664, 65335.34664653388, 67289.66355168192, 68190.65904670494, 68320.6583967082, 8620.026090998721, 8861.556922153995, 9027.548622568846, 9125.498097604695, 9198.492738558058, 12207.75584488323, 13201.273929933946, 13226.206427614374, 13261.403236854365, 13273.734525309439, 6718.395344418928, 6853.17761868579, 6938.375546200866, 6981.406580440719, 6997.825054373681, 6477.902831457532, 6504.284528701839, 6563.310852360529, 6759.763408280686, 6769.120014398097, 5721.485066344049, 5773.278340207474, 5830.067189249699, 5832.696085046383, 5908.675022873697, 1652.3308060235624, 1660.609756707173, 1677.9328826847034, 1684.1158391844135, 1702.9744553831702, 808.2806302390877, 825.5129473610599, 880.7181701855473, 894.6063731957918, 924.1543987251724, 16456.506304810635, 16667.416640417527, 16806.075665838252, 17147.142642867806, 17727.911360443373, 785.1951749456853, 797.6809276289531, 824.9546274954935, 845.2519520224646, 857.5969294431607, 9371.531423428802, 9846.29226962591, 9997.272028370933, 10009.949950250348, 10128.493575321205, 279687.0, 281726.0, 282367.0, 352265.0, 358316.0, 72505.6374718123, 76048.23951760412, 78753.0, 79538.0, 81622.0, 402.1554735056417, 424.73878564682497, 425.5042875050593, 427.2331165557769, 428.4087958617151, 9244.815103698023, 9871.950640246752, 9878.753031174278, 9962.252831037556, 10059.597616095274, 26775.732242678103, 35257.0, 35350.646493535765, 36309.0, 36892.63107368999, 47482.28776568423, 50564.49435505745, 51651.0, 52955.470445295054, 53999.46000539944, 7328.670209840463, 7429.777106686808, 7495.512791668524, 7657.770266892002, 7701.073592034991, 10079.0, 11725.765484690088, 11970.820437693268, 11975.682674905927, 12244.816327754912, 9620.518974051409, 9641.084097010773, 9717.80564388694, 10188.643397481053, 10873.347599144077, 8700.260477859452, 10048.346857454242, 10593.576256949944, 10643.94678026605, 10778.191635627203, 9748.512574371394, 10367.429791361246, 10372.377657340583, 10492.685219443429, 10550.323646399564, 7315.670794814139, 7417.703291868264, 7475.215102414386, 7488.625568721651, 7872.488288261245, 10138.188944884245, 10289.0, 10372.429516376369, 10794.244402891722, 10902.50938707776], "value": 7844.61300947594, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1206.1797977375381, 1325.8342707161605, 1330.6806366472047, 1365.3309878159698, 1633.2078941713266, 6410.358964103593, 6917.89623155653, 7205.243449437812, 7523.736669216579, 7536.133344665365, 7665.693372265103, 7722.459427840039, 7744.341730952876, 7746.302832745052, 7747.92252077479, 2001.0395010395018, 2008.9296874609317, 2011.9899400502977, 2017.3544465770958, 2023.8684485508468, 1949.3274820187012, 1992.9402117936486, 2000.3898810862681, 2006.8595198336122, 2017.2939471185114, 1973.437570292467, 1990.6615875301234, 1991.442396129086, 2000.5698774763423, 2003.3689387842783, 1963.7250784889984, 1963.980360196394, 1966.3314473079222, 1968.3110911181116, 1970.4679736471217, 1898.8670793044491, 1899.040984302932, 1904.0384605773995, 1928.7106933959878, 1936.0900376822872, 7507.249275072503, 7654.387648988068, 7662.0, 7672.46292759507, 7688.730894418724, 4044.2720310344125, 4170.791460426997, 4181.0592616661315, 4210.221109094828, 4211.684123690736, 2547.4777670577487, 2651.058874099686, 2677.477891811098, 2679.8124131310815, 2691.0984820085296, 821.5276216175663, 825.2613910550024, 841.4824882697159, 843.7679638099572, 847.229021590356, 10241.590336386536, 10387.220958428072, 10415.427151506665, 10494.895051049545, 10495.947520262502, 3568.7561732398244, 3703.2778608171147, 3843.5195600549932, 3851.4993050903204, 3907.5701672815967, 8150.144234855255, 8179.95910020458, 8232.753017409488, 8235.752927412188, 8243.876341854877, 4365.563443655673, 4367.868963931087, 4369.825206991684, 4370.672199585044, 4375.059362237134, 3492.89521314361, 3618.511500947391, 3828.9042773930873, 4087.6321131098343, 4090.570490098556, 3047.9085627431214, 3048.6951304869335, 3147.3075923296838, 3181.66592507788, 3198.296374797541, 946.8769060022291, 950.705281362766, 953.5184731710442, 955.5317894231915, 958.0371726414909, 615.3292910727239, 762.8398036412416, 775.4688038693513, 776.97669069928, 782.5930516131693, 5078.162103252996, 5091.465396133427, 5135.998480296306, 5188.610854185951, 5370.865728356823, 364.39146625136084, 367.937450633393, 372.2814967113497, 373.4864561228311, 376.149901223232, 3430.16008073296, 3520.1102781426666, 3627.818609069536, 3658.140337020798, 3658.158623516553, 8995.370324077383, 9307.674231401868, 9383.780108585841, 9387.953060234791, 9405.623775049058, 9274.95362523183, 9284.489353085644, 9287.0, 9291.396059256127, 9334.533273336307, 7053.964730176419, 7129.322714342129, 7131.92868071323, 7136.964315178391, 7144.499885007999, 4945.307656928105, 4973.378327709036, 4981.676191047571, 5103.464136265638, 5115.769790359517, 8532.914670853212, 8634.913650863662, 8638.17937295981, 8722.302215822592, 8738.91261087381, 8576.142385761623, 8616.310695144499, 8701.825963480822, 8743.300535956982, 8873.822523549621, 6145.569810113249, 6214.968925155526, 6215.098810672517, 6220.471259942956, 6222.28443728977, 6672.232693240339, 6853.314668533107, 6881.65591720402, 7049.400800931979, 7058.752943646948, 6229.595076320024, 6353.809385718251, 6377.0, 6383.1382763326355, 6526.543141980016, 6154.384561543989, 6181.84545386369, 6262.874742505215, 6316.968415157895, 6395.520335974914, 5888.411158884249, 6085.726142323518, 6145.262568491809, 6269.937300626935, 6273.96863015682, 4404.295312749945, 4555.362249285169, 4588.747618880993, 4659.0, 4751.218293140072, 4455.398521199597, 4492.438445194351, 4529.84145554904, 4611.077784443058, 4642.14314274293], "value": 3788.6322237355653, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [254.10428240452404, 258.61853765695594, 261.486179656974, 267.8781154574669, 272.2974725208961, 4718.386609740737, 4729.74661714645, 4763.833265835697, 4775.47469778325, 4810.206315957871, 4669.883252918678, 4687.437507499097, 4701.683528611994, 4709.788059537321, 4755.0, 3508.456189290664, 3587.3722098632766, 3614.5301110855553, 3669.3578623740873, 3673.8897833065053, 3673.3204357194004, 3682.1531047858875, 3693.9815300923456, 3701.907452313687, 3703.2223233121076, 3643.5627724673077, 3645.2891686121216, 3647.288778688157, 3651.1054791576103, 3676.7426280160266, 3481.617022127564, 3562.3257069177703, 3610.2418492116685, 3648.1609229877013, 3671.3391589513876, 3207.3264614430996, 3207.957413840488, 3215.565898603705, 3217.1635374802486, 3218.2598002459567, 4648.3259927310355, 4665.0, 4694.24892017279, 4695.567851805198, 4733.0, 3862.9613703862883, 4112.753234805921, 4173.874783756492, 4175.248455278049, 4176.853810116661, 4967.882226499045, 4968.950310496885, 4979.327790748239, 4985.576226020793, 4990.575801056914, 3417.0773891049525, 3431.0, 3438.948415773765, 3439.5356626855305, 3445.0, 5078.619103567247, 5288.048151332759, 5314.963582101492, 5327.706976116351, 5332.146856502941, 3492.738044646662, 3524.3303772283184, 3528.947065794015, 3531.841067151984, 3534.3991521440903, 3575.2123938030986, 3576.5350504434778, 3586.7130629549574, 3588.802615856153, 3596.956882504097, 4146.937795933063, 4155.376693495939, 4156.085661154541, 4158.688098392572, 4171.395147703566, 4750.334953106568, 4947.455779864212, 5054.671446355975, 5059.544640982329, 5067.619928505377, 1236.789745743226, 1258.5783762439685, 1259.7102666386781, 1260.8108783682521, 1263.4946021591254, 798.9760307190794, 810.7932477218271, 825.6706702209437, 830.6262182018116, 832.1470492744863, 4279.486461624625, 4405.885175115963, 4427.977860110679, 4551.385562949025, 4554.817807287738, 5255.580993131833, 5256.159014557652, 5264.394594621591, 5265.894162225975, 5269.0, 4531.592156705847, 4535.9773201133785, 4539.72761634303, 4552.613027892667, 4559.749213793273, 2635.8023148263956, 2747.8213916095788, 2759.365345970438, 2779.958300625492, 2796.2523422860713, 4980.879302157058, 4984.352034235526, 4991.351124353883, 4995.375578052744, 5033.874153146127, 5012.972340670154, 5338.332708411449, 5367.087595108841, 5377.139657654757, 5382.892342153135, 4907.779149938261, 4908.214685650279, 4911.9754401227765, 4929.827456039093, 5002.349694539686, 5130.692158470503, 5131.332926719502, 5146.941223510626, 5226.268322434787, 5231.189165679326, 4947.802087916443, 5098.311727916832, 5111.830664987583, 5118.206677964921, 5125.411122552021, 4935.629827763004, 4959.776810043484, 4976.353074100344, 4979.751012449436, 4986.301917731593, 3766.510353654117, 3770.3024940386117, 3786.6213378661914, 3799.4422286862255, 3800.771953682788, 5031.7735701894235, 5221.869453263699, 5245.842624721265, 5248.58011359098, 5250.159974404077, 5031.396232452129, 5037.672551284155, 5049.444561098203, 5049.677148511726, 5049.8737531562, 5011.173156429149, 5026.246063090565, 5095.87260318495, 5115.18157094863, 5128.58971282304, 4876.892302373334, 4900.632452566, 5010.947700982834, 5011.574016208663, 5038.571721403721, 4804.591609713214, 4907.312976183266, 4913.943502147055, 5068.214426763858, 5092.516210959953, 4867.829625963216, 4895.241237608034, 4914.508549145057, 4920.335754673073, 4940.802367905244], "value": 3751.203520822075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [581.2240658720608, 588.2617315269337, 657.7730682914392, 685.8971154326849, 699.3426179391369, 11716.355600441972, 12220.205686630374, 12309.876901230997, 12686.61940141795, 13816.101953373049, 13740.862591374083, 14363.210023448706, 14419.062760920559, 14474.276286185675, 14571.052881562691, 723.8660847743158, 741.3846507398873, 744.0996394362827, 744.5160645580389, 744.6723441685641, 595.4670569839991, 612.0788213738317, 718.7735863203101, 740.2930201657431, 747.6934456872656, 777.2965466253022, 779.3842864137325, 779.7582749347692, 780.0795061827042, 780.2158830375465, 773.7949443397504, 773.9264769846856, 774.3804956035177, 774.4927072767347, 774.5391492062214, 459.8827299038757, 466.8412739668529, 469.4859129253462, 471.1260611565531, 545.4463719324889, 12761.425735841816, 13217.14088584239, 13230.933845330808, 13241.0, 13254.0, 12160.209586376857, 12440.315782631951, 12620.747585048339, 12744.490220391173, 13278.66803329915, 11600.477978490904, 11613.0, 11703.824442633368, 11799.233049851731, 12252.509899604094, 4136.875893723193, 4158.792060396968, 4215.388768628532, 4255.5957184067465, 4333.06839029607, 64876.0, 64928.0, 67975.32024679739, 68029.9999999995, 68089.31910680929, 10076.345037572535, 10262.127719143808, 10299.0, 10553.472326383804, 10664.200184986157, 16855.325786968384, 16896.155192240338, 16913.661726765396, 16937.237824297936, 16947.0, 6526.347365263436, 6608.537402381787, 6703.597784132968, 6825.385715285648, 6909.1018167637885, 3495.8601655933476, 3531.7174626029855, 3590.084528445282, 3594.6045934947656, 3637.217998130415, 2688.5967104934416, 2771.528840097188, 2778.9305267368477, 2781.22125804775, 3050.100220434977, 512.6488355476511, 512.7205672908274, 514.9948500515022, 522.8091746512496, 523.9371275446971, 519.7946811009706, 541.2557733116964, 541.8103663717667, 547.1764993684479, 552.6545908806995, 7669.693212271447, 7703.513025432349, 8084.7574572762915, 8131.9186808132345, 8132.227438393344, 432.3860118631488, 529.1982646290872, 543.1011675676762, 543.74987505747, 545.498141709628, 3525.050080228029, 3772.245550889833, 3797.373433383461, 3846.942295865564, 4013.8795836124964, 101652.49173754084, 102319.0, 102723.48638256761, 104936.0, 106160.0, 85966.0, 86202.56898715592, 86386.0, 87288.0, 89338.10661893428, 44197.0, 50327.24509132366, 60872.0, 60985.69507152436, 79692.0, 7850.882236766567, 8242.29940455044, 8316.209960053786, 8404.705835295736, 8462.830743384975, 34499.0, 36294.27411451809, 40586.391204131374, 40714.59285407108, 43816.0, 56733.432665672815, 59438.40561594329, 62206.0669089955, 62258.688706556175, 63641.681791590745, 10809.891901080888, 10934.507947142556, 10977.560897564328, 11299.039581635325, 11452.198346116025, 12014.279143251433, 12023.879761202626, 12240.87759122433, 12310.446029928495, 12354.135210535176, 10727.356358618508, 11209.943950280196, 11556.826647600461, 11693.707657308296, 11739.706507337043, 10691.94654026756, 11362.772744544898, 11874.346910919983, 11922.880771192524, 11941.104417168921, 10748.140148787921, 11255.0, 11836.171467997157, 11886.821697674715, 11901.10741694359, 9059.864102038606, 9195.402298850553, 9408.0, 9517.143457088896, 9524.761880953032, 8169.632366543638, 8954.731358059269, 9649.614015439303, 9823.754406139618, 9849.901500984899], "value": 6375.505378004442, "unit": "score"}], "name": "dromaeo_css", "value": 6098.412446061104, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 116.0, 116.0, 118.0, 116.0, 116.0, 116.0, 119.0, 115.0, 114.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 128.0, 167.0, 126.0, 124.0, 122.0, 123.0, 177.0, 126.0], "value": 137.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 163.0, 162.0, 161.0, 163.0, 161.0, 162.0, 163.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 75.0, 104.0, 77.0, 76.0, 77.0, 77.0, 102.0, 76.0], "value": 81.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 108.0, 84.0, 84.0, 84.0, 106.0, 84.0, 83.0, 116.0], "value": 91.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 148.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 148.0, 145.0], "value": 146.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 62.0, 62.0, 62.0, 65.0, 64.0, 65.0, 66.0, 64.0, 64.0], "value": 63.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 67.0, 67.0, 66.0, 67.0], "value": 66.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 88.0, 85.0, 93.0, 86.0, 91.0, 82.0, 82.0, 82.0, 81.0], "value": 85.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 131.0, 133.0, 133.0, 132.0, 139.0, 132.0, 139.0, 170.0, 134.0], "value": 138.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [175.0, 176.0, 176.0, 177.0, 173.0, 174.0, 173.0, 175.0, 175.0, 175.0], "value": 174.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 71.0, 71.0, 72.0, 73.0, 70.0, 71.0, 72.0, 70.0, 70.0], "value": 71.0, "unit": "score"}], "name": "kraken", "value": 1546.9, "alertThreshold": 2.0}]} 09:02:56 INFO - Return code: 0 09:02:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:02:57 INFO - # TBPL SUCCESS # 09:02:57 INFO - Running post-action listener: _resource_record_post_action 09:02:57 INFO - [mozharness: 2016-09-22 16:02:57.013541Z] Finished run-tests step (success) 09:02:57 INFO - Running post-run listener: _resource_record_post_run 09:02:57 INFO - Total resource usage - Wall time: 1206s; CPU: 13.0%; Read bytes: 0; Write bytes: 404705280; Read time: 0; Write time: 419988 09:02:57 INFO - TinderboxPrint: CPU usage
13.0% 09:02:57 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:02:57 INFO - TinderboxPrint: I/O write bytes / time
404,705,280 / 419,988 09:02:57 INFO - TinderboxPrint: CPU idle
8,367.2 (86.9%) 09:02:57 INFO - TinderboxPrint: CPU user
1,202.9 (12.5%) 09:02:57 INFO - TinderboxPrint: Swap in / out
0 / 0 09:02:57 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 99860480; Read time: 0; Write time: 166060 09:02:57 INFO - run-tests - Wall time: 1190s; CPU: 13.0%; Read bytes: 0; Write bytes: 288825344; Read time: 0; Write time: 249380 09:02:57 INFO - Running post-run listener: _upload_blobber_files 09:02:57 INFO - Blob upload gear active. 09:02:57 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:02:57 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 09:02:57 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:02:57 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:02:58 INFO - (blobuploader) - INFO - Open directory for files ... 09:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:02:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:58 INFO - (blobuploader) - INFO - Done attempting. 09:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:02:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:02:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:02:59 INFO - (blobuploader) - INFO - Done attempting. 09:02:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:02:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:02:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:03:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:03:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:03:05 INFO - (blobuploader) - INFO - Done attempting. 09:03:05 INFO - (blobuploader) - INFO - Iteration through files over. 09:03:05 INFO - Return code: 0 09:03:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:03:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:03:05 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/039c93bf00e5a475096edccc6004b7ef3df9ed02514e0d2a86b465dae0befefbbb443c5fff37dd4f696c130bb0377ae572cf6d68d7d3b35190c3c9b4ac27b739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f4a8facd4999345b06c30776d773e915f41ad36cb0876aa61062a271e285c75efd2338de5b279ab63760ebcec67b6a4cef26734d81a7d7ead59732940cb9e3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d87b8cc545eddcf705fada0f58ee2fc503f4720b2706937d951546e490054dae85f61e1ea40fc1917b82dacd6e95eb8c3e788f13ebd63d0658e14df03ffea11c"} 09:03:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:03:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:03:05 INFO - Contents: 09:03:05 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/039c93bf00e5a475096edccc6004b7ef3df9ed02514e0d2a86b465dae0befefbbb443c5fff37dd4f696c130bb0377ae572cf6d68d7d3b35190c3c9b4ac27b739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f4a8facd4999345b06c30776d773e915f41ad36cb0876aa61062a271e285c75efd2338de5b279ab63760ebcec67b6a4cef26734d81a7d7ead59732940cb9e3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d87b8cc545eddcf705fada0f58ee2fc503f4720b2706937d951546e490054dae85f61e1ea40fc1917b82dacd6e95eb8c3e788f13ebd63d0658e14df03ffea11c"} 09:03:05 INFO - Running post-run listener: copy_logs_to_upload_dir 09:03:05 INFO - Copying logs to upload dir... 09:03:05 INFO - mkdir: /builds/slave/test/build/upload/logs 09:03:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1253.892600 ========= master_lag: 105.91 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 39 secs) (at 2016-09-22 09:04:50.879484) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 09:04:50.883261) ========= 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=5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/039c93bf00e5a475096edccc6004b7ef3df9ed02514e0d2a86b465dae0befefbbb443c5fff37dd4f696c130bb0377ae572cf6d68d7d3b35190c3c9b4ac27b739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f4a8facd4999345b06c30776d773e915f41ad36cb0876aa61062a271e285c75efd2338de5b279ab63760ebcec67b6a4cef26734d81a7d7ead59732940cb9e3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d87b8cc545eddcf705fada0f58ee2fc503f4720b2706937d951546e490054dae85f61e1ea40fc1917b82dacd6e95eb8c3e788f13ebd63d0658e14df03ffea11c"} build_url:https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011418 build_url: 'https://queue.taskcluster.net/v1/task/YGNCZLgQRDa9aV1ypXcOHg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/039c93bf00e5a475096edccc6004b7ef3df9ed02514e0d2a86b465dae0befefbbb443c5fff37dd4f696c130bb0377ae572cf6d68d7d3b35190c3c9b4ac27b739", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/9f4a8facd4999345b06c30776d773e915f41ad36cb0876aa61062a271e285c75efd2338de5b279ab63760ebcec67b6a4cef26734d81a7d7ead59732940cb9e3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/d87b8cc545eddcf705fada0f58ee2fc503f4720b2706937d951546e490054dae85f61e1ea40fc1917b82dacd6e95eb8c3e788f13ebd63d0658e14df03ffea11c"}' ========= master_lag: 0.19 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-22 09:04:51.086112) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:04:51.086685) ========= 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=5cf47e208febbcd81da23b2e0000026f-1474558791.749521-39997864 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004492 ========= master_lag: 0.29 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-22 09:04:51.384004) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 09:04:51.384381) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-22 09:04:51.388748) ========= ========= Total master_lag: 106.46 =========