builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-030 starttime: 1470794245.24 results: success (0) buildid: 20160809175018 builduid: 31cae4c8e02c417ab3f9719637ec1b62 revision: df29bfbb6d10d6c5451abd2bfed40c6470ab7161 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:25.240857) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:25.241448) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:25.241751) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:25.260524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:25.260980) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 18:57:25-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.7M=0s 2016-08-09 18:57:25 (46.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096559 ========= master_lag: 0.04 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:25.394338) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:25.394624) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020593 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:25.450221) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 18:57:25.450591) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df29bfbb6d10d6c5451abd2bfed40c6470ab7161 --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 df29bfbb6d10d6c5451abd2bfed40c6470ab7161 --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=4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 18:57:25,735 truncating revision to first 12 chars 2016-08-09 18:57:25,736 Setting DEBUG logging. 2016-08-09 18:57:25,736 attempt 1/10 2016-08-09 18:57:25,736 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df29bfbb6d10?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 18:57:26,724 unpacking tar archive at: fx-team-df29bfbb6d10/testing/mozharness/ program finished with exit code 0 elapsedTime=1.381183 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-09 18:57:26.847933) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:26.848282) ========= script_repo_revision: df29bfbb6d10d6c5451abd2bfed40c6470ab7161 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:26.848703) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:26.851248) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 18:57:26.864045) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-09 18:57:26.864350) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:57:27 INFO - MultiFileLogger online at 20160809 18:57:27 in /builds/slave/test 18:57:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 18:57:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:57:27 INFO - {'append_to_log': False, 18:57:27 INFO - 'base_work_dir': '/builds/slave/test', 18:57:27 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 18:57:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:57:27 INFO - 'branch': 'Fx-Team-Non-PGO', 18:57:27 INFO - 'buildbot_json_path': 'buildprops.json', 18:57:27 INFO - 'config_files': ('talos/linux_config.py',), 18:57:27 INFO - 'default_actions': ('clobber', 18:57:27 INFO - 'read-buildbot-config', 18:57:27 INFO - 'download-and-extract', 18:57:27 INFO - 'populate-webroot', 18:57:27 INFO - 'create-virtualenv', 18:57:27 INFO - 'install', 18:57:27 INFO - 'run-tests'), 18:57:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:57:27 INFO - 'download_minidump_stackwalk': True, 18:57:27 INFO - 'download_symbols': 'ondemand', 18:57:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:57:27 INFO - 'tooltool.py': '/tools/tooltool.py', 18:57:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:57:27 INFO - '/tools/misc-python/virtualenv.py')}, 18:57:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:57:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:57:27 INFO - 'installer_path': 'installer.exe', 18:57:27 INFO - 'log_level': 'info', 18:57:27 INFO - 'log_name': 'talos', 18:57:27 INFO - 'log_to_console': True, 18:57:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:57:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:57:27 INFO - 'opt_config_files': (), 18:57:27 INFO - 'pip_index': False, 18:57:27 INFO - 'sps_profile': False, 18:57:27 INFO - 'sps_profile_interval': 0, 18:57:27 INFO - 'suite': 'dromaeojs-e10s', 18:57:27 INFO - 'system_bits': '32', 18:57:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:57:27 INFO - 'title': 'talos-linux64-ix-030', 18:57:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:57:27 INFO - 'use_talos_json': True, 18:57:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:57:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:57:27 INFO - 'work_dir': 'build'} 18:57:27 INFO - [mozharness: 2016-08-10 01:57:27.241320Z] Running clobber step. 18:57:27 INFO - Running pre-action listener: _resource_record_pre_action 18:57:27 INFO - Running main action method: clobber 18:57:27 INFO - rmtree: /builds/slave/test/build 18:57:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:57:27 INFO - Running post-action listener: _resource_record_post_action 18:57:27 INFO - [mozharness: 2016-08-10 01:57:27.703939Z] Finished clobber step (success) 18:57:27 INFO - [mozharness: 2016-08-10 01:57:27.704043Z] Running read-buildbot-config step. 18:57:27 INFO - Running pre-action listener: _resource_record_pre_action 18:57:27 INFO - Running main action method: read_buildbot_config 18:57:27 INFO - Using buildbot properties: 18:57:27 INFO - { 18:57:27 INFO - "project": "", 18:57:27 INFO - "product": "firefox", 18:57:27 INFO - "script_repo_revision": "production", 18:57:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 18:57:27 INFO - "repository": "", 18:57:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 18:57:27 INFO - "buildid": "20160809175018", 18:57:27 INFO - "pgo_build": "False", 18:57:27 INFO - "basedir": "/builds/slave/test", 18:57:27 INFO - "buildnumber": 1518, 18:57:27 INFO - "slavename": "talos-linux64-ix-030", 18:57:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 18:57:27 INFO - "platform": "ubuntu64_hw", 18:57:27 INFO - "scheduler": "tests-fx-team-linux64-talos-7-3600", 18:57:27 INFO - "branch": "fx-team", 18:57:27 INFO - "repo_path": "integration/fx-team", 18:57:27 INFO - "revision": "df29bfbb6d10d6c5451abd2bfed40c6470ab7161", 18:57:27 INFO - "stage_platform": "linux64", 18:57:27 INFO - "builduid": "31cae4c8e02c417ab3f9719637ec1b62", 18:57:27 INFO - "slavebuilddir": "test" 18:57:27 INFO - } 18:57:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 18:57:27 INFO - Running post-action listener: _resource_record_post_action 18:57:27 INFO - [mozharness: 2016-08-10 01:57:27.706802Z] Finished read-buildbot-config step (success) 18:57:27 INFO - [mozharness: 2016-08-10 01:57:27.706892Z] Running download-and-extract step. 18:57:27 INFO - Running pre-action listener: _resource_record_pre_action 18:57:27 INFO - Running main action method: download_and_extract 18:57:27 INFO - mkdir: /builds/slave/test/build/tests 18:57: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')]} 18:57:27 INFO - trying https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:57:27 INFO - Downloading https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:57:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:57:28 INFO - Downloaded 1361 bytes. 18:57:28 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 18:57:28 INFO - Using the following test package requirements: 18:57:28 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:57:28 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:57:28 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:57:28 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:28 INFO - u'jsshell-linux-x86_64.zip'], 18:57:28 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:57:28 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 18:57:28 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:57:28 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:57:28 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:57:28 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 18:57:28 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:57:28 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:57:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:28 INFO - trying https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:57:28 INFO - Downloading https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:57:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:57:29 INFO - Downloaded 20259579 bytes. 18:57:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:57:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:57:30 INFO - Return code: 0 18:57:30 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:57:30 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')]} 18:57:30 INFO - trying https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:57:30 INFO - Downloading https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 18:57:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:57:31 INFO - Downloaded 20259579 bytes. 18:57:31 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:57:31 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:57:32 INFO - Return code: 0 18:57: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')]} 18:57:32 INFO - trying https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:57:32 INFO - Downloading https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 18:57:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:57:33 INFO - Downloaded 14413723 bytes. 18:57:33 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:57:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:57:33 INFO - Return code: 0 18:57:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:33 INFO - trying https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:57:33 INFO - Downloading https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:57:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:57:35 INFO - Downloaded 55610581 bytes. 18:57:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:57:35 INFO - mkdir: /builds/slave/test/properties 18:57:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:57:35 INFO - Writing to file /builds/slave/test/properties/build_url 18:57:35 INFO - Contents: 18:57:35 INFO - build_url:https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 18:57:35 INFO - Running post-action listener: _resource_record_post_action 18:57:35 INFO - Running post-action listener: set_extra_try_arguments 18:57:35 INFO - [mozharness: 2016-08-10 01:57:35.669180Z] Finished download-and-extract step (success) 18:57:35 INFO - [mozharness: 2016-08-10 01:57:35.669417Z] Running populate-webroot step. 18:57:35 INFO - Running pre-action listener: _resource_record_pre_action 18:57:35 INFO - Running main action method: populate_webroot 18:57:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:57:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:57:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:57:35 INFO - '--tppagecycles', 18:57:35 INFO - '7'], 18:57:35 INFO - 'tests': ['tsvgm']}}, 18:57:35 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:57:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:57:35 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:57:35 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:57:35 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:57:35 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:57:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:35 INFO - 'talos_options': ['--disable-e10s'], 18:57:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:57:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:35 INFO - 'talos_options': ['--disable-e10s'], 18:57:35 INFO - 'tests': ['damp', 'tps']}, 18:57:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:35 INFO - 'tests': ['damp', 'tps']}, 18:57:35 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:57:35 INFO - 'tests': ['dromaeo_dom']}, 18:57:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:57:35 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:57:35 INFO - 'tests': ['basic_compositor_video']}, 18:57:35 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:57:35 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:57:35 INFO - 'tests': ['a11yr', 18:57:35 INFO - 'ts_paint', 18:57:35 INFO - 'tpaint', 18:57:35 INFO - 'sessionrestore', 18:57:35 INFO - 'sessionrestore_no_auto_restore', 18:57:35 INFO - 'tabpaint']}, 18:57:35 INFO - 'other-e10s': {'tests': ['a11yr', 18:57:35 INFO - 'ts_paint', 18:57:35 INFO - 'tpaint', 18:57:35 INFO - 'sessionrestore', 18:57:35 INFO - 'sessionrestore_no_auto_restore', 18:57:35 INFO - 'tabpaint']}, 18:57:35 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:57:35 INFO - 'ts_paint', 18:57:35 INFO - 'tpaint', 18:57:35 INFO - 'sessionrestore', 18:57:35 INFO - 'sessionrestore_no_auto_restore', 18:57:35 INFO - 'tabpaint']}, 18:57:35 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:57:35 INFO - 'ts_paint', 18:57:35 INFO - 'tpaint', 18:57:35 INFO - 'sessionrestore', 18:57:35 INFO - 'sessionrestore_no_auto_restore', 18:57:35 INFO - 'tabpaint']}, 18:57:35 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:57:35 INFO - 'tests': ['a11yr', 18:57:35 INFO - 'ts_paint', 18:57:35 INFO - 'tpaint', 18:57:35 INFO - 'sessionrestore', 18:57:35 INFO - 'sessionrestore_no_auto_restore', 18:57:35 INFO - 'tabpaint']}, 18:57:35 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:57:35 INFO - 'tests': ['a11yr', 18:57:35 INFO - 'ts_paint', 18:57:35 INFO - 'tpaint', 18:57:35 INFO - 'sessionrestore', 18:57:35 INFO - 'sessionrestore_no_auto_restore', 18:57:35 INFO - 'tabpaint']}, 18:57:35 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:57:35 INFO - 'tests': ['tsvgx', 18:57:35 INFO - 'tsvgr_opacity', 18:57:35 INFO - 'tart', 18:57:35 INFO - 'tscrollx', 18:57:35 INFO - 'cart']}, 18:57:35 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:57:35 INFO - 'tsvgr_opacity', 18:57:35 INFO - 'tart', 18:57:35 INFO - 'tscrollx', 18:57:35 INFO - 'cart']}, 18:57:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:35 INFO - 'talos_options': ['--disable-e10s'], 18:57:35 INFO - 'tests': ['tp5o']}, 18:57:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:35 INFO - 'tests': ['tp5o']}, 18:57:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:35 INFO - 'talos_options': ['--disable-e10s', 18:57:35 INFO - '--xperf_path', 18:57:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:35 INFO - 'tests': ['tp5n']}, 18:57:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:57:35 INFO - 'talos_options': ['--xperf_path', 18:57:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:57:35 INFO - 'tests': ['tp5n']}}, 18:57:35 INFO - 'talos.zip': {'path': '', 18:57:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:57:35 INFO - Running post-action listener: _resource_record_post_action 18:57:35 INFO - [mozharness: 2016-08-10 01:57:35.684998Z] Finished populate-webroot step (success) 18:57:35 INFO - [mozharness: 2016-08-10 01:57:35.685087Z] Running create-virtualenv step. 18:57:35 INFO - Running pre-action listener: _resource_record_pre_action 18:57:35 INFO - Running main action method: create_virtualenv 18:57:35 INFO - Creating virtualenv /builds/slave/test/build/venv 18:57:35 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 18:57:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:57:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:57:35 INFO - Using real prefix '/usr' 18:57:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:57:36 INFO - Installing distribute.............................................................................................................................................................................................done. 18:57:38 INFO - Installing pip.................done. 18:57:38 INFO - Return code: 0 18:57:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1323030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1570>, '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 0x15e2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e2900>, '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': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', '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 18:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 18:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 18:57:38 INFO - Using env: {'DISPLAY': ':0', 18:57:38 INFO - 'HOME': '/home/cltbld', 18:57:38 INFO - 'LANG': 'en_US.UTF-8', 18:57:38 INFO - 'LANGUAGE': 'en_US:en', 18:57:38 INFO - 'LOGNAME': 'cltbld', 18:57:38 INFO - 'MAIL': '/var/mail/cltbld', 18:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:38 INFO - 'MOZ_NO_REMOTE': '1', 18:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:38 INFO - 'NO_EM_RESTART': '1', 18:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:38 INFO - 'PWD': '/builds/slave/test', 18:57:38 INFO - 'SHELL': '/bin/bash', 18:57:38 INFO - 'SHLVL': '1', 18:57:38 INFO - 'TERM': 'linux', 18:57:38 INFO - 'TMOUT': '86400', 18:57:38 INFO - 'USER': 'cltbld', 18:57:38 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', 18:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:38 INFO - '_': '/tools/buildbot/bin/python'} 18:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:38 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 18:57:38 INFO - Cleaning up... 18:57:38 INFO - Return code: 0 18:57:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1323030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1570>, '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 0x15e2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e2900>, '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': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', '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 18:57:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 18:57:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 18:57:38 INFO - Using env: {'DISPLAY': ':0', 18:57:38 INFO - 'HOME': '/home/cltbld', 18:57:38 INFO - 'LANG': 'en_US.UTF-8', 18:57:38 INFO - 'LANGUAGE': 'en_US:en', 18:57:38 INFO - 'LOGNAME': 'cltbld', 18:57:38 INFO - 'MAIL': '/var/mail/cltbld', 18:57:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:38 INFO - 'MOZ_NO_REMOTE': '1', 18:57:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:38 INFO - 'NO_EM_RESTART': '1', 18:57:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:38 INFO - 'PWD': '/builds/slave/test', 18:57:38 INFO - 'SHELL': '/bin/bash', 18:57:38 INFO - 'SHLVL': '1', 18:57:38 INFO - 'TERM': 'linux', 18:57:38 INFO - 'TMOUT': '86400', 18:57:38 INFO - 'USER': 'cltbld', 18:57:38 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', 18:57:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:38 INFO - '_': '/tools/buildbot/bin/python'} 18:57:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:38 INFO - Downloading/unpacking psutil>=3.1.1 18:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:57:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:40 INFO - Installing collected packages: psutil 18:57:40 INFO - Running setup.py install for psutil 18:57:40 INFO - building 'psutil._psutil_linux' extension 18:57:40 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 18:57:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 18:57:41 INFO - building 'psutil._psutil_posix' extension 18:57:41 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 18:57:41 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 18:57:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:57:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:57:41 INFO - Successfully installed psutil 18:57:41 INFO - Cleaning up... 18:57:41 INFO - Return code: 0 18:57:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1323030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1570>, '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 0x15e2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e2900>, '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': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', '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 18:57:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 18:57:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 18:57:41 INFO - Using env: {'DISPLAY': ':0', 18:57:41 INFO - 'HOME': '/home/cltbld', 18:57:41 INFO - 'LANG': 'en_US.UTF-8', 18:57:41 INFO - 'LANGUAGE': 'en_US:en', 18:57:41 INFO - 'LOGNAME': 'cltbld', 18:57:41 INFO - 'MAIL': '/var/mail/cltbld', 18:57:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:41 INFO - 'MOZ_NO_REMOTE': '1', 18:57:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:41 INFO - 'NO_EM_RESTART': '1', 18:57:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:41 INFO - 'PWD': '/builds/slave/test', 18:57:41 INFO - 'SHELL': '/bin/bash', 18:57:41 INFO - 'SHLVL': '1', 18:57:41 INFO - 'TERM': 'linux', 18:57:41 INFO - 'TMOUT': '86400', 18:57:41 INFO - 'USER': 'cltbld', 18:57:41 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', 18:57:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:41 INFO - '_': '/tools/buildbot/bin/python'} 18:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:57:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:57:43 INFO - Installing collected packages: mozsystemmonitor 18:57:43 INFO - Running setup.py install for mozsystemmonitor 18:57:43 INFO - Successfully installed mozsystemmonitor 18:57:43 INFO - Cleaning up... 18:57:43 INFO - Return code: 0 18:57:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:57: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')]} 18:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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')]} 18:57:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57: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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1323030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1570>, '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 0x15e2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e2900>, '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': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', '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 18:57: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==2.5.1'] in /builds/slave/test/build 18:57: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==2.5.1 18:57:43 INFO - Using env: {'DISPLAY': ':0', 18:57:43 INFO - 'HOME': '/home/cltbld', 18:57:43 INFO - 'LANG': 'en_US.UTF-8', 18:57:43 INFO - 'LANGUAGE': 'en_US:en', 18:57:43 INFO - 'LOGNAME': 'cltbld', 18:57:43 INFO - 'MAIL': '/var/mail/cltbld', 18:57:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:43 INFO - 'MOZ_NO_REMOTE': '1', 18:57:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:43 INFO - 'NO_EM_RESTART': '1', 18:57:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:43 INFO - 'PWD': '/builds/slave/test', 18:57:43 INFO - 'SHELL': '/bin/bash', 18:57:43 INFO - 'SHLVL': '1', 18:57:43 INFO - 'TERM': 'linux', 18:57:43 INFO - 'TMOUT': '86400', 18:57:43 INFO - 'USER': 'cltbld', 18:57:43 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', 18:57:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:43 INFO - '_': '/tools/buildbot/bin/python'} 18:57:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:43 INFO - Downloading/unpacking jsonschema==2.5.1 18:57:43 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 18:57:43 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 18:57:43 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 18:57:43 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 18:57:43 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 18:57:43 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 18:57:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:57:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:57:45 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 18:57:45 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 18:57:45 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 18:57:45 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 18:57:45 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 18:57:45 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 18:57:45 INFO - Downloading functools32-3.2.3-2.tar.gz 18:57:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:57:45 INFO - warning: no files found matching '*.txt' 18:57:45 INFO - no previously-included directories found matching 'build' 18:57:45 INFO - no previously-included directories found matching 'dist' 18:57:45 INFO - no previously-included directories found matching '.git*' 18:57:45 INFO - Installing collected packages: jsonschema, functools32 18:57:46 INFO - Running setup.py install for functools32 18:57:46 INFO - warning: no files found matching '*.txt' 18:57:46 INFO - no previously-included directories found matching 'build' 18:57:46 INFO - no previously-included directories found matching 'dist' 18:57:46 INFO - no previously-included directories found matching '.git*' 18:57:46 INFO - Successfully installed jsonschema functools32 18:57:46 INFO - Cleaning up... 18:57:46 INFO - Return code: 0 18:57:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 18:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1323030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1570>, '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 0x15e2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e2900>, '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': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', '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 18:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 18:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 18:57:46 INFO - Using env: {'DISPLAY': ':0', 18:57:46 INFO - 'HOME': '/home/cltbld', 18:57:46 INFO - 'LANG': 'en_US.UTF-8', 18:57:46 INFO - 'LANGUAGE': 'en_US:en', 18:57:46 INFO - 'LOGNAME': 'cltbld', 18:57:46 INFO - 'MAIL': '/var/mail/cltbld', 18:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:46 INFO - 'MOZ_NO_REMOTE': '1', 18:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:46 INFO - 'NO_EM_RESTART': '1', 18:57:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:46 INFO - 'PWD': '/builds/slave/test', 18:57:46 INFO - 'SHELL': '/bin/bash', 18:57:46 INFO - 'SHLVL': '1', 18:57:46 INFO - 'TERM': 'linux', 18:57:46 INFO - 'TMOUT': '86400', 18:57:46 INFO - 'USER': 'cltbld', 18:57:46 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', 18:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:46 INFO - '_': '/tools/buildbot/bin/python'} 18:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 18:57:46 INFO - Cleaning up... 18:57:46 INFO - Return code: 0 18:57:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1323030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1570>, '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 0x15e2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e2900>, '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': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', '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 18:57:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:57:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 18:57:46 INFO - Using env: {'DISPLAY': ':0', 18:57:46 INFO - 'HOME': '/home/cltbld', 18:57:46 INFO - 'LANG': 'en_US.UTF-8', 18:57:46 INFO - 'LANGUAGE': 'en_US:en', 18:57:46 INFO - 'LOGNAME': 'cltbld', 18:57:46 INFO - 'MAIL': '/var/mail/cltbld', 18:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:46 INFO - 'MOZ_NO_REMOTE': '1', 18:57:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:46 INFO - 'NO_EM_RESTART': '1', 18:57:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:46 INFO - 'PWD': '/builds/slave/test', 18:57:46 INFO - 'SHELL': '/bin/bash', 18:57:46 INFO - 'SHLVL': '1', 18:57:46 INFO - 'TERM': 'linux', 18:57:46 INFO - 'TMOUT': '86400', 18:57:46 INFO - 'USER': 'cltbld', 18:57:46 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', 18:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:46 INFO - '_': '/tools/buildbot/bin/python'} 18:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:46 INFO - Downloading/unpacking blobuploader==1.2.4 18:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:48 INFO - Downloading blobuploader-1.2.4.tar.gz 18:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:57:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:57:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:57:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:57:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:57:49 INFO - Downloading docopt-0.6.1.tar.gz 18:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:57:49 INFO - Installing collected packages: blobuploader, requests, docopt 18:57:49 INFO - Running setup.py install for blobuploader 18:57:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:57:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:57:49 INFO - Running setup.py install for requests 18:57:49 INFO - Running setup.py install for docopt 18:57:49 INFO - Successfully installed blobuploader requests docopt 18:57:49 INFO - Cleaning up... 18:57:49 INFO - Return code: 0 18:57:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:49 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')]} 18:57:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:49 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')]} 18:57:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:49 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 0x1323030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1570>, '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 0x15e2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e2900>, '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': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', '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 18:57:49 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 18:57:49 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 18:57:49 INFO - Using env: {'DISPLAY': ':0', 18:57:49 INFO - 'HOME': '/home/cltbld', 18:57:49 INFO - 'LANG': 'en_US.UTF-8', 18:57:49 INFO - 'LANGUAGE': 'en_US:en', 18:57:49 INFO - 'LOGNAME': 'cltbld', 18:57:49 INFO - 'MAIL': '/var/mail/cltbld', 18:57:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:49 INFO - 'MOZ_NO_REMOTE': '1', 18:57:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:49 INFO - 'NO_EM_RESTART': '1', 18:57:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:49 INFO - 'PWD': '/builds/slave/test', 18:57:49 INFO - 'SHELL': '/bin/bash', 18:57:49 INFO - 'SHLVL': '1', 18:57:49 INFO - 'TERM': 'linux', 18:57:49 INFO - 'TMOUT': '86400', 18:57:49 INFO - 'USER': 'cltbld', 18:57:49 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', 18:57:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:49 INFO - '_': '/tools/buildbot/bin/python'} 18:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:50 INFO - Running setup.py (path:/tmp/pip-R7NHs4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:50 INFO - Running setup.py (path:/tmp/pip-37MK6R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:50 INFO - Running setup.py (path:/tmp/pip-S4RauF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:50 INFO - Running setup.py (path:/tmp/pip-XNYxm2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:50 INFO - Running setup.py (path:/tmp/pip-K_cw3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:50 INFO - Running setup.py (path:/tmp/pip-51JwVA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:50 INFO - Running setup.py (path:/tmp/pip-z5NpSu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:50 INFO - Running setup.py (path:/tmp/pip-l_3hLY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:50 INFO - Running setup.py (path:/tmp/pip-qAfK8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:50 INFO - Running setup.py (path:/tmp/pip-H4BYw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:50 INFO - Running setup.py (path:/tmp/pip-FhszrK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:50 INFO - Running setup.py (path:/tmp/pip-bqiODx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:50 INFO - Running setup.py (path:/tmp/pip-TY0vxK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:51 INFO - Running setup.py (path:/tmp/pip-XW0N7g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:51 INFO - Running setup.py (path:/tmp/pip-SmHp1k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:51 INFO - Running setup.py (path:/tmp/pip-X0kBhF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:51 INFO - Running setup.py (path:/tmp/pip-FGERhC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:57:51 INFO - Running setup.py install for manifestparser 18:57:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:57:51 INFO - Running setup.py install for mozcrash 18:57:51 INFO - Running setup.py install for mozdebug 18:57:51 INFO - Running setup.py install for mozdevice 18:57:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:57:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:57:51 INFO - Running setup.py install for mozfile 18:57:51 INFO - Running setup.py install for mozhttpd 18:57:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:57:51 INFO - Running setup.py install for mozinfo 18:57:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:57:51 INFO - Running setup.py install for mozInstall 18:57:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:57:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:57:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:57:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:57:52 INFO - Running setup.py install for mozleak 18:57:52 INFO - Running setup.py install for mozlog 18:57:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:57:52 INFO - Running setup.py install for moznetwork 18:57:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:57:52 INFO - Running setup.py install for mozprocess 18:57:52 INFO - Running setup.py install for mozprofile 18:57:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:57:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:57:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:57:52 INFO - Running setup.py install for mozrunner 18:57:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:57:52 INFO - Running setup.py install for mozscreenshot 18:57:52 INFO - Running setup.py install for moztest 18:57:52 INFO - Running setup.py install for mozversion 18:57:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:57:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:57:53 INFO - Cleaning up... 18:57:53 INFO - Return code: 0 18:57:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1323030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1570>, '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 0x15e2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e2900>, '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': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', '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 18:57:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 18:57:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 18:57:53 INFO - Using env: {'DISPLAY': ':0', 18:57:53 INFO - 'HOME': '/home/cltbld', 18:57:53 INFO - 'LANG': 'en_US.UTF-8', 18:57:53 INFO - 'LANGUAGE': 'en_US:en', 18:57:53 INFO - 'LOGNAME': 'cltbld', 18:57:53 INFO - 'MAIL': '/var/mail/cltbld', 18:57:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:53 INFO - 'MOZ_NO_REMOTE': '1', 18:57:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:53 INFO - 'NO_EM_RESTART': '1', 18:57:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:53 INFO - 'PWD': '/builds/slave/test', 18:57:53 INFO - 'SHELL': '/bin/bash', 18:57:53 INFO - 'SHLVL': '1', 18:57:53 INFO - 'TERM': 'linux', 18:57:53 INFO - 'TMOUT': '86400', 18:57:53 INFO - 'USER': 'cltbld', 18:57:53 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', 18:57:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:53 INFO - '_': '/tools/buildbot/bin/python'} 18:57:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:57:53 INFO - Running setup.py (path:/tmp/pip-wjLJpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 18:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:57:53 INFO - Running setup.py (path:/tmp/pip-d_ERWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 18:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:57:53 INFO - Running setup.py (path:/tmp/pip-lznYdT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:57:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 18:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:57:53 INFO - Running setup.py (path:/tmp/pip-mfz7Fe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:57:53 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)) 18:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:57:53 INFO - Running setup.py (path:/tmp/pip-ay7B3J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:57:53 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)) 18:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:57:53 INFO - Running setup.py (path:/tmp/pip-nfLD9A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:57:53 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)) 18:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:57:53 INFO - Running setup.py (path:/tmp/pip-f40kzo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:57:53 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)) 18:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:57:53 INFO - Running setup.py (path:/tmp/pip-uCvZAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:57:53 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)) 18:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:57:53 INFO - Running setup.py (path:/tmp/pip-uxs2K8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:57:53 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)) 18:57:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:57:53 INFO - Running setup.py (path:/tmp/pip-2S1aGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:57:54 INFO - Running setup.py (path:/tmp/pip-_hYs8N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 18:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:57:54 INFO - Running setup.py (path:/tmp/pip-83WgmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 18:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:57:54 INFO - Running setup.py (path:/tmp/pip-AF9uzj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 18:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:57:54 INFO - Running setup.py (path:/tmp/pip-YmAmgH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 18:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:54 INFO - Running setup.py (path:/tmp/pip-TEb_Qa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 18:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:57:54 INFO - Running setup.py (path:/tmp/pip-sKRbp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:57:54 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 18:57:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:57:54 INFO - Running setup.py (path:/tmp/pip-M1OELY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:57:54 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)) 18:57:54 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)) 18:57:54 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)) 18:57:54 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)) 18:57:54 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)) 18:57:54 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)) 18:57:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:57:54 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 18:57:54 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 18:57:54 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 18:57:54 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 18:57:54 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 18:57:54 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 18:57:56 INFO - Downloading blessings-1.6.tar.gz 18:57:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:57:56 INFO - Installing collected packages: blessings 18:57:56 INFO - Running setup.py install for blessings 18:57:56 INFO - Successfully installed blessings 18:57:56 INFO - Cleaning up... 18:57:56 INFO - Return code: 0 18:57:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:57:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:56 INFO - Reading from file tmpfile_stdout 18:57:56 INFO - Current package versions: 18:57:56 INFO - argparse == 1.2.1 18:57:56 INFO - blessings == 1.6 18:57:56 INFO - blobuploader == 1.2.4 18:57:56 INFO - docopt == 0.6.1 18:57:56 INFO - functools32 == 3.2.3-2 18:57:56 INFO - jsonschema == 2.5.1 18:57:56 INFO - manifestparser == 1.1 18:57:56 INFO - mozInstall == 1.12 18:57:56 INFO - mozcrash == 0.17 18:57:56 INFO - mozdebug == 0.1 18:57:56 INFO - mozdevice == 0.48 18:57:56 INFO - mozfile == 1.2 18:57:56 INFO - mozhttpd == 0.7 18:57:56 INFO - mozinfo == 0.9 18:57:56 INFO - mozleak == 0.1 18:57:56 INFO - mozlog == 3.3 18:57:56 INFO - moznetwork == 0.27 18:57:56 INFO - mozprocess == 0.23 18:57:56 INFO - mozprofile == 0.28 18:57:56 INFO - mozrunner == 6.12 18:57:56 INFO - mozscreenshot == 0.1 18:57:56 INFO - mozsystemmonitor == 0.3 18:57:56 INFO - moztest == 0.7 18:57:56 INFO - mozversion == 1.4 18:57:56 INFO - psutil == 3.1.1 18:57:56 INFO - requests == 1.2.3 18:57:56 INFO - wsgiref == 0.1.2 18:57:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:56 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 0x1323030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1570>, '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 0x15e2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e2900>, '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': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', '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 18:57:56 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 18:57:56 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 18:57:56 INFO - Using env: {'DISPLAY': ':0', 18:57:56 INFO - 'HOME': '/home/cltbld', 18:57:56 INFO - 'LANG': 'en_US.UTF-8', 18:57:56 INFO - 'LANGUAGE': 'en_US:en', 18:57:56 INFO - 'LOGNAME': 'cltbld', 18:57:56 INFO - 'MAIL': '/var/mail/cltbld', 18:57:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:56 INFO - 'MOZ_NO_REMOTE': '1', 18:57:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:56 INFO - 'NO_EM_RESTART': '1', 18:57:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:56 INFO - 'PWD': '/builds/slave/test', 18:57:56 INFO - 'SHELL': '/bin/bash', 18:57:56 INFO - 'SHLVL': '1', 18:57:56 INFO - 'TERM': 'linux', 18:57:56 INFO - 'TMOUT': '86400', 18:57:56 INFO - 'USER': 'cltbld', 18:57:56 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', 18:57:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:56 INFO - '_': '/tools/buildbot/bin/python'} 18:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 18:57:57 INFO - Cleaning up... 18:57:57 INFO - Return code: 0 18:57:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:57:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 18:57:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:57:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:57:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1323030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14868a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1552400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15e1570>, '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 0x15e2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e2900>, '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': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', '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 18:57:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:57:57 INFO - Using env: {'DISPLAY': ':0', 18:57:57 INFO - 'HOME': '/home/cltbld', 18:57:57 INFO - 'LANG': 'en_US.UTF-8', 18:57:57 INFO - 'LANGUAGE': 'en_US:en', 18:57:57 INFO - 'LOGNAME': 'cltbld', 18:57:57 INFO - 'MAIL': '/var/mail/cltbld', 18:57:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:57:57 INFO - 'MOZ_NO_REMOTE': '1', 18:57:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:57:57 INFO - 'NO_EM_RESTART': '1', 18:57:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:57:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:57:57 INFO - 'PWD': '/builds/slave/test', 18:57:57 INFO - 'SHELL': '/bin/bash', 18:57:57 INFO - 'SHLVL': '1', 18:57:57 INFO - 'TERM': 'linux', 18:57:57 INFO - 'TMOUT': '86400', 18:57:57 INFO - 'USER': 'cltbld', 18:57:57 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', 18:57:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:57:57 INFO - '_': '/tools/buildbot/bin/python'} 18:57:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:57:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:57:57 INFO - Cleaning up... 18:57:57 INFO - Return code: 0 18:57:57 INFO - Running post-action listener: _resource_record_post_action 18:57:57 INFO - Running post-action listener: _start_resource_monitoring 18:57:57 INFO - Starting resource monitoring. 18:57:57 INFO - [mozharness: 2016-08-10 01:57:57.352988Z] Finished create-virtualenv step (success) 18:57:57 INFO - [mozharness: 2016-08-10 01:57:57.353427Z] Running install step. 18:57:57 INFO - Running pre-action listener: _resource_record_pre_action 18:57:57 INFO - Running main action method: install 18:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:57:57 INFO - Reading from file tmpfile_stdout 18:57:57 INFO - Detecting whether we're running mozinstall >=1.0... 18:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:57:57 INFO - Reading from file tmpfile_stdout 18:57:57 INFO - Output received: 18:57:57 INFO - Usage: mozinstall [options] installer 18:57:57 INFO - Options: 18:57:57 INFO - -h, --help show this help message and exit 18:57:57 INFO - -d DEST, --destination=DEST 18:57:57 INFO - Directory to install application into. [default: 18:57:57 INFO - "/builds/slave/test"] 18:57:57 INFO - --app=APP Application being installed. [default: firefox] 18:57:57 INFO - mkdir: /builds/slave/test/build/application 18:57:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:57:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:58:13 INFO - Reading from file tmpfile_stdout 18:58:13 INFO - Output received: 18:58:13 INFO - /builds/slave/test/build/application/firefox/firefox 18:58:13 INFO - Running post-action listener: _resource_record_post_action 18:58:13 INFO - [mozharness: 2016-08-10 01:58:13.676317Z] Finished install step (success) 18:58:13 INFO - [mozharness: 2016-08-10 01:58:13.676660Z] Running run-tests step. 18:58:13 INFO - Running pre-action listener: _resource_record_pre_action 18:58:13 INFO - Running main action method: run_tests 18:58:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:58:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:58:13 INFO - Python 2.7.3 18:58:13 INFO - Return code: 0 18:58:13 INFO - grabbing minidump binary from tooltool 18:58:13 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')]} 18:58:13 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 0x15e1570>, '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 0x15e2470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15e2900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:58:13 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 18:58:13 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 18:58:13 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 18:58:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:58:13 INFO - Return code: 0 18:58:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:58:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:58:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:58:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:58:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:58:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 18:58:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --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 18:58:13 INFO - Using env: {'DISPLAY': ':0', 18:58:13 INFO - 'HOME': '/home/cltbld', 18:58:13 INFO - 'LANG': 'en_US.UTF-8', 18:58:13 INFO - 'LANGUAGE': 'en_US:en', 18:58:13 INFO - 'LOGNAME': 'cltbld', 18:58:13 INFO - 'MAIL': '/var/mail/cltbld', 18:58:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:58:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:58:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:58:13 INFO - 'MOZ_NO_REMOTE': '1', 18:58:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:58:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:58:13 INFO - 'NO_EM_RESTART': '1', 18:58:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:58:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:58:13 INFO - 'PWD': '/builds/slave/test', 18:58:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:58:13 INFO - 'SHELL': '/bin/bash', 18:58:13 INFO - 'SHLVL': '1', 18:58:13 INFO - 'TERM': 'linux', 18:58:13 INFO - 'TMOUT': '86400', 18:58:13 INFO - 'USER': 'cltbld', 18:58:13 INFO - 'XDG_SESSION_COOKIE': '4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248', 18:58:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:58:13 INFO - '_': '/tools/buildbot/bin/python'} 18:58:13 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--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 18:58:13 INFO - mozversion application_buildid: 20160809175018 18:58:13 INFO - mozversion application_changeset: df29bfbb6d10d6c5451abd2bfed40c6470ab7161 18:58:13 INFO - mozversion application_display_name: Nightly 18:58:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:58:13 INFO - mozversion application_name: Firefox 18:58:13 INFO - mozversion application_remotingname: firefox 18:58:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:58:13 INFO - mozversion application_vendor: Mozilla 18:58:13 INFO - mozversion application_version: 51.0a1 18:58:13 INFO - mozversion platform_buildid: 20160809175018 18:58:13 INFO - mozversion platform_changeset: df29bfbb6d10d6c5451abd2bfed40c6470ab7161 18:58:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:58:13 INFO - mozversion platform_version: 51.0a1 18:58:13 INFO - using testdate: 1470794293 18:58:13 INFO - actual date: 1470794293 18:58:13 INFO - starting webserver on 'localhost:58402' 18:58:13 INFO - SUITE-START | Running 2 tests 18:58:13 INFO - TEST-START | dromaeo_css 18:58:13 INFO - operating with platform_type : linux_ 18:58:13 INFO - Initialising browser for dromaeo_css test... 18:58:13 INFO - TEST-INFO | started process 26731 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ5wdJ4/profile http://localhost:58402/getInfo.html) 18:58:18 INFO - PROCESS | 26731 | __metrics Screen width/height:1600/1200 18:58:18 INFO - PROCESS | 26731 | colorDepth:24 18:58:18 INFO - PROCESS | 26731 | Browser inner width/height: 1024/697 18:58:18 INFO - PROCESS | 26731 | __metrics 18:58:19 ERROR - PROCESS | 26731 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 18:58:20 INFO - TEST-INFO | 26731: exit 0 18:58:20 INFO - Browser initialized. 18:58:20 INFO - Running cycle 1/1 for dromaeo_css test... 18:58:20 INFO - TEST-INFO | started process 26852 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ5wdJ4/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:58:31 INFO - PROCESS | 26852 | RSS: Main: 164052992 18:58:31 INFO - PROCESS | 26852 | 18:59:21 INFO - PROCESS | 26852 | 1470794361570 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] 19:01:33 INFO - PROCESS | 26852 | Cycle 1(1): loaded http://localhost:58402/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58402/tests/dromaeo/cssquery-ext.html) 19:01:34 INFO - PROCESS | 26852 | RSS: Main: 166166528 19:01:34 INFO - PROCESS | 26852 | 19:04:37 INFO - PROCESS | 26852 | Cycle 1(1): loaded http://localhost:58402/tests/dromaeo/cssquery-ext.html (next: http://localhost:58402/tests/dromaeo/cssquery-jquery.html) 19:04:37 INFO - PROCESS | 26852 | RSS: Main: 165384192 19:04:37 INFO - PROCESS | 26852 | 19:07:39 INFO - PROCESS | 26852 | Cycle 1(1): loaded http://localhost:58402/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58402/tests/dromaeo/cssquery-mootools.html) 19:07:40 INFO - PROCESS | 26852 | RSS: Main: 168714240 19:07:40 INFO - PROCESS | 26852 | 19:10:42 INFO - PROCESS | 26852 | Cycle 1(1): loaded http://localhost:58402/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58402/tests/dromaeo/cssquery-prototype.html) 19:10:42 INFO - PROCESS | 26852 | RSS: Main: 162906112 19:10:42 INFO - PROCESS | 26852 | 19:13:45 INFO - PROCESS | 26852 | Cycle 1(1): loaded http://localhost:58402/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58402/tests/dromaeo/cssquery-yui.html) 19:13:46 INFO - PROCESS | 26852 | RSS: Main: 165507072 19:13:46 INFO - PROCESS | 26852 | 19:16:49 INFO - PROCESS | 26852 | Cycle 1(1): loaded http://localhost:58402/tests/dromaeo/cssquery-yui.html (next: http://localhost:58402/tests/dromaeo/cssquery-dojo.html) 19:16:49 INFO - PROCESS | 26852 | RSS: Main: 169078784 19:16:49 INFO - PROCESS | 26852 | 19:16:49 INFO - PROCESS | 26852 | __start_tp_report 19:16:49 INFO - PROCESS | 26852 | _x_x_mozilla_page_load 19:16:49 INFO - PROCESS | 26852 | _x_x_mozilla_page_load_details 19:16:49 INFO - PROCESS | 26852 | |i|pagename|runs| 19:16:49 INFO - PROCESS | 26852 | |0;dojo.html;2651.946961060779;2662.5606774882144;2674.1977406777974;2691.098482008527;2705.161399966011;4658.7204767713965;4791.688540244886;4811.783469743861;4830.686005409655;4842.80628774849;4740.76296185191;4778.3549220855175;4805.759712014394;4835.806567737286;4856.708597484154;4333.65330773539;4363.083752411997;4417.249067658506;4422.800973956164;4516.254817955033;4389.144116897206;4423.867283981485;4439.75581343026;4443.422355093833;4447.688661793676;4346.000419903408;4378.058717375779;4384.101259241879;4402.801873915681;4412.227860124482;4409.382686423904;4421.38100665907;4429.756363400012;4461.776911154429;4464.575865292792;4358.193734159191;4381.890452738675;4383.912321753547;4391.231534481453;4411.647068234533;4494.505604383515;4732.550407711262;4771.976140119312;4787.186178349654;4821.083994041121;5119.795208191668;5148.279240906276;5148.3564554430695;5163.199704045879;5190.195519694454;5179.663321884065;5186.481351864821;5190.558802501791;5192.532672059495;5240.764165612519;4652.116097941381;4717.457492388351;4744.1934871072;4760.071786001766;4834.58905992991;5235.73821308933;5236.476352364733;5237.266782650432;5244.554212891947;5254.15933450646;4996.875078123076;5019.824306149268;5021.322121513622;5029.044481548494;5043.041822053798;4893.09477746618;5030.874228144253;5093.770780314895;5096.388433387943;5100.948990510047;5031.0441016206805;5070.087384270867;5070.594352451795;5076.898462030738;5099.515546023122;5038.5969122470115;5041.495850414929;5052.267421223902;5053.0904437200925;5068.4424713281505;4207.663386929038;4347.7826108694435;4388.363687265392;4398.3842262083335;4454.688171827941;3831.1954489557506;3837.002379381381;3838.9424158637644;3859.7877116758846;3884.941725874114;4395.604395604411;4414.536473670282;4435.467743870756;4439;4479.283314669702;4896.143174944371;5069.822556210589;5118.948810511922;5143.048536020848;5219.530242278213;4378.0806030733265;4380.342948557742;4393.6704747144095;4407.911841763147;4410.206162890647;4640.23436133041;4650.930236046462;4653.371794807726;4666.160091183551;4709;4617.792199351037;4740.19416699162;4765.046990601824;4772.379590653193;4830.347903033045;5111.284420181103;5112.514311140436;5135.2553879687985;5135.922961155511;5186.507281808223;4765.189917713928;4774.832880849153;4792.305115758265;4801.4958429365815;4825.541573550507;4844.176489996638;4981.875453113701;5003.374578177728;5012.523810238022;5082.4409314976065;5115.6979359287725;5121.052605268037;5121.180611102355;5136.717480538457;5136.948630513647;4971.502849715;4990.550850423334;4994.225894986283;5000.374953130859;5007.098722230034;4783.856484305337;4926.950730492649;4983.377077865267;5001.1248031593595;5063.265826455217;4847.733374664427;4930.457649658606;4952.950470495249;4976.427710813303;4986.825461108844;5023.949760502348;5025.422076461254;5043.2687260347775;5049.974750126225;5096.0827051131155;4691.788869500949;4806.543378379049;4812.807487700453;4836.854894353175;4864.100141473838 19:16:49 INFO - PROCESS | 26852 | |1;ext.html;546.2734563031169;556.4908109080192;563.9802606908759;571.4942276085665;589.6992533807762;34879.30241395171;39324.213515729665;39411.99999999996;39510.20979580407;39580.406293905544;39563.20873582527;40021.19957600846;40174.19651606966;40211.99999999993;40333.59666403335;7407.518511296776;7517.548947063194;7522.623868806538;7531.359834414081;7532;7645.273698998586;7709.113451953013;7728.343090837286;7735.961320193391;7757.844843103135;7736.535807851519;7745.457817952745;7770.261825126632;7787.532748035108;7796.493227940194;7704.152543220242;7729.033870766154;7759.806004849867;7765.417593680497;7777.261160189773;7654.2345765423015;7681.078270607562;7709.267619576188;7722;7735.265149810759;37680.43479347812;38083;38083.238335233415;38136.618633813865;38236.04409889747;2898.2754311422145;2978.3149875528748;3100.429320721418;3242.691944265291;3252.7235185009304;29429.70570294291;30526;30859;31103.688963110304;33590.83204583961;3442.4492081267126;3497.387957107496;3513.7364697647777;3576.8926932192076;3603.56757189139;259941;263332;263539;263996;265226;33534.329313414084;57362.71318643464;58007.709961449924;58167.418325817045;58403.70798145982;33558.832205838815;34549.654503455145;34810.65189348125;35277.11807204789;35288;14019.158850469004;14179.14925104497;14181.290935453186;14188.148711077369;14197.290135493184;11000.614978475714;11021.724456888482;11024.228304018801;11027.062699670458;11059.447027648584;8010.679572817022;8063.758087257392;8089.3528517719615;8130.75607731769;8190.525705372971;3163.114327988167;3172.5558421820965;3195.376901504231;3196.328770958078;3234.6765323467466;931.2689538712214;977.8288799460066;999.7750506136061;1011.858339832424;1016.8611155505881;28527.57362131885;28552.71447285542;28712.569311460345;29127.27181820429;29465.705342946723;948.5636607160645;977.6382738386842;982.3123813330698;1003.2375394699934;1015.2284263959297;14896.925515372353;15273.923630381776;15483;15583.610409739847;15838.366465341487;399390;405612;406491;406966;409803;50344.49655503471;50998;51037.23444148341;51056.74471627618;51276.48723512792;1181.9349935753444;1196.4615922834585;1212.8605210400917;1223.2232532342027;1223.3149436315691;26617.201483954737;26957.59563606508;28304.716952830207;28395;28767.568486473137;43419;43607.78196108999;43663;43745.56254437415;43806.12387752291;342296;343404;343646;343971;343993;26085.869570652027;26107.477850443265;26153.346166345993;26457.735422645528;26510.337241569116;41843.581564183965;42629.786851065546;43017.569824301354;43264.78367608142;43632.34551481667;34164.316713666085;36128.819355903055;37166.81416593008;37260.627393725714;37959.81020094882;36096.81951590225;36532.269354612225;36598.8170059148;36775.44836827396;36780.81609591935;35435.29129417449;35593.82203089072;36135;36278.8186059068;36589.26821463609;31534.526982095747;33219.66780332166;33538.83230583832;33678.831605842795;33799.15502112368;25038.62442063407;25166.874165629055;25493.3626659335;25531.088082901406;25982.22053338403 19:16:49 INFO - PROCESS | 26852 | |2;jquery.html;347.8765038411364;355.80075157911574;359.79491689736847;360.5025065409734;364.0752488678753;15657.3737050518;16405.179741012947;16929.830701692994;17017.319307227695;17041.318347266126;16066;16925.830741692578;17522.912385438085;17555.82444175558;17630.735538966925;4906.215005599105;5108.770105345268;5113.616478764089;5114.693118412889;5117.5650069744115;3806.8667596634123;5168.147255702805;5803;6057.787977420791;6118.969405152968;6096.969515152418;6114.541409394314;6118.571699981003;6124.295705993801;6133.44798968095;6388.584741991779;6731.225909020427;6752.291009444011;6767.796966091025;6771.593704377753;6223.751049957997;6425.45383642391;6437.871242575122;6479.254885688159;6491.221053473566;21828.23601173967;23353;23646.29061128169;23924.162654307016;24166.395840103964;1923.7499125113645;2116.4179850541072;2516.7105782835024;2619.6856377234662;2666.560017597094;14132.505362312373;14693.412263509446;15098.471553495685;15313.846861531465;15697.843021569866;1813.084392381852;1823.2798044772242;1854.6476169527882;1871.7660292463443;1928.305809908432;78456.21543784546;80193.59903200447;80308.19691803066;81312;83138;15500.844991550166;15752.527424177293;16519.504414867333;16611.169441527876;16755.2460139294;28713.712862871103;28743.56884646732;28765.712342876723;28833;28855.134345969655;8924.375293729507;9163.358564900393;9271.397359171633;9363.90636093644;9549.42703437782;7583.317501424788;7655.349295309961;7721.691132354643;7781.572013539309;7884.566348850868;7680.231976802387;8245.95877020611;8314.542700151429;8339.916600833914;8459.661613535389;1521.6500204952702;1571.2772124822482;1623.123513302827;3040.6959304069414;3391.5251864738957;830.8047608811925;847.4576271186446;882.6866462405753;897.1477096758106;911.6763548940163;16750.74873876893;16764.664706705797;16936.661266774594;17060.541755086757;17428.39000634997;849.9277561407226;871.5685735560938;876.2376732242863;891.5809569502323;895.7088946092546;9363.77309089448;9866.112049915542;9914.45470499115;9919.702408927744;9932.155766759763;399644;405210;406223;406356;409060;72483;75118.62440687761;76045;77193.61403192948;78914.6054269725;917.8026724254318;927.3832901120815;937.3719607862612;955.0497255231089;960.2078285414422;13162.670933226746;15199.31603077842;15656.4520241791;15696.293666784793;15772.842271577596;37148.81425592855;37499.250014999;38125.4281185788;38987.80506097451;39346;50199.24701129413;51122.88771122858;51357.22964155466;51415.48584514107;52717;6718.596884186964;7029.5430796998035;7177.1746249182015;7317.085364329459;7428.9628551856895;8969.641214351614;10125.291229613857;11504.482298296763;11841.763164736829;11914.52341906314;9707.46608936487;9852.064053914866;9911.355761875455;10276.126529245097;10582.100521455455;10489.790204196026;10561.10230630405;10814.567417303535;10945.83581246298;11022.228444008842;9817.361871478332;9990.450525220891;10057.949710251401;10406.47967601632;10582.365058096539;7380.520266182681;7429.294217049372;7532.284432978859;7757.844843103219;8028.157043510348;7868.370530357673;9262.480257502106;10051.095401413908;10255.103060836835;10550.050495455445 19:16:49 INFO - PROCESS | 26852 | |3;mootools.html;1372.0190064104163;1408.5492642354445;1470.720563093013;1648.7444446110858;1719.277903280622;6668.399844014038;7295.708171673126;7421.144713821544;8047.6780928762855;8083.312918401935;7407.925920740791;7576.393888488921;7726.613669316525;7763.184865589116;7763.417743669219;2133.4133113393823;2200.581889441009;2204.0522575292616;2204.64725643897;2218.7226596675414;2138.4440045588103;2174.0542863854193;2191.3206905859233;2198.472366632013;2200.6919031335547;2163.5889181055627;2166.360923527563;2179.3353027326657;2182.8321847811426;2212.037763572843;2061.783512731164;2071.306112452323;2073.5645514441985;2090.216168936649;2091.4039498742936;2074.4917495213767;2136.6474531702406;2154.0952799824113;2157.65477523597;2164.8701077935375;7826.4130190235965;7867.6066196689935;7884;7904.920950790533;7936.4047696423;4569.702969306984;4695.483496815347;4734.739589322586;4736.242201247784;4741.241401375798;2818.2249881282605;2848.8290702557706;2927.443785680714;2928.370400363932;2940.588317635533;859.9398042137053;893.3389291923929;909.0228004894765;926.7590426489094;927.2859897878664;10596.629117980834;10840.67477975662;10866.402347870864;10880.292780969212;10888.945555272252;3963.920721585552;4092.140650463436;4173.8956526087095;4247.68142389322;4251.744895306291;9240.491772952417;9322.440653560809;9323.533823308808;9338.159565639126;9346;4688.882777930579;4725.574698277172;4727.338172655831;4732.73969931657;4733.242681170997;3331.6501767314567;4082.3264161413626;4181.142865712522;4299.634531064832;4306.074194048232;3651.2514934438377;3658.067192865802;3663.8534458621357;3756.586775454698;3762.567304759933;1133.824257240129;1182.4028865422906;1195.4919159357412;1196.0431654676224;1205.2226314027578;756.1417790807363;782.2646712090731;802.6348011654683;829.929455996247;840.8864803251482;5143.8456846294675;5230.215467679803;5252.474752524717;5255.211718242218;5337.653052551572;811.7077851973285;827.1728271728272;866.3199388480012;891.2468963725642;927.4667066436825;3401.727861771052;3614.5120408744483;3621.239539696693;3637.217998130415;3660.103274697663;9478.620855165716;9572.856407153899;9646.951765241269;9718.902810971942;9904.207663386911;9581.473018983883;9654.517274136266;9670.70987870365;9683.467409292556;9694.321397502248;7025.40284075849;7163.391111755455;7370.815729606696;7449.180590135081;7469.7385591504035;4944.406671199479;5046.394432668103;5188.377394712658;5209.426963033988;5211.583073354047;8282.627281772215;8726.127387261224;8941.061188575106;8969.282457403522;9030.096990300917;8432.83134337322;8697.39118261741;8732.039475657546;8739.257163141205;8750.781230469289;5936.703164841654;6525.412712855866;6666.366695163952;6870.828229294108;7068.6112263823925;7523.774286771406;7620.618969051636;7630.542167469969;7632.427567932316;7642.3504002158215;6558.901616475661;6586.077949087035;6700.46396288286;6810.693518791765;6876.587404755731;6425.5502114851515;6486.54594178403;6604.768833090819;6673.666316684049;6725.865482690221;6104.755809767559;6204.472619827366;6211.9689401552705;6212.81361559154;6243.7814676486105;4527.592516673515;4544.590986811203;4639.2113340731485;4643.071385722937;4644.210484217759;4505.144022635689;4535.027263140544;4537.1833070047705;4633.374494443207;4711.528847115261 19:16:49 INFO - PROCESS | 26852 | |4;prototype.html;282.89815666360096;291.71994884910487;295.0381755477144;298.73561897720515;302.6292791330619;4830.492798256185;4937.753112344386;5023.974880125599;5072.72100034498;5089.541941225284;4968.056069346831;4969.254611808231;4982;5000.424951130621;5014.648974571782;3956.3076461619244;3960.722749407543;3974.8807535773826;3985.103351745863;4003.779792111433;3856.2480316338324;3955.3869150281753;3987.182627561343;4006.7595944243294;4012.25773231953;3931.2334094851517;3940.8423663053586;3955.7341650671797;3956.3669812829953;3966.603339666039;3936.8818935431696;3942.231264903345;3962.4254483100076;3983.2830090583684;3984.8804535863683;3525.1539630488496;3534.7702399344216;3535.7701749386206;3536.0728403020157;3539.663731945461;4815.566599006072;4826.662133650646;4880.6171055049645;4907.1657818171;4977.576905962997;4504.414426124616;4514.571115744032;4522.34426008227;4528.43394575678;4528.773561321921;5242.318498595158;5291.444398338196;5291.941611677641;5294.57643388528;5311.990721762892;3745.8127093645207;3813.245906882837;3839.155385815116;3860.8069596520063;3876.4185372194115;5482.600787511768;5493.450654934474;5495.725213739297;5499.642523235977;5510.256115424407;3935.193285376491;3941.3890846918775;3954.861579844749;3964.583718709494;3972.1857019310974;3529.3647143514413;4022.255882661717;4025.1547175092974;4025.376066709665;4040.878773636796;4305.634021108241;4308.18144552534;4308.526062133163;4308.633766129914;4311.9784401077795;5269.235960785742;5278.709670968057;5281.471852814688;5282.656627319212;5285.753554739221;1274.413769665964;1297.4615534553243;1326.303690562443;1326.548973349066;1334.9065565410522;875.843886070381;892.4957399069634;907.3784457646533;913.3697748553477;919.347263442963;4520.18636645407;4529.932051019237;4533.342665313511;4536.546345365437;4538.1377538267625;5357.678539287655;5387.380451248078;5393.514583687408;5393.649412788156;5396.165303796728;4421.911561768747;4536.9092618148115;4548.385967894358;4553.225951588238;4556.863294101182;2455.2756936703713;2506.8370555913807;2537.7462253774474;2540.593505039185;2553.859537725406;4441.267190913463;4466.352378905106;4473.329000649928;4474.105178964155;4478.2610869206865;4808.134535783593;4826.469088400273;4832.685875418087;4868.391451068616;4872.537108974641;4672.042231342634;5039.269305950616;5090.949090509048;5099.566536844335;5127.1540195867265;5433.646812957145;5483.533899618417;5494.120940649477;5504.339479262514;5510.366307874646;5292.761825717929;5375.693948221893;5384.380796208329;5384.6499977501335;5389.83830485086;5093.592512599057;5099.617528685438;5112.36095488064;5112.846614601568;5117.8720531987;3814.8664796731982;3834.6740527055513;3857.807109644563;3860.378640970855;3865.903352416212;5237.973810130925;5412.675239485643;5428.375736790162;5433.864153396039;5440.238366628596;5286.259923610621;5299.549538289289;5312;5318.191814782837;5326.786928522971;5256.9737151314;5280.128778751617;5286.947130528645;5301.25782390458;5306.469353064663;5027.4218464877;5187.636865419385;5191.870203244949;5201.791928322825;5270.578353731616;5276.812717138767;5276.920846187233;5304.7003484146635;5305.840824775263;5308.2568440419145;5190.429052804264;5191.247269146028;5195;5198.584113271005;5209.426963034139 19:16:49 INFO - PROCESS | 26852 | |5;yui.html;617.0651463033503;636.2905360523018;691.6057847027197;712.333967740163;762.1882694929901;13341.13282636629;14511.419543218259;14549.636259093528;14559.78160327596;14585.270736463188;13477.663058423544;13608.387622556984;13627.114237574551;13628.909687225023;13683.794743078837;639.6354078175442;770.5068755996167;772.671614563811;789.5617932047711;801.6793282686942;790.8892755014302;791.6002418778509;795.6061749434009;796.4066770256138;798.0463346301173;852.433131967241;854.3378881366929;854.6026097864492;854.7393045121236;855.8587833007547;844.0757370679097;844.1811442900407;844.4131328726537;844.6114787197927;846.0820010288783;612.091044798474;616.2974209401286;616.4051690119056;616.6824085595877;617.5646169450526;13242.801357979639;13281.468741250339;13283;13290.26903520306;13329.066965312431;13699.315034248348;13970.371333290026;13988.090774099652;14157.258666136191;14345.282735863166;10529.420881851494;10637.521311540922;10637.840432393521;10683.893161068367;10685.41230232337;3374.6625337466303;3389.2204792897774;3403.421418358885;3409.2840503494294;3495.283466889307;64442.355576444104;64749.67625161891;64910.67544662294;64952.675236623516;65077.34922650808;10214.233932455096;10233.74415639615;10244.948775256076;10422.895771042344;10425.9478702606;18243.635127297646;18846;20379.286724964553;20537.79462205359;20662;7007.089078419773;7144;7163.1404231491515;7188.0431004518805;7198.352148306678;3759.3045286622064;3791;3827.2154208387215;3833.50164478616;3863.16941857502;2941.705829417041;3002.939941201164;3026.3190782073857;3041.9543706844415;3066.1874603230162;489.64500736965414;492.26652288090486;498.41934146719393;499.8025779816952;506.1623013911982;486.74932409808974;558.8798408342226;586.2378907420336;589.0251633546402;602.2471910112359;7380.704771809067;7950.681972721027;8310.168983101641;8313.833723325499;8349.749507514784;543.4431644884243;562.328018018464;569.9031164701928;586.3462239602898;609.679918043031;3700.50043244164;3815.6756675682877;3855.51806024247;3952.2490726761825;3956.940645890314;91079.54460227657;95796;96288;99246;99297;77908.61045694735;81335.5933220342;83223.16776832154;83456.16543834606;83852;71203.28796711967;73488.2651173492;75187;75816.62091689616;76289;7373.893915912656;7549.433792465477;7550.207228240955;7707.075150981918;7771.72798952034;31074.84462577673;37510.81244593869;37595.81202093972;38958.80520597379;39438;39848.60151398449;48131.75934120307;60940;63416;63634.68182659057;11208.439578020903;11400.942995285302;11407.486663100015;11583.884161158281;12285.57000504978;11703.414829258674;11982.161248712506;12198.14612977083;12293.9100352942;12680.619581412573;11762.176647634584;12345.876541234473;12555.560555380518;12714.173578717353;12783;11699.707507312045;11889.762204755683;12373.62879113628;12416.192947458387;13564.38960246811;11978.820317695416;12582.748345033231;12704;12846.327559963758;12938.094333396572;9750.804983900423;10229.897701022894;10395.480225988822;10396.636117735843;10421.426821524889;8957.552122393723;10273.845892311472;10286.251337272532;10371.58513659445;10411.479426028516 19:16:49 INFO - PROCESS | 26852 | __end_tp_report 19:16:49 INFO - PROCESS | 26852 | __start_cc_report 19:16:49 INFO - PROCESS | 26852 | _x_x_mozilla_cycle_collect,373 19:16:49 INFO - PROCESS | 26852 | __end_cc_report 19:16:49 INFO - PROCESS | 26852 | __startTimestamp1470795409705__endTimestamp 19:16:49 INFO - PROCESS | 26852 | 19:16:49 INFO - PROCESS | 26852 | ------- Summary: start ------- 19:16:49 INFO - PROCESS | 26852 | Number of tests: 6 19:16:49 INFO - PROCESS | 26852 | 19:16:49 INFO - PROCESS | 26852 | [#0] dojo.html Cycles:165 Average:4723.17 Median:4825.54 stddev:487.39 (10.1%) stddev-sans-first:461.01 19:16:49 INFO - PROCESS | 26852 | Values: 2651.9 2662.6 2674.2 2691.1 2705.2 4658.7 4791.7 4811.8 4830.7 4842.8 4740.8 4778.4 4805.8 4835.8 4856.7 4333.7 4363.1 4417.2 4422.8 4516.3 4389.1 4423.9 4439.8 4443.4 4447.7 4346.0 4378.1 4384.1 4402.8 4412.2 4409.4 4421.4 4429.8 4461.8 4464.6 4358.2 4381.9 4383.9 4391.2 4411.6 4494.5 4732.6 4772.0 4787.2 4821.1 5119.8 5148.3 5148.4 5163.2 5190.2 5179.7 5186.5 5190.6 5192.5 5240.8 4652.1 4717.5 4744.2 4760.1 4834.6 5235.7 5236.5 5237.3 5244.6 5254.2 4996.9 5019.8 5021.3 5029.0 5043.0 4893.1 5030.9 5093.8 5096.4 5100.9 5031.0 5070.1 5070.6 5076.9 5099.5 5038.6 5041.5 5052.3 5053.1 5068.4 4207.7 4347.8 4388.4 4398.4 4454.7 3831.2 3837.0 3838.9 3859.8 3884.9 4395.6 4414.5 4435.5 4439.0 4479.3 4896.1 5069.8 5118.9 5143.0 5219.5 4378.1 4380.3 4393.7 4407.9 4410.2 4640.2 4650.9 4653.4 4666.2 4709.0 4617.8 4740.2 4765.0 4772.4 4830.3 5111.3 5112.5 5135.3 5135.9 5186.5 4765.2 4774.8 4792.3 4801.5 4825.5 4844.2 4981.9 5003.4 5012.5 5082.4 5115.7 5121.1 5121.2 5136.7 5136.9 4971.5 4990.6 4994.2 5000.4 5007.1 4783.9 4927.0 4983.4 5001.1 5063.3 4847.7 4930.5 4953.0 4976.4 4986.8 5023.9 5025.4 5043.3 5050.0 5096.1 4691.8 4806.5 4812.8 4836.9 4864.1 19:16:49 INFO - PROCESS | 26852 | 19:16:49 INFO - PROCESS | 26852 | [#1] ext.html Cycles:180 Average:48240.50 Median:36131.91 stddev:90463.75 (250.4%) stddev-sans-first:90646.65 19:16:49 INFO - PROCESS | 26852 | Values: 546.3 556.5 564.0 571.5 589.7 34879.3 39324.2 39412.0 39510.2 39580.4 39563.2 40021.2 40174.2 40212.0 40333.6 7407.5 7517.5 7522.6 7531.4 7532.0 7645.3 7709.1 7728.3 7736.0 7757.8 7736.5 7745.5 7770.3 7787.5 7796.5 7704.2 7729.0 7759.8 7765.4 7777.3 7654.2 7681.1 7709.3 7722.0 7735.3 37680.4 38083.0 38083.2 38136.6 38236.0 2898.3 2978.3 3100.4 3242.7 3252.7 29429.7 30526.0 30859.0 31103.7 33590.8 3442.4 3497.4 3513.7 3576.9 3603.6 259941.0 263332.0 263539.0 263996.0 265226.0 33534.3 57362.7 58007.7 58167.4 58403.7 33558.8 34549.7 34810.7 35277.1 35288.0 14019.2 14179.1 14181.3 14188.1 14197.3 11000.6 11021.7 11024.2 11027.1 11059.4 8010.7 8063.8 8089.4 8130.8 8190.5 3163.1 3172.6 3195.4 3196.3 3234.7 931.3 977.8 999.8 1011.9 1016.9 28527.6 28552.7 28712.6 29127.3 29465.7 948.6 977.6 982.3 1003.2 1015.2 14896.9 15273.9 15483.0 15583.6 15838.4 399390.0 405612.0 406491.0 406966.0 409803.0 50344.5 50998.0 51037.2 51056.7 51276.5 1181.9 1196.5 1212.9 1223.2 1223.3 26617.2 26957.6 28304.7 28395.0 28767.6 43419.0 43607.8 43663.0 43745.6 43806.1 342296.0 343404.0 343646.0 343971.0 343993.0 26085.9 26107.5 26153.3 26457.7 26510.3 41843.6 42629.8 43017.6 43264.8 43632.3 34164.3 36128.8 37166.8 37260.6 37959.8 36096.8 36532.3 36598.8 36775.4 36780.8 35435.3 35593.8 36135.0 36278.8 36589.3 31534.5 33219.7 33538.8 33678.8 33799.2 25038.6 25166.9 25493.4 25531.1 25982.2 19:16:49 INFO - PROCESS | 26852 | 19:16:49 INFO - PROCESS | 26852 | [#2] jquery.html Cycles:180 Average:26142.51 Median:28115.83 stddev:66885.70 (237.9%) stddev-sans-first:67045.29 19:16:49 INFO - PROCESS | 26852 | Values: 347.9 355.8 359.8 360.5 364.1 15657.4 16405.2 16929.8 17017.3 17041.3 16066.0 16925.8 17522.9 17555.8 17630.7 4906.2 5108.8 5113.6 5114.7 5117.6 3806.9 5168.1 5803.0 6057.8 6119.0 6097.0 6114.5 6118.6 6124.3 6133.4 6388.6 6731.2 6752.3 6767.8 6771.6 6223.8 6425.5 6437.9 6479.3 6491.2 21828.2 23353.0 23646.3 23924.2 24166.4 1923.7 2116.4 2516.7 2619.7 2666.6 14132.5 14693.4 15098.5 15313.8 15697.8 1813.1 1823.3 1854.6 1871.8 1928.3 78456.2 80193.6 80308.2 81312.0 83138.0 15500.8 15752.5 16519.5 16611.2 16755.2 28713.7 28743.6 28765.7 28833.0 28855.1 8924.4 9163.4 9271.4 9363.9 9549.4 7583.3 7655.3 7721.7 7781.6 7884.6 7680.2 8246.0 8314.5 8339.9 8459.7 1521.7 1571.3 1623.1 3040.7 3391.5 830.8 847.5 882.7 897.1 911.7 16750.7 16764.7 16936.7 17060.5 17428.4 849.9 871.6 876.2 891.6 895.7 9363.8 9866.1 9914.5 9919.7 9932.2 399644.0 405210.0 406223.0 406356.0 409060.0 72483.0 75118.6 76045.0 77193.6 78914.6 917.8 927.4 937.4 955.0 960.2 13162.7 15199.3 15656.5 15696.3 15772.8 37148.8 37499.3 38125.4 38987.8 39346.0 50199.2 51122.9 51357.2 51415.5 52717.0 6718.6 7029.5 7177.2 7317.1 7429.0 8969.6 10125.3 11504.5 11841.8 11914.5 9707.5 9852.1 9911.4 10276.1 10582.1 10489.8 10561.1 10814.6 10945.8 11022.2 9817.4 9990.5 10057.9 10406.5 10582.4 7380.5 7429.3 7532.3 7757.8 8028.2 7868.4 9262.5 10051.1 10255.1 10550.1 19:16:49 INFO - PROCESS | 26852 | 19:16:49 INFO - PROCESS | 26852 | [#3] mootools.html Cycles:180 Average:5120.13 Median:5220.90 stddev:2876.32 (55.1%) stddev-sans-first:2870.60 19:16:49 INFO - PROCESS | 26852 | Values: 1372.0 1408.5 1470.7 1648.7 1719.3 6668.4 7295.7 7421.1 8047.7 8083.3 7407.9 7576.4 7726.6 7763.2 7763.4 2133.4 2200.6 2204.1 2204.6 2218.7 2138.4 2174.1 2191.3 2198.5 2200.7 2163.6 2166.4 2179.3 2182.8 2212.0 2061.8 2071.3 2073.6 2090.2 2091.4 2074.5 2136.6 2154.1 2157.7 2164.9 7826.4 7867.6 7884.0 7904.9 7936.4 4569.7 4695.5 4734.7 4736.2 4741.2 2818.2 2848.8 2927.4 2928.4 2940.6 859.9 893.3 909.0 926.8 927.3 10596.6 10840.7 10866.4 10880.3 10888.9 3963.9 4092.1 4173.9 4247.7 4251.7 9240.5 9322.4 9323.5 9338.2 9346.0 4688.9 4725.6 4727.3 4732.7 4733.2 3331.7 4082.3 4181.1 4299.6 4306.1 3651.3 3658.1 3663.9 3756.6 3762.6 1133.8 1182.4 1195.5 1196.0 1205.2 756.1 782.3 802.6 829.9 840.9 5143.8 5230.2 5252.5 5255.2 5337.7 811.7 827.2 866.3 891.2 927.5 3401.7 3614.5 3621.2 3637.2 3660.1 9478.6 9572.9 9647.0 9718.9 9904.2 9581.5 9654.5 9670.7 9683.5 9694.3 7025.4 7163.4 7370.8 7449.2 7469.7 4944.4 5046.4 5188.4 5209.4 5211.6 8282.6 8726.1 8941.1 8969.3 9030.1 8432.8 8697.4 8732.0 8739.3 8750.8 5936.7 6525.4 6666.4 6870.8 7068.6 7523.8 7620.6 7630.5 7632.4 7642.4 6558.9 6586.1 6700.5 6810.7 6876.6 6425.6 6486.5 6604.8 6673.7 6725.9 6104.8 6204.5 6212.0 6212.8 6243.8 4527.6 4544.6 4639.2 4643.1 4644.2 4505.1 4535.0 4537.2 4633.4 4711.5 19:16:49 INFO - PROCESS | 26852 | 19:16:49 INFO - PROCESS | 26852 | [#4] prototype.html Cycles:180 Average:4335.68 Median:4831.59 stddev:1264.26 (26.2%) stddev-sans-first:1230.67 19:16:49 INFO - PROCESS | 26852 | Values: 282.9 291.7 295.0 298.7 302.6 4830.5 4937.8 5024.0 5072.7 5089.5 4968.1 4969.3 4982.0 5000.4 5014.6 3956.3 3960.7 3974.9 3985.1 4003.8 3856.2 3955.4 3987.2 4006.8 4012.3 3931.2 3940.8 3955.7 3956.4 3966.6 3936.9 3942.2 3962.4 3983.3 3984.9 3525.2 3534.8 3535.8 3536.1 3539.7 4815.6 4826.7 4880.6 4907.2 4977.6 4504.4 4514.6 4522.3 4528.4 4528.8 5242.3 5291.4 5291.9 5294.6 5312.0 3745.8 3813.2 3839.2 3860.8 3876.4 5482.6 5493.5 5495.7 5499.6 5510.3 3935.2 3941.4 3954.9 3964.6 3972.2 3529.4 4022.3 4025.2 4025.4 4040.9 4305.6 4308.2 4308.5 4308.6 4312.0 5269.2 5278.7 5281.5 5282.7 5285.8 1274.4 1297.5 1326.3 1326.5 1334.9 875.8 892.5 907.4 913.4 919.3 4520.2 4529.9 4533.3 4536.5 4538.1 5357.7 5387.4 5393.5 5393.6 5396.2 4421.9 4536.9 4548.4 4553.2 4556.9 2455.3 2506.8 2537.7 2540.6 2553.9 4441.3 4466.4 4473.3 4474.1 4478.3 4808.1 4826.5 4832.7 4868.4 4872.5 4672.0 5039.3 5090.9 5099.6 5127.2 5433.6 5483.5 5494.1 5504.3 5510.4 5292.8 5375.7 5384.4 5384.6 5389.8 5093.6 5099.6 5112.4 5112.8 5117.9 3814.9 3834.7 3857.8 3860.4 3865.9 5238.0 5412.7 5428.4 5433.9 5440.2 5286.3 5299.5 5312.0 5318.2 5326.8 5257.0 5280.1 5286.9 5301.3 5306.5 5027.4 5187.6 5191.9 5201.8 5270.6 5276.8 5276.9 5304.7 5305.8 5308.3 5190.4 5191.2 5195.0 5198.6 5209.4 19:16:49 INFO - PROCESS | 26852 | 19:16:49 INFO - PROCESS | 26852 | [#5] yui.html Cycles:180 Average:17502.63 Median:21695.12 stddev:24672.51 (113.7%) stddev-sans-first:24709.15 19:16:49 INFO - PROCESS | 26852 | Values: 617.1 636.3 691.6 712.3 762.2 13341.1 14511.4 14549.6 14559.8 14585.3 13477.7 13608.4 13627.1 13628.9 13683.8 639.6 770.5 772.7 789.6 801.7 790.9 791.6 795.6 796.4 798.0 852.4 854.3 854.6 854.7 855.9 844.1 844.2 844.4 844.6 846.1 612.1 616.3 616.4 616.7 617.6 13242.8 13281.5 13283.0 13290.3 13329.1 13699.3 13970.4 13988.1 14157.3 14345.3 10529.4 10637.5 10637.8 10683.9 10685.4 3374.7 3389.2 3403.4 3409.3 3495.3 64442.4 64749.7 64910.7 64952.7 65077.3 10214.2 10233.7 10244.9 10422.9 10425.9 18243.6 18846.0 20379.3 20537.8 20662.0 7007.1 7144.0 7163.1 7188.0 7198.4 3759.3 3791.0 3827.2 3833.5 3863.2 2941.7 3002.9 3026.3 3042.0 3066.2 489.6 492.3 498.4 499.8 506.2 486.7 558.9 586.2 589.0 602.2 7380.7 7950.7 8310.2 8313.8 8349.7 543.4 562.3 569.9 586.3 609.7 3700.5 3815.7 3855.5 3952.2 3956.9 91079.5 95796.0 96288.0 99246.0 99297.0 77908.6 81335.6 83223.2 83456.2 83852.0 71203.3 73488.3 75187.0 75816.6 76289.0 7373.9 7549.4 7550.2 7707.1 7771.7 31074.8 37510.8 37595.8 38958.8 39438.0 39848.6 48131.8 60940.0 63416.0 63634.7 11208.4 11400.9 11407.5 11583.9 12285.6 11703.4 11982.2 12198.1 12293.9 12680.6 11762.2 12345.9 12555.6 12714.2 12783.0 11699.7 11889.8 12373.6 12416.2 13564.4 11978.8 12582.7 12704.0 12846.3 12938.1 9750.8 10229.9 10395.5 10396.6 10421.4 8957.6 10273.8 10286.3 10371.6 10411.5 19:16:49 INFO - PROCESS | 26852 | -------- Summary: end -------- 19:16:49 INFO - PROCESS | 26852 | 19:16:50 INFO - TEST-INFO | 26852: exit 0 19:16:50 INFO - TEST-OK | dromaeo_css | took 1116548ms 19:16:50 INFO - TEST-START | kraken 19:16:50 INFO - operating with platform_type : linux_ 19:16:50 INFO - Initialising browser for kraken test... 19:16:50 INFO - TEST-INFO | started process 27096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfj0PjO/profile http://localhost:58402/getInfo.html) 19:16:55 INFO - PROCESS | 27096 | __metrics Screen width/height:1600/1200 19:16:55 INFO - PROCESS | 27096 | colorDepth:24 19:16:55 INFO - PROCESS | 27096 | Browser inner width/height: 1024/697 19:16:55 INFO - PROCESS | 27096 | __metrics 19:16:55 ERROR - PROCESS | 27096 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 19:16:56 INFO - TEST-INFO | 27096: exit 0 19:16:56 INFO - Browser initialized. 19:16:56 INFO - Running cycle 1/1 for kraken test... 19:16:56 INFO - TEST-INFO | started process 27214 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfj0PjO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 19:17:08 INFO - PROCESS | 27214 | RSS: Main: 163672064 19:17:08 INFO - PROCESS | 27214 | 19:17:11 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58402/tests/kraken/driver.html?testName=audio-beat-detection) 19:17:12 INFO - PROCESS | 27214 | RSS: Main: 168812544 19:17:12 INFO - PROCESS | 27214 | 19:17:14 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58402/tests/kraken/driver.html?testName=audio-dft) 19:17:15 INFO - PROCESS | 27214 | RSS: Main: 168230912 19:17:15 INFO - PROCESS | 27214 | 19:17:18 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58402/tests/kraken/driver.html?testName=audio-fft) 19:17:19 INFO - PROCESS | 27214 | RSS: Main: 164093952 19:17:19 INFO - PROCESS | 27214 | 19:17:21 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58402/tests/kraken/driver.html?testName=audio-oscillator) 19:17:22 INFO - PROCESS | 27214 | RSS: Main: 164716544 19:17:22 INFO - PROCESS | 27214 | 19:17:24 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58402/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:17:24 INFO - PROCESS | 27214 | RSS: Main: 165171200 19:17:24 INFO - PROCESS | 27214 | 19:17:28 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58402/tests/kraken/driver.html?testName=imaging-darkroom) 19:17:28 INFO - PROCESS | 27214 | RSS: Main: 165367808 19:17:28 INFO - PROCESS | 27214 | 19:17:32 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58402/tests/kraken/driver.html?testName=imaging-desaturate) 19:17:33 INFO - PROCESS | 27214 | RSS: Main: 162283520 19:17:33 INFO - PROCESS | 27214 | 19:17:35 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58402/tests/kraken/driver.html?testName=json-parse-financial) 19:17:36 INFO - PROCESS | 27214 | RSS: Main: 164175872 19:17:36 INFO - PROCESS | 27214 | 19:17:38 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58402/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:17:38 INFO - PROCESS | 27214 | RSS: Main: 164241408 19:17:38 INFO - PROCESS | 27214 | 19:17:40 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58402/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:17:41 INFO - PROCESS | 27214 | RSS: Main: 164597760 19:17:41 INFO - PROCESS | 27214 | 19:17:43 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58402/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:17:44 INFO - PROCESS | 27214 | RSS: Main: 165220352 19:17:44 INFO - PROCESS | 27214 | 19:17:47 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:17:47 INFO - PROCESS | 27214 | RSS: Main: 165482496 19:17:47 INFO - PROCESS | 27214 | 19:17:50 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:17:51 INFO - PROCESS | 27214 | RSS: Main: 165490688 19:17:51 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | Cycle 1(1): loaded http://localhost:58402/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58402/tests/kraken/driver.html?testName=ai-astar) 19:17:53 INFO - PROCESS | 27214 | RSS: Main: 166244352 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | __start_tp_report 19:17:53 INFO - PROCESS | 27214 | _x_x_mozilla_page_load 19:17:53 INFO - PROCESS | 27214 | _x_x_mozilla_page_load_details 19:17:53 INFO - PROCESS | 27214 | |i|pagename|runs| 19:17:53 INFO - PROCESS | 27214 | |0;ai-astar;107;116;114;116;117;116;117;116;115;115 19:17:53 INFO - PROCESS | 27214 | |1;audio-beat-detection;158;125;165;186;123;162;148;125;184;123 19:17:53 INFO - PROCESS | 27214 | |2;audio-dft;163;165;164;180;162;164;164;162;163;163 19:17:53 INFO - PROCESS | 27214 | |3;audio-fft;77;77;77;170;78;76;76;75;151;77 19:17:53 INFO - PROCESS | 27214 | |4;audio-oscillator;87;85;143;86;86;86;132;86;85;147 19:17:53 INFO - PROCESS | 27214 | |5;imaging-gaussian-blur;118;118;118;119;117;117;117;118;117;118 19:17:53 INFO - PROCESS | 27214 | |6;imaging-darkroom;148;147;147;147;148;147;149;148;147;150 19:17:53 INFO - PROCESS | 27214 | |7;imaging-desaturate;96;95;96;96;96;96;96;96;100;95 19:17:53 INFO - PROCESS | 27214 | |8;json-parse-financial;63;64;63;63;65;62;62;63;62;63 19:17:53 INFO - PROCESS | 27214 | |9;json-stringify-tinderbox;67;65;65;66;65;66;66;67;67;67 19:17:53 INFO - PROCESS | 27214 | |10;stanford-crypto-aes;80;81;80;80;83;80;79;79;87;83 19:17:53 INFO - PROCESS | 27214 | |11;stanford-crypto-ccm;143;134;141;138;133;140;142;135;146;140 19:17:53 INFO - PROCESS | 27214 | |12;stanford-crypto-pbkdf2;176;168;170;168;171;173;166;169;174;169 19:17:53 INFO - PROCESS | 27214 | |13;stanford-crypto-sha256-iterative;69;70;72;70;69;67;67;68;69;67 19:17:53 INFO - PROCESS | 27214 | __end_tp_report 19:17:53 INFO - PROCESS | 27214 | __start_cc_report 19:17:53 INFO - PROCESS | 27214 | _x_x_mozilla_cycle_collect,944 19:17:53 INFO - PROCESS | 27214 | __end_cc_report 19:17:53 INFO - PROCESS | 27214 | __startTimestamp1470795473409__endTimestamp 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | ------- Summary: start ------- 19:17:53 INFO - PROCESS | 27214 | Number of tests: 14 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#0] ai-astar Cycles:10 Average:114.90 Median:116.00 stddev:2.92 (2.5%) stddev-sans-first:0.97 19:17:53 INFO - PROCESS | 27214 | Values: 107.0 116.0 114.0 116.0 117.0 116.0 117.0 116.0 115.0 115.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:160.00 stddev:24.94 (15.6%) stddev-sans-first:26.28 19:17:53 INFO - PROCESS | 27214 | Values: 158.0 125.0 165.0 186.0 123.0 162.0 148.0 125.0 184.0 123.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.00 stddev:5.35 (3.3%) stddev-sans-first:5.63 19:17:53 INFO - PROCESS | 27214 | Values: 163.0 165.0 164.0 180.0 162.0 164.0 164.0 162.0 163.0 163.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#3] audio-fft Cycles:10 Average:93.40 Median:77.00 stddev:35.66 (46.3%) stddev-sans-first:37.32 19:17:53 INFO - PROCESS | 27214 | Values: 77.0 77.0 77.0 170.0 78.0 76.0 76.0 75.0 151.0 77.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:86.00 stddev:26.73 (31.1%) stddev-sans-first:27.78 19:17:53 INFO - PROCESS | 27214 | Values: 87.0 85.0 143.0 86.0 86.0 86.0 132.0 86.0 85.0 147.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 19:17:53 INFO - PROCESS | 27214 | Values: 118.0 118.0 118.0 119.0 117.0 117.0 117.0 118.0 117.0 118.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 19:17:53 INFO - PROCESS | 27214 | Values: 148.0 147.0 147.0 147.0 148.0 147.0 149.0 148.0 147.0 150.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:1.40 (1.5%) stddev-sans-first:1.48 19:17:53 INFO - PROCESS | 27214 | Values: 96.0 95.0 96.0 96.0 96.0 96.0 96.0 96.0 100.0 95.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:0.94 (1.5%) stddev-sans-first:1.00 19:17:53 INFO - PROCESS | 27214 | Values: 63.0 64.0 63.0 63.0 65.0 62.0 62.0 63.0 62.0 63.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:66.50 stddev:0.88 (1.3%) stddev-sans-first:0.87 19:17:53 INFO - PROCESS | 27214 | Values: 67.0 65.0 65.0 66.0 65.0 66.0 66.0 67.0 67.0 67.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:80.50 stddev:2.49 (3.1%) stddev-sans-first:2.60 19:17:53 INFO - PROCESS | 27214 | Values: 80.0 81.0 80.0 80.0 83.0 80.0 79.0 79.0 87.0 83.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#11] stanford-crypto-ccm Cycles:10 Average:139.20 Median:140.50 stddev:4.18 (3.0%) stddev-sans-first:4.21 19:17:53 INFO - PROCESS | 27214 | Values: 143.0 134.0 141.0 138.0 133.0 140.0 142.0 135.0 146.0 140.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:170.40 Median:170.50 stddev:3.10 (1.8%) stddev-sans-first:2.54 19:17:53 INFO - PROCESS | 27214 | Values: 176.0 168.0 170.0 168.0 171.0 173.0 166.0 169.0 174.0 169.0 19:17:53 INFO - PROCESS | 27214 | 19:17:53 INFO - PROCESS | 27214 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:69.00 stddev:1.62 (2.3%) stddev-sans-first:1.72 19:17:53 INFO - PROCESS | 27214 | Values: 69.0 70.0 72.0 70.0 69.0 67.0 67.0 68.0 69.0 67.0 19:17:53 INFO - PROCESS | 27214 | -------- Summary: end -------- 19:17:53 INFO - PROCESS | 27214 | 19:17:54 INFO - TEST-INFO | 27214: exit 0 19:17:54 INFO - TEST-OK | kraken | took 64119ms 19:17:54 INFO - SUITE-END | took 1180s 19:17:55 INFO - Completed test suite (00:19:41) 19:17:55 INFO - javascript benchmark 19:17:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6521.677225647699, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2651.946961060779, 2662.5606774882144, 2674.1977406777974, 2691.098482008527, 2705.161399966011, 4658.7204767713965, 4791.688540244886, 4811.783469743861, 4830.686005409655, 4842.80628774849, 4740.76296185191, 4778.3549220855175, 4805.759712014394, 4835.806567737286, 4856.708597484154, 4333.65330773539, 4363.083752411997, 4417.249067658506, 4422.800973956164, 4516.254817955033, 4389.144116897206, 4423.867283981485, 4439.75581343026, 4443.422355093833, 4447.688661793676, 4346.000419903408, 4378.058717375779, 4384.101259241879, 4402.801873915681, 4412.227860124482, 4409.382686423904, 4421.38100665907, 4429.756363400012, 4461.776911154429, 4464.575865292792, 4358.193734159191, 4381.890452738675, 4383.912321753547, 4391.231534481453, 4411.647068234533, 4494.505604383515, 4732.550407711262, 4771.976140119312, 4787.186178349654, 4821.083994041121, 5119.795208191668, 5148.279240906276, 5148.3564554430695, 5163.199704045879, 5190.195519694454, 5179.663321884065, 5186.481351864821, 5190.558802501791, 5192.532672059495, 5240.764165612519, 4652.116097941381, 4717.457492388351, 4744.1934871072, 4760.071786001766, 4834.58905992991, 5235.73821308933, 5236.476352364733, 5237.266782650432, 5244.554212891947, 5254.15933450646, 4996.875078123076, 5019.824306149268, 5021.322121513622, 5029.044481548494, 5043.041822053798, 4893.09477746618, 5030.874228144253, 5093.770780314895, 5096.388433387943, 5100.948990510047, 5031.0441016206805, 5070.087384270867, 5070.594352451795, 5076.898462030738, 5099.515546023122, 5038.5969122470115, 5041.495850414929, 5052.267421223902, 5053.0904437200925, 5068.4424713281505, 4207.663386929038, 4347.7826108694435, 4388.363687265392, 4398.3842262083335, 4454.688171827941, 3831.1954489557506, 3837.002379381381, 3838.9424158637644, 3859.7877116758846, 3884.941725874114, 4395.604395604411, 4414.536473670282, 4435.467743870756, 4439.0, 4479.283314669702, 4896.143174944371, 5069.822556210589, 5118.948810511922, 5143.048536020848, 5219.530242278213, 4378.0806030733265, 4380.342948557742, 4393.6704747144095, 4407.911841763147, 4410.206162890647, 4640.23436133041, 4650.930236046462, 4653.371794807726, 4666.160091183551, 4709.0, 4617.792199351037, 4740.19416699162, 4765.046990601824, 4772.379590653193, 4830.347903033045, 5111.284420181103, 5112.514311140436, 5135.2553879687985, 5135.922961155511, 5186.507281808223, 4765.189917713928, 4774.832880849153, 4792.305115758265, 4801.4958429365815, 4825.541573550507, 4844.176489996638, 4981.875453113701, 5003.374578177728, 5012.523810238022, 5082.4409314976065, 5115.6979359287725, 5121.052605268037, 5121.180611102355, 5136.717480538457, 5136.948630513647, 4971.502849715, 4990.550850423334, 4994.225894986283, 5000.374953130859, 5007.098722230034, 4783.856484305337, 4926.950730492649, 4983.377077865267, 5001.1248031593595, 5063.265826455217, 4847.733374664427, 4930.457649658606, 4952.950470495249, 4976.427710813303, 4986.825461108844, 5023.949760502348, 5025.422076461254, 5043.2687260347775, 5049.974750126225, 5096.0827051131155, 4691.788869500949, 4806.543378379049, 4812.807487700453, 4836.854894353175, 4864.100141473838], "value": 4692.56919207377, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.2734563031169, 556.4908109080192, 563.9802606908759, 571.4942276085665, 589.6992533807762, 34879.30241395171, 39324.213515729665, 39411.99999999996, 39510.20979580407, 39580.406293905544, 39563.20873582527, 40021.19957600846, 40174.19651606966, 40211.99999999993, 40333.59666403335, 7407.518511296776, 7517.548947063194, 7522.623868806538, 7531.359834414081, 7532.0, 7645.273698998586, 7709.113451953013, 7728.343090837286, 7735.961320193391, 7757.844843103135, 7736.535807851519, 7745.457817952745, 7770.261825126632, 7787.532748035108, 7796.493227940194, 7704.152543220242, 7729.033870766154, 7759.806004849867, 7765.417593680497, 7777.261160189773, 7654.2345765423015, 7681.078270607562, 7709.267619576188, 7722.0, 7735.265149810759, 37680.43479347812, 38083.0, 38083.238335233415, 38136.618633813865, 38236.04409889747, 2898.2754311422145, 2978.3149875528748, 3100.429320721418, 3242.691944265291, 3252.7235185009304, 29429.70570294291, 30526.0, 30859.0, 31103.688963110304, 33590.83204583961, 3442.4492081267126, 3497.387957107496, 3513.7364697647777, 3576.8926932192076, 3603.56757189139, 259941.0, 263332.0, 263539.0, 263996.0, 265226.0, 33534.329313414084, 57362.71318643464, 58007.709961449924, 58167.418325817045, 58403.70798145982, 33558.832205838815, 34549.654503455145, 34810.65189348125, 35277.11807204789, 35288.0, 14019.158850469004, 14179.14925104497, 14181.290935453186, 14188.148711077369, 14197.290135493184, 11000.614978475714, 11021.724456888482, 11024.228304018801, 11027.062699670458, 11059.447027648584, 8010.679572817022, 8063.758087257392, 8089.3528517719615, 8130.75607731769, 8190.525705372971, 3163.114327988167, 3172.5558421820965, 3195.376901504231, 3196.328770958078, 3234.6765323467466, 931.2689538712214, 977.8288799460066, 999.7750506136061, 1011.858339832424, 1016.8611155505881, 28527.57362131885, 28552.71447285542, 28712.569311460345, 29127.27181820429, 29465.705342946723, 948.5636607160645, 977.6382738386842, 982.3123813330698, 1003.2375394699934, 1015.2284263959297, 14896.925515372353, 15273.923630381776, 15483.0, 15583.610409739847, 15838.366465341487, 399390.0, 405612.0, 406491.0, 406966.0, 409803.0, 50344.49655503471, 50998.0, 51037.23444148341, 51056.74471627618, 51276.48723512792, 1181.9349935753444, 1196.4615922834585, 1212.8605210400917, 1223.2232532342027, 1223.3149436315691, 26617.201483954737, 26957.59563606508, 28304.716952830207, 28395.0, 28767.568486473137, 43419.0, 43607.78196108999, 43663.0, 43745.56254437415, 43806.12387752291, 342296.0, 343404.0, 343646.0, 343971.0, 343993.0, 26085.869570652027, 26107.477850443265, 26153.346166345993, 26457.735422645528, 26510.337241569116, 41843.581564183965, 42629.786851065546, 43017.569824301354, 43264.78367608142, 43632.34551481667, 34164.316713666085, 36128.819355903055, 37166.81416593008, 37260.627393725714, 37959.81020094882, 36096.81951590225, 36532.269354612225, 36598.8170059148, 36775.44836827396, 36780.81609591935, 35435.29129417449, 35593.82203089072, 36135.0, 36278.8186059068, 36589.26821463609, 31534.526982095747, 33219.66780332166, 33538.83230583832, 33678.831605842795, 33799.15502112368, 25038.62442063407, 25166.874165629055, 25493.3626659335, 25531.088082901406, 25982.22053338403], "value": 16774.8544341701, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [347.8765038411364, 355.80075157911574, 359.79491689736847, 360.5025065409734, 364.0752488678753, 15657.3737050518, 16405.179741012947, 16929.830701692994, 17017.319307227695, 17041.318347266126, 16066.0, 16925.830741692578, 17522.912385438085, 17555.82444175558, 17630.735538966925, 4906.215005599105, 5108.770105345268, 5113.616478764089, 5114.693118412889, 5117.5650069744115, 3806.8667596634123, 5168.147255702805, 5803.0, 6057.787977420791, 6118.969405152968, 6096.969515152418, 6114.541409394314, 6118.571699981003, 6124.295705993801, 6133.44798968095, 6388.584741991779, 6731.225909020427, 6752.291009444011, 6767.796966091025, 6771.593704377753, 6223.751049957997, 6425.45383642391, 6437.871242575122, 6479.254885688159, 6491.221053473566, 21828.23601173967, 23353.0, 23646.29061128169, 23924.162654307016, 24166.395840103964, 1923.7499125113645, 2116.4179850541072, 2516.7105782835024, 2619.6856377234662, 2666.560017597094, 14132.505362312373, 14693.412263509446, 15098.471553495685, 15313.846861531465, 15697.843021569866, 1813.084392381852, 1823.2798044772242, 1854.6476169527882, 1871.7660292463443, 1928.305809908432, 78456.21543784546, 80193.59903200447, 80308.19691803066, 81312.0, 83138.0, 15500.844991550166, 15752.527424177293, 16519.504414867333, 16611.169441527876, 16755.2460139294, 28713.712862871103, 28743.56884646732, 28765.712342876723, 28833.0, 28855.134345969655, 8924.375293729507, 9163.358564900393, 9271.397359171633, 9363.90636093644, 9549.42703437782, 7583.317501424788, 7655.349295309961, 7721.691132354643, 7781.572013539309, 7884.566348850868, 7680.231976802387, 8245.95877020611, 8314.542700151429, 8339.916600833914, 8459.661613535389, 1521.6500204952702, 1571.2772124822482, 1623.123513302827, 3040.6959304069414, 3391.5251864738957, 830.8047608811925, 847.4576271186446, 882.6866462405753, 897.1477096758106, 911.6763548940163, 16750.74873876893, 16764.664706705797, 16936.661266774594, 17060.541755086757, 17428.39000634997, 849.9277561407226, 871.5685735560938, 876.2376732242863, 891.5809569502323, 895.7088946092546, 9363.77309089448, 9866.112049915542, 9914.45470499115, 9919.702408927744, 9932.155766759763, 399644.0, 405210.0, 406223.0, 406356.0, 409060.0, 72483.0, 75118.62440687761, 76045.0, 77193.61403192948, 78914.6054269725, 917.8026724254318, 927.3832901120815, 937.3719607862612, 955.0497255231089, 960.2078285414422, 13162.670933226746, 15199.31603077842, 15656.4520241791, 15696.293666784793, 15772.842271577596, 37148.81425592855, 37499.250014999, 38125.4281185788, 38987.80506097451, 39346.0, 50199.24701129413, 51122.88771122858, 51357.22964155466, 51415.48584514107, 52717.0, 6718.596884186964, 7029.5430796998035, 7177.1746249182015, 7317.085364329459, 7428.9628551856895, 8969.641214351614, 10125.291229613857, 11504.482298296763, 11841.763164736829, 11914.52341906314, 9707.46608936487, 9852.064053914866, 9911.355761875455, 10276.126529245097, 10582.100521455455, 10489.790204196026, 10561.10230630405, 10814.567417303535, 10945.83581246298, 11022.228444008842, 9817.361871478332, 9990.450525220891, 10057.949710251401, 10406.47967601632, 10582.365058096539, 7380.520266182681, 7429.294217049372, 7532.284432978859, 7757.844843103219, 8028.157043510348, 7868.370530357673, 9262.480257502106, 10051.095401413908, 10255.103060836835, 10550.050495455445], "value": 9133.079444266812, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1372.0190064104163, 1408.5492642354445, 1470.720563093013, 1648.7444446110858, 1719.277903280622, 6668.399844014038, 7295.708171673126, 7421.144713821544, 8047.6780928762855, 8083.312918401935, 7407.925920740791, 7576.393888488921, 7726.613669316525, 7763.184865589116, 7763.417743669219, 2133.4133113393823, 2200.581889441009, 2204.0522575292616, 2204.64725643897, 2218.7226596675414, 2138.4440045588103, 2174.0542863854193, 2191.3206905859233, 2198.472366632013, 2200.6919031335547, 2163.5889181055627, 2166.360923527563, 2179.3353027326657, 2182.8321847811426, 2212.037763572843, 2061.783512731164, 2071.306112452323, 2073.5645514441985, 2090.216168936649, 2091.4039498742936, 2074.4917495213767, 2136.6474531702406, 2154.0952799824113, 2157.65477523597, 2164.8701077935375, 7826.4130190235965, 7867.6066196689935, 7884.0, 7904.920950790533, 7936.4047696423, 4569.702969306984, 4695.483496815347, 4734.739589322586, 4736.242201247784, 4741.241401375798, 2818.2249881282605, 2848.8290702557706, 2927.443785680714, 2928.370400363932, 2940.588317635533, 859.9398042137053, 893.3389291923929, 909.0228004894765, 926.7590426489094, 927.2859897878664, 10596.629117980834, 10840.67477975662, 10866.402347870864, 10880.292780969212, 10888.945555272252, 3963.920721585552, 4092.140650463436, 4173.8956526087095, 4247.68142389322, 4251.744895306291, 9240.491772952417, 9322.440653560809, 9323.533823308808, 9338.159565639126, 9346.0, 4688.882777930579, 4725.574698277172, 4727.338172655831, 4732.73969931657, 4733.242681170997, 3331.6501767314567, 4082.3264161413626, 4181.142865712522, 4299.634531064832, 4306.074194048232, 3651.2514934438377, 3658.067192865802, 3663.8534458621357, 3756.586775454698, 3762.567304759933, 1133.824257240129, 1182.4028865422906, 1195.4919159357412, 1196.0431654676224, 1205.2226314027578, 756.1417790807363, 782.2646712090731, 802.6348011654683, 829.929455996247, 840.8864803251482, 5143.8456846294675, 5230.215467679803, 5252.474752524717, 5255.211718242218, 5337.653052551572, 811.7077851973285, 827.1728271728272, 866.3199388480012, 891.2468963725642, 927.4667066436825, 3401.727861771052, 3614.5120408744483, 3621.239539696693, 3637.217998130415, 3660.103274697663, 9478.620855165716, 9572.856407153899, 9646.951765241269, 9718.902810971942, 9904.207663386911, 9581.473018983883, 9654.517274136266, 9670.70987870365, 9683.467409292556, 9694.321397502248, 7025.40284075849, 7163.391111755455, 7370.815729606696, 7449.180590135081, 7469.7385591504035, 4944.406671199479, 5046.394432668103, 5188.377394712658, 5209.426963033988, 5211.583073354047, 8282.627281772215, 8726.127387261224, 8941.061188575106, 8969.282457403522, 9030.096990300917, 8432.83134337322, 8697.39118261741, 8732.039475657546, 8739.257163141205, 8750.781230469289, 5936.703164841654, 6525.412712855866, 6666.366695163952, 6870.828229294108, 7068.6112263823925, 7523.774286771406, 7620.618969051636, 7630.542167469969, 7632.427567932316, 7642.3504002158215, 6558.901616475661, 6586.077949087035, 6700.46396288286, 6810.693518791765, 6876.587404755731, 6425.5502114851515, 6486.54594178403, 6604.768833090819, 6673.666316684049, 6725.865482690221, 6104.755809767559, 6204.472619827366, 6211.9689401552705, 6212.81361559154, 6243.7814676486105, 4527.592516673515, 4544.590986811203, 4639.2113340731485, 4643.071385722937, 4644.210484217759, 4505.144022635689, 4535.027263140544, 4537.1833070047705, 4633.374494443207, 4711.528847115261], "value": 4120.76538533086, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [282.89815666360096, 291.71994884910487, 295.0381755477144, 298.73561897720515, 302.6292791330619, 4830.492798256185, 4937.753112344386, 5023.974880125599, 5072.72100034498, 5089.541941225284, 4968.056069346831, 4969.254611808231, 4982.0, 5000.424951130621, 5014.648974571782, 3956.3076461619244, 3960.722749407543, 3974.8807535773826, 3985.103351745863, 4003.779792111433, 3856.2480316338324, 3955.3869150281753, 3987.182627561343, 4006.7595944243294, 4012.25773231953, 3931.2334094851517, 3940.8423663053586, 3955.7341650671797, 3956.3669812829953, 3966.603339666039, 3936.8818935431696, 3942.231264903345, 3962.4254483100076, 3983.2830090583684, 3984.8804535863683, 3525.1539630488496, 3534.7702399344216, 3535.7701749386206, 3536.0728403020157, 3539.663731945461, 4815.566599006072, 4826.662133650646, 4880.6171055049645, 4907.1657818171, 4977.576905962997, 4504.414426124616, 4514.571115744032, 4522.34426008227, 4528.43394575678, 4528.773561321921, 5242.318498595158, 5291.444398338196, 5291.941611677641, 5294.57643388528, 5311.990721762892, 3745.8127093645207, 3813.245906882837, 3839.155385815116, 3860.8069596520063, 3876.4185372194115, 5482.600787511768, 5493.450654934474, 5495.725213739297, 5499.642523235977, 5510.256115424407, 3935.193285376491, 3941.3890846918775, 3954.861579844749, 3964.583718709494, 3972.1857019310974, 3529.3647143514413, 4022.255882661717, 4025.1547175092974, 4025.376066709665, 4040.878773636796, 4305.634021108241, 4308.18144552534, 4308.526062133163, 4308.633766129914, 4311.9784401077795, 5269.235960785742, 5278.709670968057, 5281.471852814688, 5282.656627319212, 5285.753554739221, 1274.413769665964, 1297.4615534553243, 1326.303690562443, 1326.548973349066, 1334.9065565410522, 875.843886070381, 892.4957399069634, 907.3784457646533, 913.3697748553477, 919.347263442963, 4520.18636645407, 4529.932051019237, 4533.342665313511, 4536.546345365437, 4538.1377538267625, 5357.678539287655, 5387.380451248078, 5393.514583687408, 5393.649412788156, 5396.165303796728, 4421.911561768747, 4536.9092618148115, 4548.385967894358, 4553.225951588238, 4556.863294101182, 2455.2756936703713, 2506.8370555913807, 2537.7462253774474, 2540.593505039185, 2553.859537725406, 4441.267190913463, 4466.352378905106, 4473.329000649928, 4474.105178964155, 4478.2610869206865, 4808.134535783593, 4826.469088400273, 4832.685875418087, 4868.391451068616, 4872.537108974641, 4672.042231342634, 5039.269305950616, 5090.949090509048, 5099.566536844335, 5127.1540195867265, 5433.646812957145, 5483.533899618417, 5494.120940649477, 5504.339479262514, 5510.366307874646, 5292.761825717929, 5375.693948221893, 5384.380796208329, 5384.6499977501335, 5389.83830485086, 5093.592512599057, 5099.617528685438, 5112.36095488064, 5112.846614601568, 5117.8720531987, 3814.8664796731982, 3834.6740527055513, 3857.807109644563, 3860.378640970855, 3865.903352416212, 5237.973810130925, 5412.675239485643, 5428.375736790162, 5433.864153396039, 5440.238366628596, 5286.259923610621, 5299.549538289289, 5312.0, 5318.191814782837, 5326.786928522971, 5256.9737151314, 5280.128778751617, 5286.947130528645, 5301.25782390458, 5306.469353064663, 5027.4218464877, 5187.636865419385, 5191.870203244949, 5201.791928322825, 5270.578353731616, 5276.812717138767, 5276.920846187233, 5304.7003484146635, 5305.840824775263, 5308.2568440419145, 5190.429052804264, 5191.247269146028, 5195.0, 5198.584113271005, 5209.426963034139], "value": 3928.3174862975106, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.0651463033503, 636.2905360523018, 691.6057847027197, 712.333967740163, 762.1882694929901, 13341.13282636629, 14511.419543218259, 14549.636259093528, 14559.78160327596, 14585.270736463188, 13477.663058423544, 13608.387622556984, 13627.114237574551, 13628.909687225023, 13683.794743078837, 639.6354078175442, 770.5068755996167, 772.671614563811, 789.5617932047711, 801.6793282686942, 790.8892755014302, 791.6002418778509, 795.6061749434009, 796.4066770256138, 798.0463346301173, 852.433131967241, 854.3378881366929, 854.6026097864492, 854.7393045121236, 855.8587833007547, 844.0757370679097, 844.1811442900407, 844.4131328726537, 844.6114787197927, 846.0820010288783, 612.091044798474, 616.2974209401286, 616.4051690119056, 616.6824085595877, 617.5646169450526, 13242.801357979639, 13281.468741250339, 13283.0, 13290.26903520306, 13329.066965312431, 13699.315034248348, 13970.371333290026, 13988.090774099652, 14157.258666136191, 14345.282735863166, 10529.420881851494, 10637.521311540922, 10637.840432393521, 10683.893161068367, 10685.41230232337, 3374.6625337466303, 3389.2204792897774, 3403.421418358885, 3409.2840503494294, 3495.283466889307, 64442.355576444104, 64749.67625161891, 64910.67544662294, 64952.675236623516, 65077.34922650808, 10214.233932455096, 10233.74415639615, 10244.948775256076, 10422.895771042344, 10425.9478702606, 18243.635127297646, 18846.0, 20379.286724964553, 20537.79462205359, 20662.0, 7007.089078419773, 7144.0, 7163.1404231491515, 7188.0431004518805, 7198.352148306678, 3759.3045286622064, 3791.0, 3827.2154208387215, 3833.50164478616, 3863.16941857502, 2941.705829417041, 3002.939941201164, 3026.3190782073857, 3041.9543706844415, 3066.1874603230162, 489.64500736965414, 492.26652288090486, 498.41934146719393, 499.8025779816952, 506.1623013911982, 486.74932409808974, 558.8798408342226, 586.2378907420336, 589.0251633546402, 602.2471910112359, 7380.704771809067, 7950.681972721027, 8310.168983101641, 8313.833723325499, 8349.749507514784, 543.4431644884243, 562.328018018464, 569.9031164701928, 586.3462239602898, 609.679918043031, 3700.50043244164, 3815.6756675682877, 3855.51806024247, 3952.2490726761825, 3956.940645890314, 91079.54460227657, 95796.0, 96288.0, 99246.0, 99297.0, 77908.61045694735, 81335.5933220342, 83223.16776832154, 83456.16543834606, 83852.0, 71203.28796711967, 73488.2651173492, 75187.0, 75816.62091689616, 76289.0, 7373.893915912656, 7549.433792465477, 7550.207228240955, 7707.075150981918, 7771.72798952034, 31074.84462577673, 37510.81244593869, 37595.81202093972, 38958.80520597379, 39438.0, 39848.60151398449, 48131.75934120307, 60940.0, 63416.0, 63634.68182659057, 11208.439578020903, 11400.942995285302, 11407.486663100015, 11583.884161158281, 12285.57000504978, 11703.414829258674, 11982.161248712506, 12198.14612977083, 12293.9100352942, 12680.619581412573, 11762.176647634584, 12345.876541234473, 12555.560555380518, 12714.173578717353, 12783.0, 11699.707507312045, 11889.762204755683, 12373.62879113628, 12416.192947458387, 13564.38960246811, 11978.820317695416, 12582.748345033231, 12704.0, 12846.327559963758, 12938.094333396572, 9750.804983900423, 10229.897701022894, 10395.480225988822, 10396.636117735843, 10421.426821524889, 8957.552122393723, 10273.845892311472, 10286.251337272532, 10371.58513659445, 10411.479426028516], "value": 6610.534693705875, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 116.0, 114.0, 116.0, 117.0, 116.0, 117.0, 116.0, 115.0, 115.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 125.0, 165.0, 186.0, 123.0, 162.0, 148.0, 125.0, 184.0, 123.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 165.0, 164.0, 180.0, 162.0, 164.0, 164.0, 162.0, 163.0, 163.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 77.0, 170.0, 78.0, 76.0, 76.0, 75.0, 151.0, 77.0], "value": 93.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 143.0, 86.0, 86.0, 86.0, 132.0, 86.0, 85.0, 147.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 119.0, 117.0, 117.0, 117.0, 118.0, 117.0, 118.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 147.0, 147.0, 148.0, 147.0, 149.0, 148.0, 147.0, 150.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 100.0, 95.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 63.0, 65.0, 62.0, 62.0, 63.0, 62.0, 63.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 65.0, 65.0, 66.0, 65.0, 66.0, 66.0, 67.0, 67.0, 67.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 81.0, 80.0, 80.0, 83.0, 80.0, 79.0, 79.0, 87.0, 83.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 134.0, 141.0, 138.0, 133.0, 140.0, 142.0, 135.0, 146.0, 140.0], "value": 139.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 168.0, 170.0, 168.0, 171.0, 173.0, 166.0, 169.0, 174.0, 169.0], "value": 170.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 72.0, 70.0, 69.0, 67.0, 67.0, 68.0, 69.0, 67.0], "value": 68.8, "unit": "score"}]}]} 19:17:55 INFO - Return code: 0 19:17:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 19:17:55 ERROR - # TBPL SUCCESS # 19:17:55 INFO - Running post-action listener: _resource_record_post_action 19:17:55 INFO - [mozharness: 2016-08-10 02:17:55.196478Z] Finished run-tests step (success) 19:17:55 INFO - Running post-run listener: _resource_record_post_run 19:17:55 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534704128; Read time: 16; Write time: 511292 19:17:55 INFO - TinderboxPrint: CPU usage
13.4% 19:17:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 19:17:55 INFO - TinderboxPrint: I/O write bytes / time
534,704,128 / 511,292 19:17:55 INFO - TinderboxPrint: CPU idle
8,275.3 (86.6%) 19:17:55 INFO - TinderboxPrint: CPU user
1,218.2 (12.8%) 19:17:55 INFO - TinderboxPrint: Swap in / out
0 / 0 19:17:55 INFO - install - Wall time: 16s; CPU: 14.0%; Read bytes: 0; Write bytes: 250527744; Read time: 0; Write time: 267756 19:17:55 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 284176384; Read time: 0; Write time: 243536 19:17:55 INFO - Running post-run listener: _upload_blobber_files 19:17:55 INFO - Blob upload gear active. 19:17:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 19:17:55 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 19:17:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 19:17:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 19:17:56 INFO - (blobuploader) - INFO - Open directory for files ... 19:17:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 19:17:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 19:17:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:57 INFO - (blobuploader) - INFO - Done attempting. 19:17:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 19:17:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:17:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 19:17:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:17:58 INFO - (blobuploader) - INFO - Done attempting. 19:17:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 19:17:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 19:17:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 19:18:02 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 19:18:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 19:18:02 INFO - (blobuploader) - INFO - Done attempting. 19:18:02 INFO - (blobuploader) - INFO - Iteration through files over. 19:18:02 INFO - Return code: 0 19:18:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 19:18:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 19:18:02 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/731269351bd869acd5134035df0b874fd2a172a881da7eb6204c4a5b841c53612be9ca74c95edc2d370a96be25a63b8658a2e37daa217bc4cb94fa897628f957", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd6c130c83c396f022e2c9428a6b595799ff9a873f18ff8d75fe71347e00caf0c1264a81603fc538a8cddb639b60d42c6a1825907a239f4ab2edae65596ba08b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41d22acc0bb4d46ff7636f6076efe2463b1dc981a6af9fd73a24112cd6b2545ee6eb70c58d72afb2f83f094f8233d3d32a70acec5e82e86c6480c05f779b51c6"} 19:18:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 19:18:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 19:18:02 INFO - Contents: 19:18:02 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/731269351bd869acd5134035df0b874fd2a172a881da7eb6204c4a5b841c53612be9ca74c95edc2d370a96be25a63b8658a2e37daa217bc4cb94fa897628f957", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd6c130c83c396f022e2c9428a6b595799ff9a873f18ff8d75fe71347e00caf0c1264a81603fc538a8cddb639b60d42c6a1825907a239f4ab2edae65596ba08b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41d22acc0bb4d46ff7636f6076efe2463b1dc981a6af9fd73a24112cd6b2545ee6eb70c58d72afb2f83f094f8233d3d32a70acec5e82e86c6480c05f779b51c6"} 19:18:02 INFO - Running post-run listener: copy_logs_to_upload_dir 19:18:02 INFO - Copying logs to upload dir... 19:18:02 INFO - mkdir: /builds/slave/test/build/upload/logs 19:18:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.613050 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-08-09 19:18:02.498514) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 19:18:02.501577) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248 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-Non-PGO/sha512/731269351bd869acd5134035df0b874fd2a172a881da7eb6204c4a5b841c53612be9ca74c95edc2d370a96be25a63b8658a2e37daa217bc4cb94fa897628f957", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd6c130c83c396f022e2c9428a6b595799ff9a873f18ff8d75fe71347e00caf0c1264a81603fc538a8cddb639b60d42c6a1825907a239f4ab2edae65596ba08b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41d22acc0bb4d46ff7636f6076efe2463b1dc981a6af9fd73a24112cd6b2545ee6eb70c58d72afb2f83f094f8233d3d32a70acec5e82e86c6480c05f779b51c6"} build_url:https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011415 build_url: 'https://queue.taskcluster.net/v1/task/RC3Kv9bpSYuHojIVhrB8AQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/731269351bd869acd5134035df0b874fd2a172a881da7eb6204c4a5b841c53612be9ca74c95edc2d370a96be25a63b8658a2e37daa217bc4cb94fa897628f957", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/cd6c130c83c396f022e2c9428a6b595799ff9a873f18ff8d75fe71347e00caf0c1264a81603fc538a8cddb639b60d42c6a1825907a239f4ab2edae65596ba08b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/41d22acc0bb4d46ff7636f6076efe2463b1dc981a6af9fd73a24112cd6b2545ee6eb70c58d72afb2f83f094f8233d3d32a70acec5e82e86c6480c05f779b51c6"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 19:18:02.526615) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 19:18:02.526911) ========= 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=4ac8d263c7293b36a1be1aed000001be-1470788898.894948-733969248 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004448 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 19:18:02.609248) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 19:18:02.609771) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 19:18:02.610108) ========= ========= Total master_lag: 0.20 =========