builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-007 starttime: 1474384145.61 results: success (0) buildid: 20160920033006 builduid: a5599cf195674b56a88a9123e36a5f6e revision: 14705f779a46da3dbbc41af098209911479cff01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:05.607910) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:05.608367) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:05.608665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:05.623463) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:05.623777) ========= 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=923d835db2ba3686ebe126b700000192-1474384144.980981-851266606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-20 08:09:05-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.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% 35.9M=0s 2016-09-20 08:09:05 (35.9 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.070954 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:05.710798) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:05.711330) ========= 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=923d835db2ba3686ebe126b700000192-1474384144.980981-851266606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017786 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:05.761712) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-20 08:09:05.762071) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 14705f779a46da3dbbc41af098209911479cff01 --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 14705f779a46da3dbbc41af098209911479cff01 --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=923d835db2ba3686ebe126b700000192-1474384144.980981-851266606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-20 08:09:05,858 truncating revision to first 12 chars 2016-09-20 08:09:05,858 Setting DEBUG logging. 2016-09-20 08:09:05,858 attempt 1/10 2016-09-20 08:09:05,858 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/14705f779a46?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-20 08:09:06,591 unpacking tar archive at: fx-team-14705f779a46/testing/mozharness/ program finished with exit code 0 elapsedTime=1.062251 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-09-20 08:09:06.838107) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:06.838480) ========= script_repo_revision: 14705f779a46da3dbbc41af098209911479cff01 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:06.838956) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:06.839249) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-20 08:09:06.849385) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-09-20 08:09:06.850134) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] 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=923d835db2ba3686ebe126b700000192-1474384144.980981-851266606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:09:07 INFO - MultiFileLogger online at 20160920 08:09:07 in /builds/slave/test 08:09:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 08:09:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:09:07 INFO - {'append_to_log': False, 08:09:07 INFO - 'base_work_dir': '/builds/slave/test', 08:09:07 INFO - 'blob_upload_branch': 'Fx-Team', 08:09:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:09:07 INFO - 'branch': 'Fx-Team', 08:09:07 INFO - 'buildbot_json_path': 'buildprops.json', 08:09:07 INFO - 'config_files': ('talos/linux_config.py',), 08:09:07 INFO - 'default_actions': ('clobber', 08:09:07 INFO - 'read-buildbot-config', 08:09:07 INFO - 'download-and-extract', 08:09:07 INFO - 'populate-webroot', 08:09:07 INFO - 'create-virtualenv', 08:09:07 INFO - 'install', 08:09:07 INFO - 'run-tests'), 08:09:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:09:07 INFO - 'download_minidump_stackwalk': True, 08:09:07 INFO - 'download_symbols': 'ondemand', 08:09:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:09:07 INFO - 'tooltool.py': '/tools/tooltool.py', 08:09:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:09:07 INFO - '/tools/misc-python/virtualenv.py')}, 08:09:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:09:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:09:07 INFO - 'installer_path': 'installer.exe', 08:09:07 INFO - 'log_level': 'info', 08:09:07 INFO - 'log_name': 'talos', 08:09:07 INFO - 'log_to_console': True, 08:09:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:09:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:09:07 INFO - 'opt_config_files': (), 08:09:07 INFO - 'pip_index': False, 08:09:07 INFO - 'sps_profile': False, 08:09:07 INFO - 'sps_profile_interval': 0, 08:09:07 INFO - 'suite': 'dromaeojs-e10s', 08:09:07 INFO - 'system_bits': '32', 08:09:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:09:07 INFO - 'title': 'talos-linux64-ix-007', 08:09:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:09:07 INFO - 'use_talos_json': True, 08:09:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:09:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:09:07 INFO - 'work_dir': 'build'} 08:09:07 INFO - [mozharness: 2016-09-20 15:09:07.046887Z] Running clobber step. 08:09:07 INFO - Running pre-action listener: _resource_record_pre_action 08:09:07 INFO - Running main action method: clobber 08:09:07 INFO - rmtree: /builds/slave/test/build 08:09:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:09:08 INFO - Running post-action listener: _resource_record_post_action 08:09:08 INFO - [mozharness: 2016-09-20 15:09:08.017429Z] Finished clobber step (success) 08:09:08 INFO - [mozharness: 2016-09-20 15:09:08.017530Z] Running read-buildbot-config step. 08:09:08 INFO - Running pre-action listener: _resource_record_pre_action 08:09:08 INFO - Running main action method: read_buildbot_config 08:09:08 INFO - Using buildbot properties: 08:09:08 INFO - { 08:09:08 INFO - "project": "", 08:09:08 INFO - "product": "firefox", 08:09:08 INFO - "script_repo_revision": "production", 08:09:08 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 08:09:08 INFO - "repository": "", 08:09:08 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 08:09:08 INFO - "buildid": "20160920033006", 08:09:08 INFO - "pgo_build": "True", 08:09:08 INFO - "basedir": "/builds/slave/test", 08:09:08 INFO - "buildnumber": 1184, 08:09:08 INFO - "slavename": "talos-linux64-ix-007", 08:09:08 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 08:09:08 INFO - "platform": "ubuntu64_hw", 08:09:08 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 08:09:08 INFO - "branch": "fx-team", 08:09:08 INFO - "repo_path": "integration/fx-team", 08:09:08 INFO - "revision": "14705f779a46da3dbbc41af098209911479cff01", 08:09:08 INFO - "stage_platform": "linux64-pgo", 08:09:08 INFO - "builduid": "a5599cf195674b56a88a9123e36a5f6e", 08:09:08 INFO - "slavebuilddir": "test" 08:09:08 INFO - } 08:09:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 08:09:08 INFO - Running post-action listener: _resource_record_post_action 08:09:08 INFO - [mozharness: 2016-09-20 15:09:08.019970Z] Finished read-buildbot-config step (success) 08:09:08 INFO - [mozharness: 2016-09-20 15:09:08.020060Z] Running download-and-extract step. 08:09:08 INFO - Running pre-action listener: _resource_record_pre_action 08:09:08 INFO - Running main action method: download_and_extract 08:09:08 INFO - mkdir: /builds/slave/test/build/tests 08:09:08 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:09:08 INFO - trying https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:09:08 INFO - Downloading https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/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:09:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/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:09:08 INFO - Downloaded 1361 bytes. 08:09:08 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 08:09:08 INFO - Using the following test package requirements: 08:09:08 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:08 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:09:08 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:09:08 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:08 INFO - u'jsshell-linux-x86_64.zip'], 08:09:08 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:09:08 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 08:09:08 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:09:08 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:09:08 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:09:08 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 08:09:08 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:09:08 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:09:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:09:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:09:08 INFO - Fetch https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:09:09 INFO - Expected file size: 21941042 08:09:13 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:09:13 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 08:09:13 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 08:09:13 INFO - Fetch https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 08:09:14 INFO - Expected file size: 21941042 08:09:18 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 08:09:18 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 08:09:18 INFO - Fetch https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 08:09:19 INFO - Expected file size: 14414059 08:09:19 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:09:19 INFO - trying https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:09:19 INFO - Downloading https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/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:09:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/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:09:21 INFO - Downloaded 59557485 bytes. 08:09:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:09:21 INFO - mkdir: /builds/slave/test/properties 08:09:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:09:21 INFO - Writing to file /builds/slave/test/properties/build_url 08:09:21 INFO - Contents: 08:09:21 INFO - build_url:https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 08:09:21 INFO - Running post-action listener: _resource_record_post_action 08:09:21 INFO - Running post-action listener: set_extra_try_arguments 08:09:21 INFO - [mozharness: 2016-09-20 15:09:21.701107Z] Finished download-and-extract step (success) 08:09:21 INFO - [mozharness: 2016-09-20 15:09:21.701335Z] Running populate-webroot step. 08:09:21 INFO - Running pre-action listener: _resource_record_pre_action 08:09:21 INFO - Running main action method: populate_webroot 08:09:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:09:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:09:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:09:21 INFO - '--tppagecycles', 08:09:21 INFO - '7'], 08:09:21 INFO - 'tests': ['tsvgm']}}, 08:09:21 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:09:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:09:21 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:09:21 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:09:21 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:09:21 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:09:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:21 INFO - 'talos_options': ['--disable-e10s'], 08:09:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:09:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:21 INFO - 'talos_options': ['--disable-e10s'], 08:09:21 INFO - 'tests': ['damp', 'tps']}, 08:09:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:21 INFO - 'tests': ['damp', 'tps']}, 08:09:21 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:09:21 INFO - 'tests': ['dromaeo_dom']}, 08:09:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:09:21 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:09:21 INFO - 'tests': ['basic_compositor_video']}, 08:09:21 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:09:21 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:09:21 INFO - 'tests': ['a11yr', 08:09:21 INFO - 'ts_paint', 08:09:21 INFO - 'tpaint', 08:09:21 INFO - 'sessionrestore', 08:09:21 INFO - 'sessionrestore_no_auto_restore', 08:09:21 INFO - 'tabpaint']}, 08:09:21 INFO - 'other-e10s': {'tests': ['a11yr', 08:09:21 INFO - 'ts_paint', 08:09:21 INFO - 'tpaint', 08:09:21 INFO - 'sessionrestore', 08:09:21 INFO - 'sessionrestore_no_auto_restore', 08:09:21 INFO - 'tabpaint']}, 08:09:21 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:09:21 INFO - 'ts_paint', 08:09:21 INFO - 'tpaint', 08:09:21 INFO - 'sessionrestore', 08:09:21 INFO - 'sessionrestore_no_auto_restore', 08:09:21 INFO - 'tabpaint']}, 08:09:21 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:09:21 INFO - 'ts_paint', 08:09:21 INFO - 'tpaint', 08:09:21 INFO - 'sessionrestore', 08:09:21 INFO - 'sessionrestore_no_auto_restore', 08:09:21 INFO - 'tabpaint']}, 08:09:21 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:09:21 INFO - 'tests': ['a11yr', 08:09:21 INFO - 'ts_paint', 08:09:21 INFO - 'tpaint', 08:09:21 INFO - 'sessionrestore', 08:09:21 INFO - 'sessionrestore_no_auto_restore', 08:09:21 INFO - 'tabpaint']}, 08:09:21 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:09:21 INFO - 'tests': ['a11yr', 08:09:21 INFO - 'ts_paint', 08:09:21 INFO - 'tpaint', 08:09:21 INFO - 'sessionrestore', 08:09:21 INFO - 'sessionrestore_no_auto_restore', 08:09:21 INFO - 'tabpaint']}, 08:09:21 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:09:21 INFO - 'tests': ['tsvgx', 08:09:21 INFO - 'tsvgr_opacity', 08:09:21 INFO - 'tart', 08:09:21 INFO - 'tscrollx', 08:09:21 INFO - 'cart']}, 08:09:21 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:09:21 INFO - 'tsvgr_opacity', 08:09:21 INFO - 'tart', 08:09:21 INFO - 'tscrollx', 08:09:21 INFO - 'cart']}, 08:09:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:21 INFO - 'talos_options': ['--disable-e10s'], 08:09:21 INFO - 'tests': ['tp5o']}, 08:09:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:21 INFO - 'tests': ['tp5o']}, 08:09:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:21 INFO - 'talos_options': ['--disable-e10s', 08:09:21 INFO - '--xperf_path', 08:09:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:21 INFO - 'tests': ['tp5n']}, 08:09:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:09:21 INFO - 'talos_options': ['--xperf_path', 08:09:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:09:21 INFO - 'tests': ['tp5n']}}, 08:09:21 INFO - 'talos.zip': {'path': '', 08:09:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:09:21 INFO - Running post-action listener: _resource_record_post_action 08:09:21 INFO - [mozharness: 2016-09-20 15:09:21.719919Z] Finished populate-webroot step (success) 08:09:21 INFO - [mozharness: 2016-09-20 15:09:21.720009Z] Running create-virtualenv step. 08:09:21 INFO - Running pre-action listener: _resource_record_pre_action 08:09:21 INFO - Running main action method: create_virtualenv 08:09:21 INFO - Creating virtualenv /builds/slave/test/build/venv 08:09:21 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:09:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:09:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:09:21 INFO - Using real prefix '/usr' 08:09:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:09:22 INFO - Installing distribute.............................................................................................................................................................................................done. 08:09:24 INFO - Installing pip.................done. 08:09:24 INFO - Return code: 0 08:09:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:09:24 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:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 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:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 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 0x7f707d967f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28930>, '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 0x2b29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29cc0>, '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': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', '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:09:24 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:09:24 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:09:24 INFO - Using env: {'DISPLAY': ':0', 08:09:24 INFO - 'HOME': '/home/cltbld', 08:09:24 INFO - 'LANG': 'en_US.UTF-8', 08:09:24 INFO - 'LANGUAGE': 'en_US:en', 08:09:24 INFO - 'LOGNAME': 'cltbld', 08:09:24 INFO - 'MAIL': '/var/mail/cltbld', 08:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:24 INFO - 'MOZ_NO_REMOTE': '1', 08:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:24 INFO - 'NO_EM_RESTART': '1', 08:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:24 INFO - 'PWD': '/builds/slave/test', 08:09:24 INFO - 'SHELL': '/bin/bash', 08:09:24 INFO - 'SHLVL': '1', 08:09:24 INFO - 'TERM': 'linux', 08:09:24 INFO - 'TMOUT': '86400', 08:09:24 INFO - 'USER': 'cltbld', 08:09:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', 08:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:24 INFO - '_': '/tools/buildbot/bin/python'} 08:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:24 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:09:24 INFO - Cleaning up... 08:09:24 INFO - Return code: 0 08:09:24 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:09:24 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:09:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 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:09:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:24 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 0x7f707d967f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28930>, '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 0x2b29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29cc0>, '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': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', '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:09:24 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:09:24 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:09:24 INFO - Using env: {'DISPLAY': ':0', 08:09:24 INFO - 'HOME': '/home/cltbld', 08:09:24 INFO - 'LANG': 'en_US.UTF-8', 08:09:24 INFO - 'LANGUAGE': 'en_US:en', 08:09:24 INFO - 'LOGNAME': 'cltbld', 08:09:24 INFO - 'MAIL': '/var/mail/cltbld', 08:09:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:24 INFO - 'MOZ_NO_REMOTE': '1', 08:09:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:24 INFO - 'NO_EM_RESTART': '1', 08:09:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:24 INFO - 'PWD': '/builds/slave/test', 08:09:24 INFO - 'SHELL': '/bin/bash', 08:09:24 INFO - 'SHLVL': '1', 08:09:24 INFO - 'TERM': 'linux', 08:09:24 INFO - 'TMOUT': '86400', 08:09:24 INFO - 'USER': 'cltbld', 08:09:24 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', 08:09:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:24 INFO - '_': '/tools/buildbot/bin/python'} 08:09:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:24 INFO - Downloading/unpacking psutil>=3.1.1 08:09:24 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:09:24 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:09:24 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:09:24 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:09:24 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:09:24 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:09:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:09:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:26 INFO - Installing collected packages: psutil 08:09:26 INFO - Running setup.py install for psutil 08:09:26 INFO - building 'psutil._psutil_linux' extension 08:09:26 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:09:26 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 08:09:27 INFO - building 'psutil._psutil_posix' extension 08:09:27 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:09:27 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:09:27 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:09:27 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:09:27 INFO - Successfully installed psutil 08:09:27 INFO - Cleaning up... 08:09:27 INFO - Return code: 0 08:09:27 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:09:27 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:09:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:27 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:09:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:27 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 0x7f707d967f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28930>, '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 0x2b29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29cc0>, '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': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', '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:09:27 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:09:27 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:09:27 INFO - Using env: {'DISPLAY': ':0', 08:09:27 INFO - 'HOME': '/home/cltbld', 08:09:27 INFO - 'LANG': 'en_US.UTF-8', 08:09:27 INFO - 'LANGUAGE': 'en_US:en', 08:09:27 INFO - 'LOGNAME': 'cltbld', 08:09:27 INFO - 'MAIL': '/var/mail/cltbld', 08:09:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:27 INFO - 'MOZ_NO_REMOTE': '1', 08:09:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:27 INFO - 'NO_EM_RESTART': '1', 08:09:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:27 INFO - 'PWD': '/builds/slave/test', 08:09:27 INFO - 'SHELL': '/bin/bash', 08:09:27 INFO - 'SHLVL': '1', 08:09:27 INFO - 'TERM': 'linux', 08:09:27 INFO - 'TMOUT': '86400', 08:09:27 INFO - 'USER': 'cltbld', 08:09:27 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', 08:09:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:27 INFO - '_': '/tools/buildbot/bin/python'} 08:09:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:27 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:27 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:09:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:09:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:09:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:09:29 INFO - Installing collected packages: mozsystemmonitor 08:09:29 INFO - Running setup.py install for mozsystemmonitor 08:09:29 INFO - Successfully installed mozsystemmonitor 08:09:29 INFO - Cleaning up... 08:09:29 INFO - Return code: 0 08:09:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:09:29 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:09:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:29 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:09:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:29 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 0x7f707d967f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28930>, '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 0x2b29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29cc0>, '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': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', '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:09:29 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:09:29 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:09:29 INFO - Using env: {'DISPLAY': ':0', 08:09:29 INFO - 'HOME': '/home/cltbld', 08:09:29 INFO - 'LANG': 'en_US.UTF-8', 08:09:29 INFO - 'LANGUAGE': 'en_US:en', 08:09:29 INFO - 'LOGNAME': 'cltbld', 08:09:29 INFO - 'MAIL': '/var/mail/cltbld', 08:09:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:29 INFO - 'MOZ_NO_REMOTE': '1', 08:09:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:29 INFO - 'NO_EM_RESTART': '1', 08:09:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:29 INFO - 'PWD': '/builds/slave/test', 08:09:29 INFO - 'SHELL': '/bin/bash', 08:09:29 INFO - 'SHLVL': '1', 08:09:29 INFO - 'TERM': 'linux', 08:09:29 INFO - 'TMOUT': '86400', 08:09:29 INFO - 'USER': 'cltbld', 08:09:29 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', 08:09:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:29 INFO - '_': '/tools/buildbot/bin/python'} 08:09:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:29 INFO - Downloading/unpacking jsonschema==2.5.1 08:09:29 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:09:29 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:09:29 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:09:29 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:09:29 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:09:29 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:09:31 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:09:31 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:09: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:09: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:09: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:09: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:09: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:09: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:09:31 INFO - Downloading functools32-3.2.3-2.tar.gz 08:09:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:09:31 INFO - warning: no files found matching '*.txt' 08:09:31 INFO - no previously-included directories found matching 'build' 08:09:31 INFO - no previously-included directories found matching 'dist' 08:09:31 INFO - no previously-included directories found matching '.git*' 08:09:31 INFO - Installing collected packages: jsonschema, functools32 08:09:32 INFO - Running setup.py install for functools32 08:09:32 INFO - warning: no files found matching '*.txt' 08:09:32 INFO - no previously-included directories found matching 'build' 08:09:32 INFO - no previously-included directories found matching 'dist' 08:09:32 INFO - no previously-included directories found matching '.git*' 08:09:32 INFO - Successfully installed jsonschema functools32 08:09:32 INFO - Cleaning up... 08:09:32 INFO - Return code: 0 08:09:32 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 08:09:32 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:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:32 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:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:32 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 0x7f707d967f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28930>, '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 0x2b29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29cc0>, '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': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', '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:09:32 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:09:32 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:09:32 INFO - Using env: {'DISPLAY': ':0', 08:09:32 INFO - 'HOME': '/home/cltbld', 08:09:32 INFO - 'LANG': 'en_US.UTF-8', 08:09:32 INFO - 'LANGUAGE': 'en_US:en', 08:09:32 INFO - 'LOGNAME': 'cltbld', 08:09:32 INFO - 'MAIL': '/var/mail/cltbld', 08:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:32 INFO - 'MOZ_NO_REMOTE': '1', 08:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:32 INFO - 'NO_EM_RESTART': '1', 08:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:32 INFO - 'PWD': '/builds/slave/test', 08:09:32 INFO - 'SHELL': '/bin/bash', 08:09:32 INFO - 'SHLVL': '1', 08:09:32 INFO - 'TERM': 'linux', 08:09:32 INFO - 'TMOUT': '86400', 08:09:32 INFO - 'USER': 'cltbld', 08:09:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', 08:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:32 INFO - '_': '/tools/buildbot/bin/python'} 08:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:32 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 08:09:32 INFO - Cleaning up... 08:09:32 INFO - Return code: 0 08:09:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:09:32 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:09:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:32 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:09:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:32 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 0x7f707d967f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28930>, '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 0x2b29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29cc0>, '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': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', '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:09:32 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:09:32 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:09:32 INFO - Using env: {'DISPLAY': ':0', 08:09:32 INFO - 'HOME': '/home/cltbld', 08:09:32 INFO - 'LANG': 'en_US.UTF-8', 08:09:32 INFO - 'LANGUAGE': 'en_US:en', 08:09:32 INFO - 'LOGNAME': 'cltbld', 08:09:32 INFO - 'MAIL': '/var/mail/cltbld', 08:09:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:32 INFO - 'MOZ_NO_REMOTE': '1', 08:09:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:32 INFO - 'NO_EM_RESTART': '1', 08:09:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:32 INFO - 'PWD': '/builds/slave/test', 08:09:32 INFO - 'SHELL': '/bin/bash', 08:09:32 INFO - 'SHLVL': '1', 08:09:32 INFO - 'TERM': 'linux', 08:09:32 INFO - 'TMOUT': '86400', 08:09:32 INFO - 'USER': 'cltbld', 08:09:32 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', 08:09:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:32 INFO - '_': '/tools/buildbot/bin/python'} 08:09:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:32 INFO - Downloading/unpacking blobuploader==1.2.4 08:09:32 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:09:32 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:09:32 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:09:32 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:09:32 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:09:32 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:09:34 INFO - Downloading blobuploader-1.2.4.tar.gz 08:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:09:34 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:09: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:09: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:09: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:09: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:09: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:09: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:09:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:09:34 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:09: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:09: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:09: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:09: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:09: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:09: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:09:35 INFO - Downloading docopt-0.6.1.tar.gz 08:09:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:09:35 INFO - Installing collected packages: blobuploader, requests, docopt 08:09:35 INFO - Running setup.py install for blobuploader 08:09:35 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:09:35 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:09:35 INFO - Running setup.py install for requests 08:09:35 INFO - Running setup.py install for docopt 08:09:35 INFO - Successfully installed blobuploader requests docopt 08:09:35 INFO - Cleaning up... 08:09:35 INFO - Return code: 0 08:09:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:35 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:09:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:35 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:09:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:35 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 0x7f707d967f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28930>, '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 0x2b29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29cc0>, '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': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', '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:09:35 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:09:35 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:09:35 INFO - Using env: {'DISPLAY': ':0', 08:09:35 INFO - 'HOME': '/home/cltbld', 08:09:35 INFO - 'LANG': 'en_US.UTF-8', 08:09:35 INFO - 'LANGUAGE': 'en_US:en', 08:09:35 INFO - 'LOGNAME': 'cltbld', 08:09:35 INFO - 'MAIL': '/var/mail/cltbld', 08:09:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:35 INFO - 'MOZ_NO_REMOTE': '1', 08:09:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:35 INFO - 'NO_EM_RESTART': '1', 08:09:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:35 INFO - 'PWD': '/builds/slave/test', 08:09:35 INFO - 'SHELL': '/bin/bash', 08:09:35 INFO - 'SHLVL': '1', 08:09:35 INFO - 'TERM': 'linux', 08:09:35 INFO - 'TMOUT': '86400', 08:09:35 INFO - 'USER': 'cltbld', 08:09:35 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', 08:09:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:35 INFO - '_': '/tools/buildbot/bin/python'} 08:09:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:36 INFO - Running setup.py (path:/tmp/pip-T2wico-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:36 INFO - Running setup.py (path:/tmp/pip-tmrsta-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:36 INFO - Running setup.py (path:/tmp/pip-2bVa_B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:36 INFO - Running setup.py (path:/tmp/pip-6hcw9v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:36 INFO - Running setup.py (path:/tmp/pip-Osst4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:36 INFO - Running setup.py (path:/tmp/pip-DeSqUl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:36 INFO - Running setup.py (path:/tmp/pip-kugKWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:36 INFO - Running setup.py (path:/tmp/pip-rFuz3C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:36 INFO - Running setup.py (path:/tmp/pip-S41fZU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:36 INFO - Running setup.py (path:/tmp/pip-wgbAY4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:36 INFO - Running setup.py (path:/tmp/pip-GjJpI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:36 INFO - Running setup.py (path:/tmp/pip-OSi84V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:36 INFO - Running setup.py (path:/tmp/pip-eNb9SV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:36 INFO - Running setup.py (path:/tmp/pip-pwJPqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:37 INFO - Running setup.py (path:/tmp/pip-DEB_5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:37 INFO - Running setup.py (path:/tmp/pip-0r4QLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:37 INFO - Running setup.py (path:/tmp/pip-f6l6WV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:37 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:09:37 INFO - Running setup.py install for manifestparser 08:09:37 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Running setup.py install for mozcrash 08:09:37 INFO - Running setup.py install for mozdebug 08:09:37 INFO - Running setup.py install for mozdevice 08:09:37 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Running setup.py install for mozfile 08:09:37 INFO - Running setup.py install for mozhttpd 08:09:37 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Running setup.py install for mozinfo 08:09:37 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:09:37 INFO - Running setup.py install for mozInstall 08:09:38 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Running setup.py install for mozleak 08:09:38 INFO - Running setup.py install for mozlog 08:09:38 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Running setup.py install for moznetwork 08:09:38 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Running setup.py install for mozprocess 08:09:38 INFO - Running setup.py install for mozprofile 08:09:38 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Running setup.py install for mozrunner 08:09:38 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:09:38 INFO - Running setup.py install for mozscreenshot 08:09:38 INFO - Running setup.py install for moztest 08:09:38 INFO - Running setup.py install for mozversion 08:09:39 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:09:39 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:09:39 INFO - Cleaning up... 08:09:39 INFO - Return code: 0 08:09:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09: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:09:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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:09:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:39 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 0x7f707d967f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28930>, '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 0x2b29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29cc0>, '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': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', '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:09:39 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:09:39 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:09:39 INFO - Using env: {'DISPLAY': ':0', 08:09:39 INFO - 'HOME': '/home/cltbld', 08:09:39 INFO - 'LANG': 'en_US.UTF-8', 08:09:39 INFO - 'LANGUAGE': 'en_US:en', 08:09:39 INFO - 'LOGNAME': 'cltbld', 08:09:39 INFO - 'MAIL': '/var/mail/cltbld', 08:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:39 INFO - 'MOZ_NO_REMOTE': '1', 08:09:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:39 INFO - 'NO_EM_RESTART': '1', 08:09:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:39 INFO - 'PWD': '/builds/slave/test', 08:09:39 INFO - 'SHELL': '/bin/bash', 08:09:39 INFO - 'SHLVL': '1', 08:09:39 INFO - 'TERM': 'linux', 08:09:39 INFO - 'TMOUT': '86400', 08:09:39 INFO - 'USER': 'cltbld', 08:09:39 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', 08:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:39 INFO - '_': '/tools/buildbot/bin/python'} 08:09:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:09:39 INFO - Running setup.py (path:/tmp/pip-FxmOFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:09:39 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:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:09:39 INFO - Running setup.py (path:/tmp/pip-JnqqIB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:09:39 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:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:09:39 INFO - Running setup.py (path:/tmp/pip-bgkWOA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:09:39 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:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:09:39 INFO - Running setup.py (path:/tmp/pip-MC6dxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:09:39 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:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:09:39 INFO - Running setup.py (path:/tmp/pip-clZuqj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:09:39 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:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:09:39 INFO - Running setup.py (path:/tmp/pip-Q85Z0W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:09:39 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:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:09:39 INFO - Running setup.py (path:/tmp/pip-3WNagM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:09:39 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:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:09:39 INFO - Running setup.py (path:/tmp/pip-CCMdja-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:09:39 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:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:09:39 INFO - Running setup.py (path:/tmp/pip-z8uYuz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:09:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 08:09:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:09:39 INFO - Running setup.py (path:/tmp/pip-9gXlR_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:09:40 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:09:40 INFO - Running setup.py (path:/tmp/pip-Xk9V_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:09:40 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:09:40 INFO - Running setup.py (path:/tmp/pip-jWmdV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:09:40 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:09:40 INFO - Running setup.py (path:/tmp/pip-XCvoh5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:09:40 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:09:40 INFO - Running setup.py (path:/tmp/pip-C5533X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:09:40 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:40 INFO - Running setup.py (path:/tmp/pip-4YFhKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:09:40 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:09:40 INFO - Running setup.py (path:/tmp/pip-BsKboA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:09:40 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:09:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:09:40 INFO - Running setup.py (path:/tmp/pip-bzyXe9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:09:40 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:09:40 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:09:40 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:09:40 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:09:40 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:09:40 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:09:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:09:40 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:09:40 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:09:40 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:09:40 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:09:40 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:09:40 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:09:42 INFO - Downloading blessings-1.6.tar.gz 08:09:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:09:42 INFO - Installing collected packages: blessings 08:09:42 INFO - Running setup.py install for blessings 08:09:42 INFO - Successfully installed blessings 08:09:42 INFO - Cleaning up... 08:09:42 INFO - Return code: 0 08:09:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:09:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:42 INFO - Reading from file tmpfile_stdout 08:09:42 INFO - Current package versions: 08:09:42 INFO - argparse == 1.2.1 08:09:42 INFO - blessings == 1.6 08:09:42 INFO - blobuploader == 1.2.4 08:09:42 INFO - docopt == 0.6.1 08:09:42 INFO - functools32 == 3.2.3-2 08:09:42 INFO - jsonschema == 2.5.1 08:09:42 INFO - manifestparser == 1.1 08:09:42 INFO - mozInstall == 1.12 08:09:42 INFO - mozcrash == 0.17 08:09:42 INFO - mozdebug == 0.1 08:09:42 INFO - mozdevice == 0.48 08:09:42 INFO - mozfile == 1.2 08:09:42 INFO - mozhttpd == 0.7 08:09:42 INFO - mozinfo == 0.9 08:09:42 INFO - mozleak == 0.1 08:09:42 INFO - mozlog == 3.4 08:09:42 INFO - moznetwork == 0.27 08:09:42 INFO - mozprocess == 0.23 08:09:42 INFO - mozprofile == 0.28 08:09:42 INFO - mozrunner == 6.12 08:09:42 INFO - mozscreenshot == 0.1 08:09:42 INFO - mozsystemmonitor == 0.3 08:09:42 INFO - moztest == 0.7 08:09:42 INFO - mozversion == 1.4 08:09:42 INFO - psutil == 3.1.1 08:09:42 INFO - requests == 1.2.3 08:09:42 INFO - wsgiref == 0.1.2 08:09:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 08:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:42 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 0x7f707d967f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28930>, '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 0x2b29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29cc0>, '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': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', '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:09:42 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:09:42 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:09:42 INFO - Using env: {'DISPLAY': ':0', 08:09:42 INFO - 'HOME': '/home/cltbld', 08:09:42 INFO - 'LANG': 'en_US.UTF-8', 08:09:42 INFO - 'LANGUAGE': 'en_US:en', 08:09:42 INFO - 'LOGNAME': 'cltbld', 08:09:42 INFO - 'MAIL': '/var/mail/cltbld', 08:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:42 INFO - 'MOZ_NO_REMOTE': '1', 08:09:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:42 INFO - 'NO_EM_RESTART': '1', 08:09:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:42 INFO - 'PWD': '/builds/slave/test', 08:09:42 INFO - 'SHELL': '/bin/bash', 08:09:42 INFO - 'SHLVL': '1', 08:09:42 INFO - 'TERM': 'linux', 08:09:42 INFO - 'TMOUT': '86400', 08:09:42 INFO - 'USER': 'cltbld', 08:09:42 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', 08:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:42 INFO - '_': '/tools/buildbot/bin/python'} 08:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:43 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:09:43 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:09:43 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:09:43 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:09:43 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:09:43 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:09:43 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:09:43 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:09:43 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:09:43 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:09:43 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:09:43 INFO - Cleaning up... 08:09:43 INFO - Return code: 0 08:09:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:09: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:09:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09: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:09:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:09:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:09:43 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 0x7f707d967f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a5e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b2b790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b28930>, '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 0x2b29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29cc0>, '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': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', '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:09:43 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:09:43 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:09:43 INFO - Using env: {'DISPLAY': ':0', 08:09:43 INFO - 'HOME': '/home/cltbld', 08:09:43 INFO - 'LANG': 'en_US.UTF-8', 08:09:43 INFO - 'LANGUAGE': 'en_US:en', 08:09:43 INFO - 'LOGNAME': 'cltbld', 08:09:43 INFO - 'MAIL': '/var/mail/cltbld', 08:09:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:09:43 INFO - 'MOZ_NO_REMOTE': '1', 08:09:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:09:43 INFO - 'NO_EM_RESTART': '1', 08:09:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:09:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:09:43 INFO - 'PWD': '/builds/slave/test', 08:09:43 INFO - 'SHELL': '/bin/bash', 08:09:43 INFO - 'SHLVL': '1', 08:09:43 INFO - 'TERM': 'linux', 08:09:43 INFO - 'TMOUT': '86400', 08:09:43 INFO - 'USER': 'cltbld', 08:09:43 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', 08:09:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:09:43 INFO - '_': '/tools/buildbot/bin/python'} 08:09:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:09:43 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:09:43 INFO - Cleaning up... 08:09:43 INFO - Return code: 0 08:09:43 INFO - Running post-action listener: _resource_record_post_action 08:09:43 INFO - Running post-action listener: _start_resource_monitoring 08:09:43 INFO - Starting resource monitoring. 08:09:43 INFO - [mozharness: 2016-09-20 15:09:43.363290Z] Finished create-virtualenv step (success) 08:09:43 INFO - [mozharness: 2016-09-20 15:09:43.363794Z] Running install step. 08:09:43 INFO - Running pre-action listener: _resource_record_pre_action 08:09:43 INFO - Running main action method: install 08:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:09:43 INFO - Reading from file tmpfile_stdout 08:09:43 INFO - Detecting whether we're running mozinstall >=1.0... 08:09:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:09:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:09:43 INFO - Reading from file tmpfile_stdout 08:09:43 INFO - Output received: 08:09:43 INFO - Usage: mozinstall [options] installer 08:09:43 INFO - Options: 08:09:43 INFO - -h, --help show this help message and exit 08:09:43 INFO - -d DEST, --destination=DEST 08:09:43 INFO - Directory to install application into. [default: 08:09:43 INFO - "/builds/slave/test"] 08:09:43 INFO - --app=APP Application being installed. [default: firefox] 08:09:43 INFO - mkdir: /builds/slave/test/build/application 08:09:43 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:09:43 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:10:00 INFO - Reading from file tmpfile_stdout 08:10:00 INFO - Output received: 08:10:00 INFO - /builds/slave/test/build/application/firefox/firefox 08:10:00 INFO - Running post-action listener: _resource_record_post_action 08:10:00 INFO - [mozharness: 2016-09-20 15:10:00.593374Z] Finished install step (success) 08:10:00 INFO - [mozharness: 2016-09-20 15:10:00.593669Z] Running run-tests step. 08:10:00 INFO - Running pre-action listener: _resource_record_pre_action 08:10:00 INFO - Running main action method: run_tests 08:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:10:00 INFO - Python 2.7.3 08:10:00 INFO - Return code: 0 08:10:00 INFO - grabbing minidump binary from tooltool 08:10:00 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:10:00 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 0x2b28930>, '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 0x2b29830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b29cc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:10:00 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:10:00 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:10:00 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:10:00 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:10:00 INFO - Return code: 0 08:10:00 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:10:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:10:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:10:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:10:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 08:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 08:10:00 INFO - Using env: {'DISPLAY': ':0', 08:10:00 INFO - 'HOME': '/home/cltbld', 08:10:00 INFO - 'LANG': 'en_US.UTF-8', 08:10:00 INFO - 'LANGUAGE': 'en_US:en', 08:10:00 INFO - 'LOGNAME': 'cltbld', 08:10:00 INFO - 'MAIL': '/var/mail/cltbld', 08:10:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:10:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:10:00 INFO - 'MOZ_NO_REMOTE': '1', 08:10:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:10:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:10:00 INFO - 'NO_EM_RESTART': '1', 08:10:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:10:00 INFO - 'PWD': '/builds/slave/test', 08:10:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:10:00 INFO - 'SHELL': '/bin/bash', 08:10:00 INFO - 'SHLVL': '1', 08:10:00 INFO - 'TERM': 'linux', 08:10:00 INFO - 'TMOUT': '86400', 08:10:00 INFO - 'USER': 'cltbld', 08:10:00 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1474384144.980981-851266606', 08:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:10:00 INFO - '_': '/tools/buildbot/bin/python'} 08:10:00 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 08:10:00 INFO - mozversion application_buildid: 20160920033006 08:10:00 INFO - mozversion application_changeset: 14705f779a46da3dbbc41af098209911479cff01 08:10:00 INFO - mozversion application_display_name: Nightly 08:10:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:10:00 INFO - mozversion application_name: Firefox 08:10:00 INFO - mozversion application_remotingname: firefox 08:10:00 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:10:00 INFO - mozversion application_vendor: Mozilla 08:10:00 INFO - mozversion application_version: 52.0a1 08:10:00 INFO - mozversion platform_buildid: 20160920033006 08:10:00 INFO - mozversion platform_changeset: 14705f779a46da3dbbc41af098209911479cff01 08:10:00 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:10:00 INFO - mozversion platform_version: 52.0a1 08:10:00 INFO - using testdate: 1474384200 08:10:00 INFO - actual date: 1474384200 08:10:00 INFO - starting webserver on 'localhost:49116' 08:10:00 INFO - SUITE-START | Running 2 tests 08:10:00 INFO - TEST-START | dromaeo_css 08:10:00 INFO - operating with platform_type : linux_ 08:10:00 INFO - Initialising browser for dromaeo_css test... 08:10:00 INFO - TEST-INFO | started process 28099 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcSeVJA/profile http://localhost:49116/getInfo.html) 08:10:05 INFO - PROCESS | 28099 | __metrics Screen width/height:1600/1200 08:10:05 INFO - PROCESS | 28099 | colorDepth:24 08:10:05 INFO - PROCESS | 28099 | Browser inner width/height: 1024/697 08:10:05 INFO - PROCESS | 28099 | __metrics 08:10:05 ERROR - PROCESS | 28099 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 08:10:06 INFO - TEST-INFO | 28099: exit 0 08:10:06 INFO - Browser initialized. 08:10:06 INFO - Running cycle 1/1 for dromaeo_css test... 08:10:06 INFO - TEST-INFO | started process 28219 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcSeVJA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:10:18 INFO - PROCESS | 28219 | RSS: Main: 184492032 08:10:18 INFO - PROCESS | 28219 | 08:11:08 INFO - PROCESS | 28219 | 1474384268225 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:13:17 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:49116/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49116/tests/dromaeo/cssquery-ext.html) 08:13:18 INFO - PROCESS | 28219 | RSS: Main: 200048640 08:13:18 INFO - PROCESS | 28219 | 08:16:20 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:49116/tests/dromaeo/cssquery-ext.html (next: http://localhost:49116/tests/dromaeo/cssquery-jquery.html) 08:16:21 INFO - PROCESS | 28219 | RSS: Main: 195960832 08:16:21 INFO - PROCESS | 28219 | 08:19:23 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:49116/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49116/tests/dromaeo/cssquery-mootools.html) 08:19:24 INFO - PROCESS | 28219 | RSS: Main: 197939200 08:19:24 INFO - PROCESS | 28219 | 08:22:25 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:49116/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49116/tests/dromaeo/cssquery-prototype.html) 08:22:26 INFO - PROCESS | 28219 | RSS: Main: 194527232 08:22:26 INFO - PROCESS | 28219 | 08:25:28 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:49116/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49116/tests/dromaeo/cssquery-yui.html) 08:25:29 INFO - PROCESS | 28219 | RSS: Main: 198139904 08:25:29 INFO - PROCESS | 28219 | 08:28:32 INFO - PROCESS | 28219 | Cycle 1(1): loaded http://localhost:49116/tests/dromaeo/cssquery-yui.html (next: http://localhost:49116/tests/dromaeo/cssquery-dojo.html) 08:28:32 INFO - PROCESS | 28219 | RSS: Main: 198791168 08:28:32 INFO - PROCESS | 28219 | 08:28:32 INFO - PROCESS | 28219 | __start_tp_report 08:28:32 INFO - PROCESS | 28219 | _x_x_mozilla_page_load 08:28:32 INFO - PROCESS | 28219 | _x_x_mozilla_page_load_details 08:28:32 INFO - PROCESS | 28219 | |i|pagename|runs| 08:28:32 INFO - PROCESS | 28219 | |0;dojo.html;2979.7765167612433;2995.7453616442604;3010.3076292452733;3010.81935083895;3032.302570408806;5226.477352264772;5236.607254455912;5369.194620806881;5369.5167434930845;5385.246065550821;5314.548263397616;5324.866878328034;5337.919931201035;5342.358916929964;5390;4783.736894470802;4870.756462176877;4931.334269873557;4938.283948827436;4983.775730092155;4994.150994330972;5014.398272207341;5052.570531504826;5063.645544811865;5066.797328106872;4767.475577686451;4777.140114779339;4794.232922732346;4795.448523419782;4982.825601103962;4827.179379505457;4831.516848315176;4834.081524510332;4873.31773551703;4880.072786170652;4766.428028636551;4810.494898035726;4815.349927759743;4819.08437396897;4863.537963893425;5211.24436956643;5237.73811309433;5262.736863156827;5344.759485823109;5370.060239458079;5780.826575202751;5781.364049954502;5800.390958949334;5841.766329346821;5863.912041319383;5802.912956305617;5813.215215945877;5820.534357251409;5821.970890145564;5836.124581312837;5258.50044245796;5277.604179686462;5359.758810853521;5374.355077390699;5378.435264297232;5797.304323481125;5853.88292234153;5855.033919403336;5884.264466941632;5957.49361304294;5607.355154157242;5648.4633959773755;5660.830175094754;5661.716914154275;5666.603337766317;5557.916631250535;5591.776328946797;5672.716364181774;5731.656100633975;5741.540676745851;5574.1917421973585;5626.1842032905;5647;5675.347335056439;5754.223179870748;5660.801871934463;5672.858178545569;5678.4605462480995;5679.346875109332;5680.6307590007345;4307.56924307573;4364.9127017460105;4396.340548917624;4401.6698747594055;4444.777761111932;3885.86399476017;3914.647681708603;3925.293447179535;3927.1752931884625;3999.5000624921886;5281.9207711884355;5292.867678308073;5389.568834493231;5405.21624364465;5406.783728650888;5749.8275051748515;5750.2237197978575;5760.049591817387;5760.53915686744;5792.507636850831;5203.14148165556;5205.115130427761;5264.499872512105;5272.525472707474;5276.3932147802725;4779.641526885497;4784.210605250164;4788.449328327218;4841;4892.486288939681;5840.415958404211;5866.472017518444;5870.6771127587535;5876.941230587639;5914.378990205966;5596.356419011866;5638.633488823213;5708.687001989649;5722.084466485342;5734.684592347294;5986.461218490357;5992.0712289595185;5995.88008239824;6048.939510604838;6049.606775559574;5621.634593751393;5666.914996274977;5680.517156041617;5686.60193786431;5708.143778433268;5561.277033985556;5607.80372686954;5653.3781284057895;5722.885542289047;5759.193712880116;5569.749361278671;5629.099344104923;5638.661680299195;5692.943070569241;5706.115552089433;5589.580781441489;5602.1036634138345;5606;5606.24315717373;5626.24045753818;5330.8933821324135;5396.64921780083;5537.7784888604;5539.7784088636;5576.470235327637;5659.179418984307;5674.375818659862;5682.3465301489205;5688.061469857427;5746.827595172152;5524.116141417354;5560.944390556205;5570.387257401763;5576.498115169654;5603.991281569357 08:28:32 INFO - PROCESS | 28219 | |1;ext.html;541.6100407706452;571.1518395183153;587.2277954489847;587.2453896742686;589.5195415736175;34909.650903490954;35850.64149358509;35884.28231435373;42420;43550;46209.76895115528;46478.30282545764;46753.53246467534;46871;46950.53049469504;8774.429662071976;8840.160184782468;8921.732348029569;8927.95536022319;8931.64273429062;8737.21365077143;8853.42452740573;8885.333599980027;8896.733098007071;8915.866262006075;8878.911210887873;8960.417572857743;8985.550722463884;8985.730428087169;8987.0563590823;8783.560821958908;8807.955960220223;8859.424137431046;8873.378863479527;8877.112288771135;8764.298856091498;8769.298456123495;8783.253423459013;8789.912100879037;8822.602982865787;42965.140697186194;43038.56961430377;43385.56614433847;43513.12973740508;43660.345094823606;3355.060583036729;3415.55597772288;3438.8108654024018;3532.5407696999227;3823.298632108713;32263.193420164447;32400.18999525007;32439.83780081108;32952.505712414335;33185.336293274;3929.155231625186;3942.093318536724;4335.393044973706;4384.079343337903;4426.513083560838;326550;326749;328004;328756.9999999976;329483;60053;60441;60489.69755151196;60592.69703651542;60642.17477591916;37559.81220093882;38156.6184338153;38160.427593586115;38326.61673383231;63134.36865631285;16392.590185245226;16620.833791661928;16638.667226655398;16723.749143762852;16725.91637041807;12627.242365458102;12657.240565566095;12675.556355527513;12691;12721.93639031799;18704.345347912757;18820.435386938414;18992.905035474734;19038.33365832189;19316;6936.306369363124;6981.2669669683955;7011.404030657452;7248.96375518119;7260.273972602803;888.5690440136528;951.3388195204267;960.2270172511196;980.6028558433845;1026.1277913773233;29964.250893727396;30039.699603004126;30072;31504;31538;1047.5547892145808;1075.9246852720391;1078.1105587889865;1078.784243151373;1103.5309993252836;16254.75617865733;16449.753253701205;16604.25280862364;16920.492385228463;16924.746128808078;521632;524718;526848;529499;531017;57092.429075709544;57692.42307576955;57779;57785.422145778844;57841.710791445774;1193.540486912545;1215.3740823475916;1246.8005119180887;1260.8802163794426;1300.6163181861373;29595.260118497208;29944.850275748482;30243.197448420564;30421.543676844423;30616.234594134436;50466.49533504618;51098;51253.7437312811;51460.485395145566;51571.22643160431;421511;423546;424402;424810;425395;28357;28428.715712842608;28561.857190713912;28814.423711526073;29064.273393164494;46838;47006.52993470158;47171.52828471671;47313;47802.043959119925;39600.80199598984;40136.59863401329;40170.1965960685;40667.79666101769;42054;38675.90791261033;39848;40449.595504044584;41407.792961035004;41879.7906010468;40499.3925091118;42090;42372;42857.57142428661;42892.571074288855;31832.8408357966;35237.64762352344;38615.613843862324;39156.412653809646;39248.80375598104;28169.71830281671;28560.714392855807;28667.139985799626;28681;28791.280217994718 08:28:32 INFO - PROCESS | 28219 | |2;jquery.html;391.9216156768647;397.38207087978185;397.5249576755777;406.30319002910005;420.3736432715255;15976.600584985381;16100.597485062879;18052.90973545132;19616.411507654757;19633.803661963393;11694.766104677901;11963.102767292467;12299.569515066974;12321.753564928697;19617;5009.098362294794;5214.348206474191;5224.138017227172;5262.947370526284;5268.0517506848755;5158.174692049273;5246.449122842104;5553.972230138844;5807.0998995155815;5824.941750582482;5873.236479257691;5873.970630146843;5889.116632505137;5889.146073819294;5900.144479050535;5528.640638358514;5805.564582656318;5807.2450581424355;5821.446962538552;5884.882302353929;5561.916571251434;5712.542996560265;5722.084466485342;5722.513586345166;5751.597388182829;13224.603261902159;13546.187228766306;13586.320683965761;13588.25264610446;13593.932030339785;2164.826813854888;2274.420022894168;2403.471236328005;2566.961495577568;2710.9969311354726;9897.950510247403;9999.350042247303;10100.444475553842;10228.284020118595;10245.334053286588;1806.66576683314;1868;1877.896715680637;1909.809019098079;1915.4062240705425;83165;84748.57625711894;87305;89353.55323223407;89358.10641893563;11021.944890275498;11203.215774895842;11215.887841121485;11350.829737553944;11372.531377929645;15925.362985480682;15929.769832223497;15932.203389830462;15974.92012539953;15980.520584382488;7754.263344982331;7863.72476963315;8032.357411407073;8104.1085480597085;8153.22544358285;7655.923440765632;7784.143744188134;7947.284744372919;8039.075506316732;8081.434299598972;4706.1999460091865;4829.855104346875;4835.879103022382;4842.080004799147;4939.357883475125;1968.2717394563817;1997.3608445297657;2004.9699254511195;2016.385002574229;2019.2932473634405;826.3636999510463;906.9863952040592;928.0765638190044;957.3394357893031;968.4092703450889;17924.551886202687;18490.537736556693;18520.81479185218;18540.721889171673;18843.152058157415;936.5925822267335;940.1162906867522;965.285688590438;973.2700474644017;980.1919542577139;10192.949035254776;10323.122534584494;10360.740981475372;10421.53103110362;10510.211734119819;351967.36228463764;357718;494284;496027;502752;56716.88041663754;103128;103613;104837;105639.43605639528;1014.1785154025263;1045.5765415006933;1047.7537778621866;1095.8739744929276;1100.818364969771;16796.328146873988;16885.662286754443;17493.737593935846;17642.647147057243;17647.647047059243;35019.47470787889;40422;42011.57988420199;42732;43371.56628433675;56914.14628780654;59935.40064599298;61235;61637.07544386748;61686;7657.4256930731535;7716.189800070912;8047.678092876219;8471.66113355459;8523.48859068458;9222.306862813013;13187.53843615469;13355.799663005257;13450.26023568713;13971.30143492801;11792.115591330514;11988.940055299669;12136.271823690608;12151.75696486083;12529.122961392615;6740.494462915399;8354.749357519284;11611.5355385787;11881.643550693147;11973.521059157536;11510.884891150981;12008.159428839897;12140.575079872162;12154.392280385768;12459.93770031144;7759.68961241544;7864.606769661608;7874.448788584744;7892.644830982505;8027.438079334391;10670.359778413009;11492.310461372344;11509.597164099216;11618.535258589562;11932.642020739391 08:28:32 INFO - PROCESS | 28219 | |3;mootools.html;1453.4622189789777;1499.7900293958844;1602.6874759421917;1717.6650553142135;1743.7558741776145;7877;8240.340772738182;8618.741437756862;9193.172614464696;9243.53782310885;8590.570471476432;8935.463872167675;8940;9115.407498512592;9133.634654613825;2396.2332053742807;2396.400899775052;2417.7944874685586;2424.0788500369836;2424.1757802347197;2413.070967677448;2416.8066554675584;2428.4171798768343;2433.5254625348066;2436.805055595557;2401.6277476991095;2433.7931275841574;2437.305367970129;2440.8779561021965;2453.938651533717;2385.761423857609;2389.339409110669;2399.3042017814814;2405.9278221653203;2426.7815896569396;2334.299710086967;2344.9296521104393;2353.7881590656752;2363.345658039362;2377.025419577982;9120.954395228047;9141.954290228572;9148.771280717969;9149.130832570896;9150.816983660356;5106.387233531963;5115.104856650109;5176.404713457963;5176.430592634807;5181.637285390024;3317.2370354818527;3342.097633638928;3412.351653185887;3433.2275238071484;3504.3341765064556;1119.2724728926182;1164.4294295795085;1177.9764404711943;1190.1490434339403;1190.1668831817763;12424.937875310656;12440.688982775413;12463.875361246362;12483.438245278985;12506.124571280105;4458.799354029076;4664.55686709762;4791.305260737174;4805.879853003703;4850.95149048512;10339.844902326471;10380.636677716244;10395.584176633001;10421.9478902605;10442.63450779219;5188.8962220755375;5199.194124910645;5207.843764687065;5213.113770658997;5213.895722085613;4674.74288914113;4771.212749896297;4774.9522504775205;4818.10864989978;4846.903061938741;3873.205992771475;3960.2277555876326;3996.2606917720314;4036.5156181258435;4050.270951228807;1229.7540491901655;1243.8072098824696;1247.9812802807965;1250.4560516175493;1262.4066688656317;852.2031900173358;869.6434461870602;875.7460336502343;891.5943245823134;901.7520181950016;5802.390748971382;5936.673482958478;5996.2504686914135;6042.6072305300895;6165.414285642857;915.5742579700338;919.558611866308;922.4972390047441;924.8751418558543;959.9520023998772;3743.801983365297;3862.420636904487;4020.396940458896;4176.43618111551;4323.848665296699;10857.402842843561;11261.211715180023;11262.549498020151;11263.211575189658;11317.886821131848;11129.387883666475;11163;11234.943825280985;11235.494402751896;11260.211785174959;7928.365730741527;8117.95941020303;8135.511869287861;8140.982377202849;8180.263776260165;5828.271466066742;5917.763289468545;5932.4957378621575;5943.435373639497;5987.88024239504;9621.374610650286;9809.607615695577;9923.851142233018;9975.800483990424;10019.398836069859;10198.847017294895;10209.9489502552;10219.080282774587;10228.53971571296;10247.026532479402;6911.723531058701;7125.465590080661;7409.592472414069;7438.107427108565;7518.661660225413;8444.535550544779;8804.647814087364;8844.690435834715;8852.114788521096;8880.777980550538;7466.178720340867;7506.174320824595;7703.114141873756;7784.494007889469;7792.337651299703;7820.569868657279;7877.054753429625;7885.487443316166;7987.800304992422;8037.879431808645;7133.964330178316;7180.712771489082;7180.820479487846;7191.8561628768175;7201.243869393638;4550.954490455053;4589.632829373709;4609.723416595015;4616.584507394351;4731.787069581808;4902.656814023127;4934.753262336941;4936.481669424658;5023.899522009467;5041.563154500949 08:28:32 INFO - PROCESS | 28219 | |4;prototype.html;293.2156481412222;308.358614082708;317.1832531232078;318.69564565839624;322.8047031545915;5324.227986941891;5488.1493368527845;5497.890042199154;5549.77800887964;5558.555315574755;5371.623986320949;5476.959377718231;5506.779728810843;5509.889802203954;5511.779528818853;4288.249556327638;4302.827886884521;4323.848665296715;4339.262325404673;4345;4132.73137246078;4242.766647834368;4271.508776490697;4322.459692538433;4348.804303806336;4208.3687446882905;4217.36739489076;4219.641330486897;4225.957740422603;4232.682548808836;4236.555161708007;4243.469566304212;4248.9150216995795;4252.362145678142;4253.44705188325;3655.4151335786146;3753.3244016077097;3753.6246375362516;3754.784677040559;3759.906002349936;5306.230596563515;5326.573874090063;5345.3585569731495;5352.625316227865;5356.464353564651;4866.732329721899;4868.878278043042;4873;4925.926111108336;4932.926006109911;5591.664500130005;5694.259746233005;5728.169415434781;5792.160136780143;5806.88386232273;4100.856470023565;4101.835926562934;4105.774182419966;4109.219248342805;4136.627703506669;5981.700914954235;5998.670073145975;6022.427869352405;6027.306859711145;6059.545534084918;4095.426640270305;4236.576342365739;4239.915201696011;4244.639205667553;4251.723637963522;4273.337632666941;4284.785760711952;4297.871063868089;4298.892527686833;4305.956940430556;4916.434610019822;4919;4920.8769780755765;4932.816124130183;4952.8761780955765;5680.68756218412;5816.127580862904;5844.1818145459665;5854.121881717691;5856.297244330707;1451.550019493939;1474.9041312314664;1477.6601381682274;1480.9555713328618;1485.8365579786214;900.8603666431713;942.9297747057002;942.9811403772023;953.5518306395983;966.2511553545918;4754.595859351924;4775.498572649891;4915.090708218991;4940.925886111711;4953.504649535018;5249.790008399621;5272.2355258487305;5275.630705850554;5313.927568248386;5331.653442526301;4558.407407037064;4826.879328016757;4859.902801944012;4885;4892.437369702458;2776.6667999840147;2778.4304217635336;2784.3317603775354;2796.5525515917357;2811.831290122599;5369.677819330853;5374.4625537445945;5412.350517937873;5415.781449173905;5446.863828404322;5326.307580014573;5346.690060935096;5636.589863132827;6086.9391306087255;6106.236720409949;6215.658138802319;6219.911515484772;6233.257366758612;6254.874902501924;6268.874622507525;5897.292324921037;5947.286325640778;5960.642361458326;6056.3035250946705;6077.6961151943115;5886.440788125121;5904.409559044233;5922.851928701644;5970.223870896929;6003.189569408249;6229.56393052482;6261.96869015652;6324.494040476843;6329.335419780857;6341.207349081365;3977.3636218204947;4135.60711732385;4135.97932010338;4148.668106551529;4216.957830421779;5948.167256583995;5975.342712301556;5983.910241346296;6017.819465416044;6027.909581356371;5624.550035997192;5845.795397161079;5875.41245875409;5891.1457838612305;5913.763449461973;5721.368170641552;5738.8278351649515;5745.1382292656435;5766.068367096902;5782.508486778503;5808.73860676279;5813.854653633693;5818.33089194748;5835.708214589338;5853.209816674695;5609.971950140223;5837.970810146092;5903.675297858659;5907.379725128972;5910.70446477683;5718.485336319751;5742.59801813869;5745.2818397700285;5746.626469279484;5794.783095549813 08:28:32 INFO - PROCESS | 28219 | |5;yui.html;737.1007371007372;764.7361660227222;772.0503780350166;791.8495485857686;831.3972370031728;13485.190888546695;14611.634709132277;14641.19473428961;14668.486602968886;14735.189564573944;13569;13751.174929504237;13767.862321376782;13778.655533611665;13791.793123103136;623.227198274139;633.5628416392674;726.6729971512827;751.3838652305112;759.2521366454039;752.405599576334;754.6830331260884;756.648158606248;758.9810254743647;759.9164091949881;798.660569258063;805.9758207253792;807.5114555693809;807.9474834135763;810.1655295046082;782.996085019577;788.8185717284999;793.3692714292151;794.2454668065332;797.2187256488645;585.1719816459704;585.4233579923772;587.8647910980455;588.3087372337486;592.2567178191385;13566.321683915863;13597;13599.320033998261;13697.657558561015;13716.314184290846;14953.327100280514;15230.314635841414;15347.769783453257;15422.614434639223;15696.372145114181;11610.36143012134;12019.15865889388;12101.939490302491;13064.738705225936;13580.592582222549;4411.205982923073;4463;4471.351654010183;4528.366028755977;4631.976840115812;76237.61881190559;77502;77788.8331675031;78732.60633696851;79417;10643.787124257471;10975.890241097486;10983.505742241618;11010.174236932262;11072.169587280987;21069.89465052665;21212.15151393927;21338.57322853534;21492.247771328242;21607.243746468797;8281.751547453465;8369;8488.278496327881;8544.444611100258;8638.568071596395;4671.120093183465;4680.812767489262;4751.619870410428;4794.880127996828;4844.588210002119;3046.9238269043453;3136.8902088427253;3160.3047329587453;3167.619885613695;3173.6032995875516;521.8330134356969;524.1220954900526;535.9919601205985;539.3877948528449;562.9577781666392;562.8170844475562;651.8761435327273;715.481276074852;716.6846587501483;755.1466842467976;9756.756081098029;9871.555779989918;9977.850332245021;10083.19334453242;10224.539895704711;574.9223854779635;632.9620222786648;682.9351211634887;700.6076597105637;720.052258640387;4471.977640111779;4652.1626107300335;4683.6721429500285;4695.178343789823;4714.787834547454;70111;97728;125829.37085314514;127370;132799;107239.39140912892;108807.45596271969;109929;110389.9999999984;110910.44544777225;94397;94877;95599;96454.51772741231;97371.51314243383;8519.616617252115;8526.147385261424;8558.871616925875;8662.956685216534;8787.384883058125;52276.73861630668;53230;53831.192532111265;54030.45969540411;54313.45686543242;72597.27402725905;76509.61745191239;80046;81700.59149704213;82967.58516207381;11235.325880447199;11544.538218471504;11566.826497602711;11760.176787624785;12097.637070887888;12298.938505307417;12357.25856448616;12682.302473364054;12892.419841106985;13295.335233238106;12308.938455307667;12507.93746031264;12805.74388512206;12898.548550801052;13214.207147571176;11716.753501455862;12144.817827732768;12453.315067671365;12501.374931253582;12753.171043882117;11893.76212475763;12306.876931230574;12471.314077725448;12611;12923.35383230816;10230.846537301797;10483.056524912794;10564.366138031743;10660.413677247825;10839.729006774578;10317.896821031694;10522;10622.946885265525;10711.732206694895;10726.731831703957 08:28:32 INFO - PROCESS | 28219 | __end_tp_report 08:28:32 INFO - PROCESS | 28219 | __start_cc_report 08:28:32 INFO - PROCESS | 28219 | _x_x_mozilla_cycle_collect,299 08:28:32 INFO - PROCESS | 28219 | __end_cc_report 08:28:32 INFO - PROCESS | 28219 | __startTimestamp1474385312293__endTimestamp 08:28:32 INFO - PROCESS | 28219 | 08:28:32 INFO - PROCESS | 28219 | ------- Summary: start ------- 08:28:32 INFO - PROCESS | 28219 | Number of tests: 6 08:28:32 INFO - PROCESS | 28219 | 08:28:32 INFO - PROCESS | 28219 | [#0] dojo.html Cycles:165 Average:5310.00 Median:5561.28 stddev:617.22 (11.1%) stddev-sans-first:591.43 08:28:32 INFO - PROCESS | 28219 | Values: 2979.8 2995.7 3010.3 3010.8 3032.3 5226.5 5236.6 5369.2 5369.5 5385.2 5314.5 5324.9 5337.9 5342.4 5390.0 4783.7 4870.8 4931.3 4938.3 4983.8 4994.2 5014.4 5052.6 5063.6 5066.8 4767.5 4777.1 4794.2 4795.4 4982.8 4827.2 4831.5 4834.1 4873.3 4880.1 4766.4 4810.5 4815.3 4819.1 4863.5 5211.2 5237.7 5262.7 5344.8 5370.1 5780.8 5781.4 5800.4 5841.8 5863.9 5802.9 5813.2 5820.5 5822.0 5836.1 5258.5 5277.6 5359.8 5374.4 5378.4 5797.3 5853.9 5855.0 5884.3 5957.5 5607.4 5648.5 5660.8 5661.7 5666.6 5557.9 5591.8 5672.7 5731.7 5741.5 5574.2 5626.2 5647.0 5675.3 5754.2 5660.8 5672.9 5678.5 5679.3 5680.6 4307.6 4364.9 4396.3 4401.7 4444.8 3885.9 3914.6 3925.3 3927.2 3999.5 5281.9 5292.9 5389.6 5405.2 5406.8 5749.8 5750.2 5760.0 5760.5 5792.5 5203.1 5205.1 5264.5 5272.5 5276.4 4779.6 4784.2 4788.4 4841.0 4892.5 5840.4 5866.5 5870.7 5876.9 5914.4 5596.4 5638.6 5708.7 5722.1 5734.7 5986.5 5992.1 5995.9 6048.9 6049.6 5621.6 5666.9 5680.5 5686.6 5708.1 5561.3 5607.8 5653.4 5722.9 5759.2 5569.7 5629.1 5638.7 5692.9 5706.1 5589.6 5602.1 5606.0 5606.2 5626.2 5330.9 5396.6 5537.8 5539.8 5576.5 5659.2 5674.4 5682.3 5688.1 5746.8 5524.1 5560.9 5570.4 5576.5 5604.0 08:28:32 INFO - PROCESS | 28219 | 08:28:32 INFO - PROCESS | 28219 | [#1] ext.html Cycles:180 Average:58474.88 Median:42072.00 stddev:115002.35 (273.3%) stddev-sans-first:115242.70 08:28:32 INFO - PROCESS | 28219 | Values: 541.6 571.2 587.2 587.2 589.5 34909.7 35850.6 35884.3 42420.0 43550.0 46209.8 46478.3 46753.5 46871.0 46950.5 8774.4 8840.2 8921.7 8928.0 8931.6 8737.2 8853.4 8885.3 8896.7 8915.9 8878.9 8960.4 8985.6 8985.7 8987.1 8783.6 8808.0 8859.4 8873.4 8877.1 8764.3 8769.3 8783.3 8789.9 8822.6 42965.1 43038.6 43385.6 43513.1 43660.3 3355.1 3415.6 3438.8 3532.5 3823.3 32263.2 32400.2 32439.8 32952.5 33185.3 3929.2 3942.1 4335.4 4384.1 4426.5 326550.0 326749.0 328004.0 328757.0 329483.0 60053.0 60441.0 60489.7 60592.7 60642.2 37559.8 38156.6 38160.4 38326.6 63134.4 16392.6 16620.8 16638.7 16723.7 16725.9 12627.2 12657.2 12675.6 12691.0 12721.9 18704.3 18820.4 18992.9 19038.3 19316.0 6936.3 6981.3 7011.4 7249.0 7260.3 888.6 951.3 960.2 980.6 1026.1 29964.3 30039.7 30072.0 31504.0 31538.0 1047.6 1075.9 1078.1 1078.8 1103.5 16254.8 16449.8 16604.3 16920.5 16924.7 521632.0 524718.0 526848.0 529499.0 531017.0 57092.4 57692.4 57779.0 57785.4 57841.7 1193.5 1215.4 1246.8 1260.9 1300.6 29595.3 29944.9 30243.2 30421.5 30616.2 50466.5 51098.0 51253.7 51460.5 51571.2 421511.0 423546.0 424402.0 424810.0 425395.0 28357.0 28428.7 28561.9 28814.4 29064.3 46838.0 47006.5 47171.5 47313.0 47802.0 39600.8 40136.6 40170.2 40667.8 42054.0 38675.9 39848.0 40449.6 41407.8 41879.8 40499.4 42090.0 42372.0 42857.6 42892.6 31832.8 35237.6 38615.6 39156.4 39248.8 28169.7 28560.7 28667.1 28681.0 28791.3 08:28:32 INFO - PROCESS | 28219 | 08:28:32 INFO - PROCESS | 28219 | [#2] jquery.html Cycles:180 Average:27339.63 Median:354842.68 stddev:74245.96 (20.9%) stddev-sans-first:74426.67 08:28:32 INFO - PROCESS | 28219 | Values: 391.9 397.4 397.5 406.3 420.4 15976.6 16100.6 18052.9 19616.4 19633.8 11694.8 11963.1 12299.6 12321.8 19617.0 5009.1 5214.3 5224.1 5262.9 5268.1 5158.2 5246.4 5554.0 5807.1 5824.9 5873.2 5874.0 5889.1 5889.1 5900.1 5528.6 5805.6 5807.2 5821.4 5884.9 5561.9 5712.5 5722.1 5722.5 5751.6 13224.6 13546.2 13586.3 13588.3 13593.9 2164.8 2274.4 2403.5 2567.0 2711.0 9898.0 9999.4 10100.4 10228.3 10245.3 1806.7 1868.0 1877.9 1909.8 1915.4 83165.0 84748.6 87305.0 89353.6 89358.1 11021.9 11203.2 11215.9 11350.8 11372.5 15925.4 15929.8 15932.2 15974.9 15980.5 7754.3 7863.7 8032.4 8104.1 8153.2 7655.9 7784.1 7947.3 8039.1 8081.4 4706.2 4829.9 4835.9 4842.1 4939.4 1968.3 1997.4 2005.0 2016.4 2019.3 826.4 907.0 928.1 957.3 968.4 17924.6 18490.5 18520.8 18540.7 18843.2 936.6 940.1 965.3 973.3 980.2 10192.9 10323.1 10360.7 10421.5 10510.2 351967.4 357718.0 494284.0 496027.0 502752.0 56716.9 103128.0 103613.0 104837.0 105639.4 1014.2 1045.6 1047.8 1095.9 1100.8 16796.3 16885.7 17493.7 17642.6 17647.6 35019.5 40422.0 42011.6 42732.0 43371.6 56914.1 59935.4 61235.0 61637.1 61686.0 7657.4 7716.2 8047.7 8471.7 8523.5 9222.3 13187.5 13355.8 13450.3 13971.3 11792.1 11988.9 12136.3 12151.8 12529.1 6740.5 8354.7 11611.5 11881.6 11973.5 11510.9 12008.2 12140.6 12154.4 12459.9 7759.7 7864.6 7874.4 7892.6 8027.4 10670.4 11492.3 11509.6 11618.5 11932.6 08:28:32 INFO - PROCESS | 28219 | 08:28:32 INFO - PROCESS | 28219 | [#3] mootools.html Cycles:180 Average:5821.47 Median:4783.13 stddev:3335.96 (69.7%) stddev-sans-first:3329.17 08:28:32 INFO - PROCESS | 28219 | Values: 1453.5 1499.8 1602.7 1717.7 1743.8 7877.0 8240.3 8618.7 9193.2 9243.5 8590.6 8935.5 8940.0 9115.4 9133.6 2396.2 2396.4 2417.8 2424.1 2424.2 2413.1 2416.8 2428.4 2433.5 2436.8 2401.6 2433.8 2437.3 2440.9 2453.9 2385.8 2389.3 2399.3 2405.9 2426.8 2334.3 2344.9 2353.8 2363.3 2377.0 9121.0 9142.0 9148.8 9149.1 9150.8 5106.4 5115.1 5176.4 5176.4 5181.6 3317.2 3342.1 3412.4 3433.2 3504.3 1119.3 1164.4 1178.0 1190.1 1190.2 12424.9 12440.7 12463.9 12483.4 12506.1 4458.8 4664.6 4791.3 4805.9 4851.0 10339.8 10380.6 10395.6 10421.9 10442.6 5188.9 5199.2 5207.8 5213.1 5213.9 4674.7 4771.2 4775.0 4818.1 4846.9 3873.2 3960.2 3996.3 4036.5 4050.3 1229.8 1243.8 1248.0 1250.5 1262.4 852.2 869.6 875.7 891.6 901.8 5802.4 5936.7 5996.3 6042.6 6165.4 915.6 919.6 922.5 924.9 960.0 3743.8 3862.4 4020.4 4176.4 4323.8 10857.4 11261.2 11262.5 11263.2 11317.9 11129.4 11163.0 11234.9 11235.5 11260.2 7928.4 8118.0 8135.5 8141.0 8180.3 5828.3 5917.8 5932.5 5943.4 5987.9 9621.4 9809.6 9923.9 9975.8 10019.4 10198.8 10209.9 10219.1 10228.5 10247.0 6911.7 7125.5 7409.6 7438.1 7518.7 8444.5 8804.6 8844.7 8852.1 8880.8 7466.2 7506.2 7703.1 7784.5 7792.3 7820.6 7877.1 7885.5 7987.8 8037.9 7134.0 7180.7 7180.8 7191.9 7201.2 4551.0 4589.6 4609.7 4616.6 4731.8 4902.7 4934.8 4936.5 5023.9 5041.6 08:28:32 INFO - PROCESS | 28219 | 08:28:32 INFO - PROCESS | 28219 | [#4] prototype.html Cycles:180 Average:4783.90 Median:5349.66 stddev:1433.87 (26.8%) stddev-sans-first:1397.72 08:28:32 INFO - PROCESS | 28219 | Values: 293.2 308.4 317.2 318.7 322.8 5324.2 5488.1 5497.9 5549.8 5558.6 5371.6 5477.0 5506.8 5509.9 5511.8 4288.2 4302.8 4323.8 4339.3 4345.0 4132.7 4242.8 4271.5 4322.5 4348.8 4208.4 4217.4 4219.6 4226.0 4232.7 4236.6 4243.5 4248.9 4252.4 4253.4 3655.4 3753.3 3753.6 3754.8 3759.9 5306.2 5326.6 5345.4 5352.6 5356.5 4866.7 4868.9 4873.0 4925.9 4932.9 5591.7 5694.3 5728.2 5792.2 5806.9 4100.9 4101.8 4105.8 4109.2 4136.6 5981.7 5998.7 6022.4 6027.3 6059.5 4095.4 4236.6 4239.9 4244.6 4251.7 4273.3 4284.8 4297.9 4298.9 4306.0 4916.4 4919.0 4920.9 4932.8 4952.9 5680.7 5816.1 5844.2 5854.1 5856.3 1451.6 1474.9 1477.7 1481.0 1485.8 900.9 942.9 943.0 953.6 966.3 4754.6 4775.5 4915.1 4940.9 4953.5 5249.8 5272.2 5275.6 5313.9 5331.7 4558.4 4826.9 4859.9 4885.0 4892.4 2776.7 2778.4 2784.3 2796.6 2811.8 5369.7 5374.5 5412.4 5415.8 5446.9 5326.3 5346.7 5636.6 6086.9 6106.2 6215.7 6219.9 6233.3 6254.9 6268.9 5897.3 5947.3 5960.6 6056.3 6077.7 5886.4 5904.4 5922.9 5970.2 6003.2 6229.6 6262.0 6324.5 6329.3 6341.2 3977.4 4135.6 4136.0 4148.7 4217.0 5948.2 5975.3 5983.9 6017.8 6027.9 5624.6 5845.8 5875.4 5891.1 5913.8 5721.4 5738.8 5745.1 5766.1 5782.5 5808.7 5813.9 5818.3 5835.7 5853.2 5610.0 5838.0 5903.7 5907.4 5910.7 5718.5 5742.6 5745.3 5746.6 5794.8 08:28:32 INFO - PROCESS | 28219 | 08:28:32 INFO - PROCESS | 28219 | [#5] yui.html Cycles:180 Average:21151.47 Median:4642.07 stddev:31666.22 (682.2%) stddev-sans-first:31717.95 08:28:32 INFO - PROCESS | 28219 | Values: 737.1 764.7 772.1 791.8 831.4 13485.2 14611.6 14641.2 14668.5 14735.2 13569.0 13751.2 13767.9 13778.7 13791.8 623.2 633.6 726.7 751.4 759.3 752.4 754.7 756.6 759.0 759.9 798.7 806.0 807.5 807.9 810.2 783.0 788.8 793.4 794.2 797.2 585.2 585.4 587.9 588.3 592.3 13566.3 13597.0 13599.3 13697.7 13716.3 14953.3 15230.3 15347.8 15422.6 15696.4 11610.4 12019.2 12101.9 13064.7 13580.6 4411.2 4463.0 4471.4 4528.4 4632.0 76237.6 77502.0 77788.8 78732.6 79417.0 10643.8 10975.9 10983.5 11010.2 11072.2 21069.9 21212.2 21338.6 21492.2 21607.2 8281.8 8369.0 8488.3 8544.4 8638.6 4671.1 4680.8 4751.6 4794.9 4844.6 3046.9 3136.9 3160.3 3167.6 3173.6 521.8 524.1 536.0 539.4 563.0 562.8 651.9 715.5 716.7 755.1 9756.8 9871.6 9977.9 10083.2 10224.5 574.9 633.0 682.9 700.6 720.1 4472.0 4652.2 4683.7 4695.2 4714.8 70111.0 97728.0 125829.4 127370.0 132799.0 107239.4 108807.5 109929.0 110390.0 110910.4 94397.0 94877.0 95599.0 96454.5 97371.5 8519.6 8526.1 8558.9 8663.0 8787.4 52276.7 53230.0 53831.2 54030.5 54313.5 72597.3 76509.6 80046.0 81700.6 82967.6 11235.3 11544.5 11566.8 11760.2 12097.6 12298.9 12357.3 12682.3 12892.4 13295.3 12308.9 12507.9 12805.7 12898.5 13214.2 11716.8 12144.8 12453.3 12501.4 12753.2 11893.8 12306.9 12471.3 12611.0 12923.4 10230.8 10483.1 10564.4 10660.4 10839.7 10317.9 10522.0 10622.9 10711.7 10726.7 08:28:32 INFO - PROCESS | 28219 | -------- Summary: end -------- 08:28:32 INFO - PROCESS | 28219 | 08:28:33 INFO - TEST-INFO | 28219: exit 0 08:28:33 INFO - TEST-OK | dromaeo_css | took 1112496ms 08:28:33 INFO - TEST-START | kraken 08:28:33 INFO - operating with platform_type : linux_ 08:28:33 INFO - Initialising browser for kraken test... 08:28:33 INFO - TEST-INFO | started process 28582 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFuvARq/profile http://localhost:49116/getInfo.html) 08:28:37 INFO - PROCESS | 28582 | __metrics Screen width/height:1600/1200 08:28:37 INFO - PROCESS | 28582 | colorDepth:24 08:28:37 INFO - PROCESS | 28582 | Browser inner width/height: 1024/697 08:28:37 INFO - PROCESS | 28582 | __metrics 08:28:37 ERROR - PROCESS | 28582 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3018: TypeError: this.tabs is undefined 08:28:38 INFO - TEST-INFO | 28582: exit 0 08:28:38 INFO - Browser initialized. 08:28:38 INFO - Running cycle 1/1 for kraken test... 08:28:38 INFO - TEST-INFO | started process 28705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFuvARq/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:28:50 INFO - PROCESS | 28705 | RSS: Main: 184664064 08:28:50 INFO - PROCESS | 28705 | 08:28:53 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49116/tests/kraken/driver.html?testName=audio-beat-detection) 08:28:54 INFO - PROCESS | 28705 | RSS: Main: 198537216 08:28:54 INFO - PROCESS | 28705 | 08:28:57 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49116/tests/kraken/driver.html?testName=audio-dft) 08:28:57 INFO - PROCESS | 28705 | RSS: Main: 196259840 08:28:57 INFO - PROCESS | 28705 | 08:29:00 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49116/tests/kraken/driver.html?testName=audio-fft) 08:29:01 INFO - PROCESS | 28705 | RSS: Main: 192126976 08:29:01 INFO - PROCESS | 28705 | 08:29:03 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49116/tests/kraken/driver.html?testName=audio-oscillator) 08:29:04 INFO - PROCESS | 28705 | RSS: Main: 193024000 08:29:04 INFO - PROCESS | 28705 | 08:29:06 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49116/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:29:06 INFO - PROCESS | 28705 | RSS: Main: 193028096 08:29:06 INFO - PROCESS | 28705 | 08:29:09 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49116/tests/kraken/driver.html?testName=imaging-darkroom) 08:29:10 INFO - PROCESS | 28705 | RSS: Main: 193347584 08:29:10 INFO - PROCESS | 28705 | 08:29:13 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49116/tests/kraken/driver.html?testName=imaging-desaturate) 08:29:14 INFO - PROCESS | 28705 | RSS: Main: 191623168 08:29:14 INFO - PROCESS | 28705 | 08:29:17 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49116/tests/kraken/driver.html?testName=json-parse-financial) 08:29:18 INFO - PROCESS | 28705 | RSS: Main: 192761856 08:29:18 INFO - PROCESS | 28705 | 08:29:19 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49116/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:29:20 INFO - PROCESS | 28705 | RSS: Main: 193056768 08:29:20 INFO - PROCESS | 28705 | 08:29:21 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49116/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:29:22 INFO - PROCESS | 28705 | RSS: Main: 193425408 08:29:22 INFO - PROCESS | 28705 | 08:29:24 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49116/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:29:25 INFO - PROCESS | 28705 | RSS: Main: 193478656 08:29:25 INFO - PROCESS | 28705 | 08:29:28 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49116/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:29:28 INFO - PROCESS | 28705 | RSS: Main: 193839104 08:29:28 INFO - PROCESS | 28705 | 08:29:31 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49116/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:29:32 INFO - PROCESS | 28705 | RSS: Main: 193728512 08:29:32 INFO - PROCESS | 28705 | 08:29:33 INFO - PROCESS | 28705 | Cycle 1(1): loaded http://localhost:49116/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49116/tests/kraken/driver.html?testName=ai-astar) 08:29:34 INFO - PROCESS | 28705 | RSS: Main: 195014656 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | __start_tp_report 08:29:34 INFO - PROCESS | 28705 | _x_x_mozilla_page_load 08:29:34 INFO - PROCESS | 28705 | _x_x_mozilla_page_load_details 08:29:34 INFO - PROCESS | 28705 | |i|pagename|runs| 08:29:34 INFO - PROCESS | 28705 | |0;ai-astar;106;112;114;112;113;113;112;111;112;111 08:29:34 INFO - PROCESS | 28705 | |1;audio-beat-detection;151;126;120;176;120;120;120;119;151;122 08:29:34 INFO - PROCESS | 28705 | |2;audio-dft;162;161;163;164;175;162;165;164;164;162 08:29:34 INFO - PROCESS | 28705 | |3;audio-fft;78;78;77;112;77;76;75;76;116;74 08:29:34 INFO - PROCESS | 28705 | |4;audio-oscillator;83;86;115;82;83;82;103;82;82;106 08:29:34 INFO - PROCESS | 28705 | |5;imaging-gaussian-blur;117;117;117;118;117;118;117;118;118;118 08:29:34 INFO - PROCESS | 28705 | |6;imaging-darkroom;147;147;149;149;148;149;147;147;146;147 08:29:34 INFO - PROCESS | 28705 | |7;imaging-desaturate;96;98;97;96;96;95;95;98;96;96 08:29:34 INFO - PROCESS | 28705 | |8;json-parse-financial;52;52;51;52;53;57;52;54;52;52 08:29:34 INFO - PROCESS | 28705 | |9;json-stringify-tinderbox;60;60;60;60;60;60;59;59;60;60 08:29:34 INFO - PROCESS | 28705 | |10;stanford-crypto-aes;80;81;80;81;79;80;83;81;80;80 08:29:34 INFO - PROCESS | 28705 | |11;stanford-crypto-ccm;128;126;134;135;139;129;129;135;163;140 08:29:34 INFO - PROCESS | 28705 | |12;stanford-crypto-pbkdf2;169;173;172;166;168;169;169;172;170;170 08:29:34 INFO - PROCESS | 28705 | |13;stanford-crypto-sha256-iterative;66;78;73;66;66;66;66;66;65;65 08:29:34 INFO - PROCESS | 28705 | __end_tp_report 08:29:34 INFO - PROCESS | 28705 | __start_cc_report 08:29:34 INFO - PROCESS | 28705 | _x_x_mozilla_cycle_collect,778 08:29:34 INFO - PROCESS | 28705 | __end_cc_report 08:29:34 INFO - PROCESS | 28705 | __startTimestamp1474385374172__endTimestamp 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | ------- Summary: start ------- 08:29:34 INFO - PROCESS | 28705 | Number of tests: 14 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#0] ai-astar Cycles:10 Average:111.60 Median:112.00 stddev:2.17 (1.9%) stddev-sans-first:0.97 08:29:34 INFO - PROCESS | 28705 | Values: 106.0 112.0 114.0 112.0 113.0 113.0 112.0 111.0 112.0 111.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#1] audio-beat-detection Cycles:10 Average:132.50 Median:124.00 stddev:19.82 (16.0%) stddev-sans-first:19.86 08:29:34 INFO - PROCESS | 28705 | Values: 151.0 126.0 120.0 176.0 120.0 120.0 120.0 119.0 151.0 122.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:3.99 (2.4%) stddev-sans-first:4.16 08:29:34 INFO - PROCESS | 28705 | Values: 162.0 161.0 163.0 164.0 175.0 162.0 165.0 164.0 164.0 162.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#3] audio-fft Cycles:10 Average:83.90 Median:76.50 stddev:15.94 (20.8%) stddev-sans-first:16.76 08:29:34 INFO - PROCESS | 28705 | Values: 78.0 78.0 77.0 112.0 77.0 76.0 75.0 76.0 116.0 74.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#4] audio-oscillator Cycles:10 Average:90.40 Median:82.00 stddev:12.55 (15.3%) stddev-sans-first:13.03 08:29:34 INFO - PROCESS | 28705 | Values: 83.0 86.0 115.0 82.0 83.0 82.0 103.0 82.0 82.0 106.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:118.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 08:29:34 INFO - PROCESS | 28705 | Values: 117.0 117.0 117.0 118.0 117.0 118.0 117.0 118.0 118.0 118.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:147.50 stddev:1.07 (0.7%) stddev-sans-first:1.12 08:29:34 INFO - PROCESS | 28705 | Values: 147.0 147.0 149.0 149.0 148.0 149.0 147.0 147.0 146.0 147.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.06 (1.1%) stddev-sans-first:1.12 08:29:34 INFO - PROCESS | 28705 | Values: 96.0 98.0 97.0 96.0 96.0 95.0 95.0 98.0 96.0 96.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#8] json-parse-financial Cycles:10 Average:52.70 Median:52.00 stddev:1.70 (3.3%) stddev-sans-first:1.79 08:29:34 INFO - PROCESS | 28705 | Values: 52.0 52.0 51.0 52.0 53.0 57.0 52.0 54.0 52.0 52.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#9] json-stringify-tinderbox Cycles:10 Average:59.80 Median:60.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 08:29:34 INFO - PROCESS | 28705 | Values: 60.0 60.0 60.0 60.0 60.0 60.0 59.0 59.0 60.0 60.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#10] stanford-crypto-aes Cycles:10 Average:80.50 Median:80.50 stddev:1.08 (1.3%) stddev-sans-first:1.13 08:29:34 INFO - PROCESS | 28705 | Values: 80.0 81.0 80.0 81.0 79.0 80.0 83.0 81.0 80.0 80.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#11] stanford-crypto-ccm Cycles:10 Average:135.80 Median:135.00 stddev:10.65 (7.9%) stddev-sans-first:10.92 08:29:34 INFO - PROCESS | 28705 | Values: 128.0 126.0 134.0 135.0 139.0 129.0 129.0 135.0 163.0 140.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:170.00 stddev:2.10 (1.2%) stddev-sans-first:2.20 08:29:34 INFO - PROCESS | 28705 | Values: 169.0 173.0 172.0 166.0 168.0 169.0 169.0 172.0 170.0 170.0 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:66.00 stddev:4.30 (6.5%) stddev-sans-first:4.51 08:29:34 INFO - PROCESS | 28705 | Values: 66.0 78.0 73.0 66.0 66.0 66.0 66.0 66.0 65.0 65.0 08:29:34 INFO - PROCESS | 28705 | -------- Summary: end -------- 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000C,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | 08:29:34 INFO - PROCESS | 28705 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 08:29:34 INFO - PROCESS | 28705 | 08:29:35 INFO - TEST-INFO | 28705: exit 0 08:29:35 INFO - TEST-OK | kraken | took 61940ms 08:29:35 INFO - SUITE-END | took 1174s 08:29:35 INFO - Completed test suite (00:19:34) 08:29:35 INFO - javascript benchmark 08:29:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7161.938888057801, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2979.7765167612433, 2995.7453616442604, 3010.3076292452733, 3010.81935083895, 3032.302570408806, 5226.477352264772, 5236.607254455912, 5369.194620806881, 5369.5167434930845, 5385.246065550821, 5314.548263397616, 5324.866878328034, 5337.919931201035, 5342.358916929964, 5390.0, 4783.736894470802, 4870.756462176877, 4931.334269873557, 4938.283948827436, 4983.775730092155, 4994.150994330972, 5014.398272207341, 5052.570531504826, 5063.645544811865, 5066.797328106872, 4767.475577686451, 4777.140114779339, 4794.232922732346, 4795.448523419782, 4982.825601103962, 4827.179379505457, 4831.516848315176, 4834.081524510332, 4873.31773551703, 4880.072786170652, 4766.428028636551, 4810.494898035726, 4815.349927759743, 4819.08437396897, 4863.537963893425, 5211.24436956643, 5237.73811309433, 5262.736863156827, 5344.759485823109, 5370.060239458079, 5780.826575202751, 5781.364049954502, 5800.390958949334, 5841.766329346821, 5863.912041319383, 5802.912956305617, 5813.215215945877, 5820.534357251409, 5821.970890145564, 5836.124581312837, 5258.50044245796, 5277.604179686462, 5359.758810853521, 5374.355077390699, 5378.435264297232, 5797.304323481125, 5853.88292234153, 5855.033919403336, 5884.264466941632, 5957.49361304294, 5607.355154157242, 5648.4633959773755, 5660.830175094754, 5661.716914154275, 5666.603337766317, 5557.916631250535, 5591.776328946797, 5672.716364181774, 5731.656100633975, 5741.540676745851, 5574.1917421973585, 5626.1842032905, 5647.0, 5675.347335056439, 5754.223179870748, 5660.801871934463, 5672.858178545569, 5678.4605462480995, 5679.346875109332, 5680.6307590007345, 4307.56924307573, 4364.9127017460105, 4396.340548917624, 4401.6698747594055, 4444.777761111932, 3885.86399476017, 3914.647681708603, 3925.293447179535, 3927.1752931884625, 3999.5000624921886, 5281.9207711884355, 5292.867678308073, 5389.568834493231, 5405.21624364465, 5406.783728650888, 5749.8275051748515, 5750.2237197978575, 5760.049591817387, 5760.53915686744, 5792.507636850831, 5203.14148165556, 5205.115130427761, 5264.499872512105, 5272.525472707474, 5276.3932147802725, 4779.641526885497, 4784.210605250164, 4788.449328327218, 4841.0, 4892.486288939681, 5840.415958404211, 5866.472017518444, 5870.6771127587535, 5876.941230587639, 5914.378990205966, 5596.356419011866, 5638.633488823213, 5708.687001989649, 5722.084466485342, 5734.684592347294, 5986.461218490357, 5992.0712289595185, 5995.88008239824, 6048.939510604838, 6049.606775559574, 5621.634593751393, 5666.914996274977, 5680.517156041617, 5686.60193786431, 5708.143778433268, 5561.277033985556, 5607.80372686954, 5653.3781284057895, 5722.885542289047, 5759.193712880116, 5569.749361278671, 5629.099344104923, 5638.661680299195, 5692.943070569241, 5706.115552089433, 5589.580781441489, 5602.1036634138345, 5606.0, 5606.24315717373, 5626.24045753818, 5330.8933821324135, 5396.64921780083, 5537.7784888604, 5539.7784088636, 5576.470235327637, 5659.179418984307, 5674.375818659862, 5682.3465301489205, 5688.061469857427, 5746.827595172152, 5524.116141417354, 5560.944390556205, 5570.387257401763, 5576.498115169654, 5603.991281569357], "value": 5266.93924853137, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [541.6100407706452, 571.1518395183153, 587.2277954489847, 587.2453896742686, 589.5195415736175, 34909.650903490954, 35850.64149358509, 35884.28231435373, 42420.0, 43550.0, 46209.76895115528, 46478.30282545764, 46753.53246467534, 46871.0, 46950.53049469504, 8774.429662071976, 8840.160184782468, 8921.732348029569, 8927.95536022319, 8931.64273429062, 8737.21365077143, 8853.42452740573, 8885.333599980027, 8896.733098007071, 8915.866262006075, 8878.911210887873, 8960.417572857743, 8985.550722463884, 8985.730428087169, 8987.0563590823, 8783.560821958908, 8807.955960220223, 8859.424137431046, 8873.378863479527, 8877.112288771135, 8764.298856091498, 8769.298456123495, 8783.253423459013, 8789.912100879037, 8822.602982865787, 42965.140697186194, 43038.56961430377, 43385.56614433847, 43513.12973740508, 43660.345094823606, 3355.060583036729, 3415.55597772288, 3438.8108654024018, 3532.5407696999227, 3823.298632108713, 32263.193420164447, 32400.18999525007, 32439.83780081108, 32952.505712414335, 33185.336293274, 3929.155231625186, 3942.093318536724, 4335.393044973706, 4384.079343337903, 4426.513083560838, 326550.0, 326749.0, 328004.0, 328756.9999999976, 329483.0, 60053.0, 60441.0, 60489.69755151196, 60592.69703651542, 60642.17477591916, 37559.81220093882, 38156.6184338153, 38160.427593586115, 38326.61673383231, 63134.36865631285, 16392.590185245226, 16620.833791661928, 16638.667226655398, 16723.749143762852, 16725.91637041807, 12627.242365458102, 12657.240565566095, 12675.556355527513, 12691.0, 12721.93639031799, 18704.345347912757, 18820.435386938414, 18992.905035474734, 19038.33365832189, 19316.0, 6936.306369363124, 6981.2669669683955, 7011.404030657452, 7248.96375518119, 7260.273972602803, 888.5690440136528, 951.3388195204267, 960.2270172511196, 980.6028558433845, 1026.1277913773233, 29964.250893727396, 30039.699603004126, 30072.0, 31504.0, 31538.0, 1047.5547892145808, 1075.9246852720391, 1078.1105587889865, 1078.784243151373, 1103.5309993252836, 16254.75617865733, 16449.753253701205, 16604.25280862364, 16920.492385228463, 16924.746128808078, 521632.0, 524718.0, 526848.0, 529499.0, 531017.0, 57092.429075709544, 57692.42307576955, 57779.0, 57785.422145778844, 57841.710791445774, 1193.540486912545, 1215.3740823475916, 1246.8005119180887, 1260.8802163794426, 1300.6163181861373, 29595.260118497208, 29944.850275748482, 30243.197448420564, 30421.543676844423, 30616.234594134436, 50466.49533504618, 51098.0, 51253.7437312811, 51460.485395145566, 51571.22643160431, 421511.0, 423546.0, 424402.0, 424810.0, 425395.0, 28357.0, 28428.715712842608, 28561.857190713912, 28814.423711526073, 29064.273393164494, 46838.0, 47006.52993470158, 47171.52828471671, 47313.0, 47802.043959119925, 39600.80199598984, 40136.59863401329, 40170.1965960685, 40667.79666101769, 42054.0, 38675.90791261033, 39848.0, 40449.595504044584, 41407.792961035004, 41879.7906010468, 40499.3925091118, 42090.0, 42372.0, 42857.57142428661, 42892.571074288855, 31832.8408357966, 35237.64762352344, 38615.613843862324, 39156.412653809646, 39248.80375598104, 28169.71830281671, 28560.714392855807, 28667.139985799626, 28681.0, 28791.280217994718], "value": 19655.476974133882, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.9216156768647, 397.38207087978185, 397.5249576755777, 406.30319002910005, 420.3736432715255, 15976.600584985381, 16100.597485062879, 18052.90973545132, 19616.411507654757, 19633.803661963393, 11694.766104677901, 11963.102767292467, 12299.569515066974, 12321.753564928697, 19617.0, 5009.098362294794, 5214.348206474191, 5224.138017227172, 5262.947370526284, 5268.0517506848755, 5158.174692049273, 5246.449122842104, 5553.972230138844, 5807.0998995155815, 5824.941750582482, 5873.236479257691, 5873.970630146843, 5889.116632505137, 5889.146073819294, 5900.144479050535, 5528.640638358514, 5805.564582656318, 5807.2450581424355, 5821.446962538552, 5884.882302353929, 5561.916571251434, 5712.542996560265, 5722.084466485342, 5722.513586345166, 5751.597388182829, 13224.603261902159, 13546.187228766306, 13586.320683965761, 13588.25264610446, 13593.932030339785, 2164.826813854888, 2274.420022894168, 2403.471236328005, 2566.961495577568, 2710.9969311354726, 9897.950510247403, 9999.350042247303, 10100.444475553842, 10228.284020118595, 10245.334053286588, 1806.66576683314, 1868.0, 1877.896715680637, 1909.809019098079, 1915.4062240705425, 83165.0, 84748.57625711894, 87305.0, 89353.55323223407, 89358.10641893563, 11021.944890275498, 11203.215774895842, 11215.887841121485, 11350.829737553944, 11372.531377929645, 15925.362985480682, 15929.769832223497, 15932.203389830462, 15974.92012539953, 15980.520584382488, 7754.263344982331, 7863.72476963315, 8032.357411407073, 8104.1085480597085, 8153.22544358285, 7655.923440765632, 7784.143744188134, 7947.284744372919, 8039.075506316732, 8081.434299598972, 4706.1999460091865, 4829.855104346875, 4835.879103022382, 4842.080004799147, 4939.357883475125, 1968.2717394563817, 1997.3608445297657, 2004.9699254511195, 2016.385002574229, 2019.2932473634405, 826.3636999510463, 906.9863952040592, 928.0765638190044, 957.3394357893031, 968.4092703450889, 17924.551886202687, 18490.537736556693, 18520.81479185218, 18540.721889171673, 18843.152058157415, 936.5925822267335, 940.1162906867522, 965.285688590438, 973.2700474644017, 980.1919542577139, 10192.949035254776, 10323.122534584494, 10360.740981475372, 10421.53103110362, 10510.211734119819, 351967.36228463764, 357718.0, 494284.0, 496027.0, 502752.0, 56716.88041663754, 103128.0, 103613.0, 104837.0, 105639.43605639528, 1014.1785154025263, 1045.5765415006933, 1047.7537778621866, 1095.8739744929276, 1100.818364969771, 16796.328146873988, 16885.662286754443, 17493.737593935846, 17642.647147057243, 17647.647047059243, 35019.47470787889, 40422.0, 42011.57988420199, 42732.0, 43371.56628433675, 56914.14628780654, 59935.40064599298, 61235.0, 61637.07544386748, 61686.0, 7657.4256930731535, 7716.189800070912, 8047.678092876219, 8471.66113355459, 8523.48859068458, 9222.306862813013, 13187.53843615469, 13355.799663005257, 13450.26023568713, 13971.30143492801, 11792.115591330514, 11988.940055299669, 12136.271823690608, 12151.75696486083, 12529.122961392615, 6740.494462915399, 8354.749357519284, 11611.5355385787, 11881.643550693147, 11973.521059157536, 11510.884891150981, 12008.159428839897, 12140.575079872162, 12154.392280385768, 12459.93770031144, 7759.68961241544, 7864.606769661608, 7874.448788584744, 7892.644830982505, 8027.438079334391, 10670.359778413009, 11492.310461372344, 11509.597164099216, 11618.535258589562, 11932.642020739391], "value": 8878.337458183534, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1453.4622189789777, 1499.7900293958844, 1602.6874759421917, 1717.6650553142135, 1743.7558741776145, 7877.0, 8240.340772738182, 8618.741437756862, 9193.172614464696, 9243.53782310885, 8590.570471476432, 8935.463872167675, 8940.0, 9115.407498512592, 9133.634654613825, 2396.2332053742807, 2396.400899775052, 2417.7944874685586, 2424.0788500369836, 2424.1757802347197, 2413.070967677448, 2416.8066554675584, 2428.4171798768343, 2433.5254625348066, 2436.805055595557, 2401.6277476991095, 2433.7931275841574, 2437.305367970129, 2440.8779561021965, 2453.938651533717, 2385.761423857609, 2389.339409110669, 2399.3042017814814, 2405.9278221653203, 2426.7815896569396, 2334.299710086967, 2344.9296521104393, 2353.7881590656752, 2363.345658039362, 2377.025419577982, 9120.954395228047, 9141.954290228572, 9148.771280717969, 9149.130832570896, 9150.816983660356, 5106.387233531963, 5115.104856650109, 5176.404713457963, 5176.430592634807, 5181.637285390024, 3317.2370354818527, 3342.097633638928, 3412.351653185887, 3433.2275238071484, 3504.3341765064556, 1119.2724728926182, 1164.4294295795085, 1177.9764404711943, 1190.1490434339403, 1190.1668831817763, 12424.937875310656, 12440.688982775413, 12463.875361246362, 12483.438245278985, 12506.124571280105, 4458.799354029076, 4664.55686709762, 4791.305260737174, 4805.879853003703, 4850.95149048512, 10339.844902326471, 10380.636677716244, 10395.584176633001, 10421.9478902605, 10442.63450779219, 5188.8962220755375, 5199.194124910645, 5207.843764687065, 5213.113770658997, 5213.895722085613, 4674.74288914113, 4771.212749896297, 4774.9522504775205, 4818.10864989978, 4846.903061938741, 3873.205992771475, 3960.2277555876326, 3996.2606917720314, 4036.5156181258435, 4050.270951228807, 1229.7540491901655, 1243.8072098824696, 1247.9812802807965, 1250.4560516175493, 1262.4066688656317, 852.2031900173358, 869.6434461870602, 875.7460336502343, 891.5943245823134, 901.7520181950016, 5802.390748971382, 5936.673482958478, 5996.2504686914135, 6042.6072305300895, 6165.414285642857, 915.5742579700338, 919.558611866308, 922.4972390047441, 924.8751418558543, 959.9520023998772, 3743.801983365297, 3862.420636904487, 4020.396940458896, 4176.43618111551, 4323.848665296699, 10857.402842843561, 11261.211715180023, 11262.549498020151, 11263.211575189658, 11317.886821131848, 11129.387883666475, 11163.0, 11234.943825280985, 11235.494402751896, 11260.211785174959, 7928.365730741527, 8117.95941020303, 8135.511869287861, 8140.982377202849, 8180.263776260165, 5828.271466066742, 5917.763289468545, 5932.4957378621575, 5943.435373639497, 5987.88024239504, 9621.374610650286, 9809.607615695577, 9923.851142233018, 9975.800483990424, 10019.398836069859, 10198.847017294895, 10209.9489502552, 10219.080282774587, 10228.53971571296, 10247.026532479402, 6911.723531058701, 7125.465590080661, 7409.592472414069, 7438.107427108565, 7518.661660225413, 8444.535550544779, 8804.647814087364, 8844.690435834715, 8852.114788521096, 8880.777980550538, 7466.178720340867, 7506.174320824595, 7703.114141873756, 7784.494007889469, 7792.337651299703, 7820.569868657279, 7877.054753429625, 7885.487443316166, 7987.800304992422, 8037.879431808645, 7133.964330178316, 7180.712771489082, 7180.820479487846, 7191.8561628768175, 7201.243869393638, 4550.954490455053, 4589.632829373709, 4609.723416595015, 4616.584507394351, 4731.787069581808, 4902.656814023127, 4934.753262336941, 4936.481669424658, 5023.899522009467, 5041.563154500949], "value": 4650.651531481643, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.2156481412222, 308.358614082708, 317.1832531232078, 318.69564565839624, 322.8047031545915, 5324.227986941891, 5488.1493368527845, 5497.890042199154, 5549.77800887964, 5558.555315574755, 5371.623986320949, 5476.959377718231, 5506.779728810843, 5509.889802203954, 5511.779528818853, 4288.249556327638, 4302.827886884521, 4323.848665296715, 4339.262325404673, 4345.0, 4132.73137246078, 4242.766647834368, 4271.508776490697, 4322.459692538433, 4348.804303806336, 4208.3687446882905, 4217.36739489076, 4219.641330486897, 4225.957740422603, 4232.682548808836, 4236.555161708007, 4243.469566304212, 4248.9150216995795, 4252.362145678142, 4253.44705188325, 3655.4151335786146, 3753.3244016077097, 3753.6246375362516, 3754.784677040559, 3759.906002349936, 5306.230596563515, 5326.573874090063, 5345.3585569731495, 5352.625316227865, 5356.464353564651, 4866.732329721899, 4868.878278043042, 4873.0, 4925.926111108336, 4932.926006109911, 5591.664500130005, 5694.259746233005, 5728.169415434781, 5792.160136780143, 5806.88386232273, 4100.856470023565, 4101.835926562934, 4105.774182419966, 4109.219248342805, 4136.627703506669, 5981.700914954235, 5998.670073145975, 6022.427869352405, 6027.306859711145, 6059.545534084918, 4095.426640270305, 4236.576342365739, 4239.915201696011, 4244.639205667553, 4251.723637963522, 4273.337632666941, 4284.785760711952, 4297.871063868089, 4298.892527686833, 4305.956940430556, 4916.434610019822, 4919.0, 4920.8769780755765, 4932.816124130183, 4952.8761780955765, 5680.68756218412, 5816.127580862904, 5844.1818145459665, 5854.121881717691, 5856.297244330707, 1451.550019493939, 1474.9041312314664, 1477.6601381682274, 1480.9555713328618, 1485.8365579786214, 900.8603666431713, 942.9297747057002, 942.9811403772023, 953.5518306395983, 966.2511553545918, 4754.595859351924, 4775.498572649891, 4915.090708218991, 4940.925886111711, 4953.504649535018, 5249.790008399621, 5272.2355258487305, 5275.630705850554, 5313.927568248386, 5331.653442526301, 4558.407407037064, 4826.879328016757, 4859.902801944012, 4885.0, 4892.437369702458, 2776.6667999840147, 2778.4304217635336, 2784.3317603775354, 2796.5525515917357, 2811.831290122599, 5369.677819330853, 5374.4625537445945, 5412.350517937873, 5415.781449173905, 5446.863828404322, 5326.307580014573, 5346.690060935096, 5636.589863132827, 6086.9391306087255, 6106.236720409949, 6215.658138802319, 6219.911515484772, 6233.257366758612, 6254.874902501924, 6268.874622507525, 5897.292324921037, 5947.286325640778, 5960.642361458326, 6056.3035250946705, 6077.6961151943115, 5886.440788125121, 5904.409559044233, 5922.851928701644, 5970.223870896929, 6003.189569408249, 6229.56393052482, 6261.96869015652, 6324.494040476843, 6329.335419780857, 6341.207349081365, 3977.3636218204947, 4135.60711732385, 4135.97932010338, 4148.668106551529, 4216.957830421779, 5948.167256583995, 5975.342712301556, 5983.910241346296, 6017.819465416044, 6027.909581356371, 5624.550035997192, 5845.795397161079, 5875.41245875409, 5891.1457838612305, 5913.763449461973, 5721.368170641552, 5738.8278351649515, 5745.1382292656435, 5766.068367096902, 5782.508486778503, 5808.73860676279, 5813.854653633693, 5818.33089194748, 5835.708214589338, 5853.209816674695, 5609.971950140223, 5837.970810146092, 5903.675297858659, 5907.379725128972, 5910.70446477683, 5718.485336319751, 5742.59801813869, 5745.2818397700285, 5746.626469279484, 5794.783095549813], "value": 4317.754121489408, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [737.1007371007372, 764.7361660227222, 772.0503780350166, 791.8495485857686, 831.3972370031728, 13485.190888546695, 14611.634709132277, 14641.19473428961, 14668.486602968886, 14735.189564573944, 13569.0, 13751.174929504237, 13767.862321376782, 13778.655533611665, 13791.793123103136, 623.227198274139, 633.5628416392674, 726.6729971512827, 751.3838652305112, 759.2521366454039, 752.405599576334, 754.6830331260884, 756.648158606248, 758.9810254743647, 759.9164091949881, 798.660569258063, 805.9758207253792, 807.5114555693809, 807.9474834135763, 810.1655295046082, 782.996085019577, 788.8185717284999, 793.3692714292151, 794.2454668065332, 797.2187256488645, 585.1719816459704, 585.4233579923772, 587.8647910980455, 588.3087372337486, 592.2567178191385, 13566.321683915863, 13597.0, 13599.320033998261, 13697.657558561015, 13716.314184290846, 14953.327100280514, 15230.314635841414, 15347.769783453257, 15422.614434639223, 15696.372145114181, 11610.36143012134, 12019.15865889388, 12101.939490302491, 13064.738705225936, 13580.592582222549, 4411.205982923073, 4463.0, 4471.351654010183, 4528.366028755977, 4631.976840115812, 76237.61881190559, 77502.0, 77788.8331675031, 78732.60633696851, 79417.0, 10643.787124257471, 10975.890241097486, 10983.505742241618, 11010.174236932262, 11072.169587280987, 21069.89465052665, 21212.15151393927, 21338.57322853534, 21492.247771328242, 21607.243746468797, 8281.751547453465, 8369.0, 8488.278496327881, 8544.444611100258, 8638.568071596395, 4671.120093183465, 4680.812767489262, 4751.619870410428, 4794.880127996828, 4844.588210002119, 3046.9238269043453, 3136.8902088427253, 3160.3047329587453, 3167.619885613695, 3173.6032995875516, 521.8330134356969, 524.1220954900526, 535.9919601205985, 539.3877948528449, 562.9577781666392, 562.8170844475562, 651.8761435327273, 715.481276074852, 716.6846587501483, 755.1466842467976, 9756.756081098029, 9871.555779989918, 9977.850332245021, 10083.19334453242, 10224.539895704711, 574.9223854779635, 632.9620222786648, 682.9351211634887, 700.6076597105637, 720.052258640387, 4471.977640111779, 4652.1626107300335, 4683.6721429500285, 4695.178343789823, 4714.787834547454, 70111.0, 97728.0, 125829.37085314514, 127370.0, 132799.0, 107239.39140912892, 108807.45596271969, 109929.0, 110389.9999999984, 110910.44544777225, 94397.0, 94877.0, 95599.0, 96454.51772741231, 97371.51314243383, 8519.616617252115, 8526.147385261424, 8558.871616925875, 8662.956685216534, 8787.384883058125, 52276.73861630668, 53230.0, 53831.192532111265, 54030.45969540411, 54313.45686543242, 72597.27402725905, 76509.61745191239, 80046.0, 81700.59149704213, 82967.58516207381, 11235.325880447199, 11544.538218471504, 11566.826497602711, 11760.176787624785, 12097.637070887888, 12298.938505307417, 12357.25856448616, 12682.302473364054, 12892.419841106985, 13295.335233238106, 12308.938455307667, 12507.93746031264, 12805.74388512206, 12898.548550801052, 13214.207147571176, 11716.753501455862, 12144.817827732768, 12453.315067671365, 12501.374931253582, 12753.171043882117, 11893.76212475763, 12306.876931230574, 12471.314077725448, 12611.0, 12923.35383230816, 10230.846537301797, 10483.056524912794, 10564.366138031743, 10660.413677247825, 10839.729006774578, 10317.896821031694, 10522.0, 10622.946885265525, 10711.732206694895, 10726.731831703957], "value": 7311.313822989326, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1510.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 112.0, 114.0, 112.0, 113.0, 113.0, 112.0, 111.0, 112.0, 111.0], "value": 111.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 126.0, 120.0, 176.0, 120.0, 120.0, 120.0, 119.0, 151.0, 122.0], "value": 132.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 164.0, 175.0, 162.0, 165.0, 164.0, 164.0, 162.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 78.0, 77.0, 112.0, 77.0, 76.0, 75.0, 76.0, 116.0, 74.0], "value": 83.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 86.0, 115.0, 82.0, 83.0, 82.0, 103.0, 82.0, 82.0, 106.0], "value": 90.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 118.0, 117.0, 118.0, 117.0, 118.0, 118.0, 118.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 149.0, 149.0, 148.0, 149.0, 147.0, 147.0, 146.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 98.0, 97.0, 96.0, 96.0, 95.0, 95.0, 98.0, 96.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 52.0, 51.0, 52.0, 53.0, 57.0, 52.0, 54.0, 52.0, 52.0], "value": 52.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0, 60.0, 60.0], "value": 59.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 81.0, 79.0, 80.0, 83.0, 81.0, 80.0, 80.0], "value": 80.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 126.0, 134.0, 135.0, 139.0, 129.0, 129.0, 135.0, 163.0, 140.0], "value": 135.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 173.0, 172.0, 166.0, 168.0, 169.0, 169.0, 172.0, 170.0, 170.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 78.0, 73.0, 66.0, 66.0, 66.0, 66.0, 66.0, 65.0, 65.0], "value": 67.7, "unit": "score"}]}]} 08:29:35 INFO - Return code: 0 08:29:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:29:35 ERROR - # TBPL SUCCESS # 08:29:35 INFO - Running post-action listener: _resource_record_post_action 08:29:35 INFO - [mozharness: 2016-09-20 15:29:35.492257Z] Finished run-tests step (success) 08:29:35 INFO - Running post-run listener: _resource_record_post_run 08:29:35 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 4096; Write bytes: 392503296; Read time: 4; Write time: 259944 08:29:35 INFO - TinderboxPrint: CPU usage
13.3% 08:29:35 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 4 08:29:35 INFO - TinderboxPrint: I/O write bytes / time
392,503,296 / 259,944 08:29:35 INFO - TinderboxPrint: CPU idle
8,236.0 (86.6%) 08:29:35 INFO - TinderboxPrint: CPU user
1,208.4 (12.7%) 08:29:35 INFO - TinderboxPrint: Swap in / out
0 / 0 08:29:35 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 103743488; Read time: 0; Write time: 87692 08:29:35 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 288419840; Read time: 0; Write time: 172248 08:29:36 INFO - Running post-run listener: _upload_blobber_files 08:29:36 INFO - Blob upload gear active. 08:29:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:29:36 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 08:29:36 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', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:29:36 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 -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:29:36 INFO - (blobuploader) - INFO - Open directory for files ... 08:29:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 08:29:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 08:29:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:37 INFO - (blobuploader) - INFO - Done attempting. 08:29:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:29:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:29:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:40 INFO - (blobuploader) - INFO - Done attempting. 08:29:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 08:29:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:29:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:29:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 08:29:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:29:41 INFO - (blobuploader) - INFO - Done attempting. 08:29:41 INFO - (blobuploader) - INFO - Iteration through files over. 08:29:41 INFO - Return code: 0 08:29:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:29:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:29:41 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ee69e63543f5456abf4114fe73b1ad621f50b031e2a5c3d6be4dfcafcc1bbd9ce4ac5ed3dc5f583946e937535e1d3d21158fe69dae4e8a2b047fa7a4f416264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9efb09b97271eedb290713cf3bbc9792188f42d069a47ad0f681324dd1a99fd092c847119d83ec2591415905a8ff9642177721e0b9866e7c7bad79a3fd751d19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8eeffcbe6136093a3726ad8709b37a23073a0184aeaa360a1d28db13155a422191fea5cf7e72d1831c31cf68cc26a812384e23b6517a9ff2da627e84e5fbd09d"} 08:29:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:29:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:29:41 INFO - Contents: 08:29:41 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ee69e63543f5456abf4114fe73b1ad621f50b031e2a5c3d6be4dfcafcc1bbd9ce4ac5ed3dc5f583946e937535e1d3d21158fe69dae4e8a2b047fa7a4f416264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9efb09b97271eedb290713cf3bbc9792188f42d069a47ad0f681324dd1a99fd092c847119d83ec2591415905a8ff9642177721e0b9866e7c7bad79a3fd751d19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8eeffcbe6136093a3726ad8709b37a23073a0184aeaa360a1d28db13155a422191fea5cf7e72d1831c31cf68cc26a812384e23b6517a9ff2da627e84e5fbd09d"} 08:29:41 INFO - Running post-run listener: copy_logs_to_upload_dir 08:29:41 INFO - Copying logs to upload dir... 08:29:41 INFO - mkdir: /builds/slave/test/build/upload/logs 08:29:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.012881 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-09-20 08:29:41.884917) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 08:29:41.888116) ========= 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=923d835db2ba3686ebe126b700000192-1474384144.980981-851266606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ee69e63543f5456abf4114fe73b1ad621f50b031e2a5c3d6be4dfcafcc1bbd9ce4ac5ed3dc5f583946e937535e1d3d21158fe69dae4e8a2b047fa7a4f416264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9efb09b97271eedb290713cf3bbc9792188f42d069a47ad0f681324dd1a99fd092c847119d83ec2591415905a8ff9642177721e0b9866e7c7bad79a3fd751d19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8eeffcbe6136093a3726ad8709b37a23073a0184aeaa360a1d28db13155a422191fea5cf7e72d1831c31cf68cc26a812384e23b6517a9ff2da627e84e5fbd09d"} build_url:https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011262 build_url: 'https://queue.taskcluster.net/v1/task/OpKaR8B7TH2wTmQvagyifQ/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ee69e63543f5456abf4114fe73b1ad621f50b031e2a5c3d6be4dfcafcc1bbd9ce4ac5ed3dc5f583946e937535e1d3d21158fe69dae4e8a2b047fa7a4f416264", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/9efb09b97271eedb290713cf3bbc9792188f42d069a47ad0f681324dd1a99fd092c847119d83ec2591415905a8ff9642177721e0b9866e7c7bad79a3fd751d19", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/8eeffcbe6136093a3726ad8709b37a23073a0184aeaa360a1d28db13155a422191fea5cf7e72d1831c31cf68cc26a812384e23b6517a9ff2da627e84e5fbd09d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-20 08:29:41.917746) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 08:29:41.918073) ========= 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=923d835db2ba3686ebe126b700000192-1474384144.980981-851266606 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004423 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-20 08:29:42.000593) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 08:29:42.003992) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-20 08:29:42.004311) ========= ========= Total master_lag: 0.18 =========