builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-020 starttime: 1471846584.46 results: success (0) buildid: 20160821203026 builduid: 89c629ce0b0741e0ad2b7eadb635b997 revision: 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.456511) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.456948) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.457252) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.494412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.494699) ========= 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=af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-21 23:16: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 35.4M=0s 2016-08-21 23:16:25 (35.4 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.125732 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.643862) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.644173) ========= 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=af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015031 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.693871) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:24.694236) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 --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 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 --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=af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-21 23:16:25,672 truncating revision to first 12 chars 2016-08-21 23:16:25,672 Setting DEBUG logging. 2016-08-21 23:16:25,672 attempt 1/10 2016-08-21 23:16:25,672 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/64f4ea57b6fd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-21 23:16:25,927 unpacking tar archive at: fx-team-64f4ea57b6fd/testing/mozharness/ program finished with exit code 0 elapsedTime=0.536420 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:25.244357) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:25.244669) ========= script_repo_revision: 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:25.245166) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:25.245467) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-21 23:16:25.255251) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-21 23:16:25.255595) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:16:26 INFO - MultiFileLogger online at 20160821 23:16:26 in /builds/slave/test 23:16:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 23:16:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:16:26 INFO - {'append_to_log': False, 23:16:26 INFO - 'base_work_dir': '/builds/slave/test', 23:16:26 INFO - 'blob_upload_branch': 'Fx-Team', 23:16:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:16:26 INFO - 'branch': 'Fx-Team', 23:16:26 INFO - 'buildbot_json_path': 'buildprops.json', 23:16:26 INFO - 'config_files': ('talos/linux_config.py',), 23:16:26 INFO - 'default_actions': ('clobber', 23:16:26 INFO - 'read-buildbot-config', 23:16:26 INFO - 'download-and-extract', 23:16:26 INFO - 'populate-webroot', 23:16:26 INFO - 'create-virtualenv', 23:16:26 INFO - 'install', 23:16:26 INFO - 'run-tests'), 23:16:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:16:26 INFO - 'download_minidump_stackwalk': True, 23:16:26 INFO - 'download_symbols': 'ondemand', 23:16:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:16:26 INFO - 'tooltool.py': '/tools/tooltool.py', 23:16:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:16:26 INFO - '/tools/misc-python/virtualenv.py')}, 23:16:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:16:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:16:26 INFO - 'installer_path': 'installer.exe', 23:16:26 INFO - 'log_level': 'info', 23:16:26 INFO - 'log_name': 'talos', 23:16:26 INFO - 'log_to_console': True, 23:16:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:16:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:16:26 INFO - 'opt_config_files': (), 23:16:26 INFO - 'pip_index': False, 23:16:26 INFO - 'sps_profile': False, 23:16:26 INFO - 'sps_profile_interval': 0, 23:16:26 INFO - 'suite': 'dromaeojs-e10s', 23:16:26 INFO - 'system_bits': '32', 23:16:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:16:26 INFO - 'title': 'talos-linux64-ix-020', 23:16:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:16:26 INFO - 'use_talos_json': True, 23:16:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:16:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:16:26 INFO - 'work_dir': 'build'} 23:16:26 INFO - [mozharness: 2016-08-22 06:16:26.327225Z] Running clobber step. 23:16:26 INFO - Running pre-action listener: _resource_record_pre_action 23:16:26 INFO - Running main action method: clobber 23:16:26 INFO - rmtree: /builds/slave/test/build 23:16:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:16:27 INFO - Running post-action listener: _resource_record_post_action 23:16:27 INFO - [mozharness: 2016-08-22 06:16:27.312574Z] Finished clobber step (success) 23:16:27 INFO - [mozharness: 2016-08-22 06:16:27.312675Z] Running read-buildbot-config step. 23:16:27 INFO - Running pre-action listener: _resource_record_pre_action 23:16:27 INFO - Running main action method: read_buildbot_config 23:16:27 INFO - Using buildbot properties: 23:16:27 INFO - { 23:16:27 INFO - "project": "", 23:16:27 INFO - "product": "firefox", 23:16:27 INFO - "script_repo_revision": "production", 23:16:27 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 23:16:27 INFO - "repository": "", 23:16:27 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 23:16:27 INFO - "buildid": "20160821203026", 23:16:27 INFO - "pgo_build": "True", 23:16:27 INFO - "basedir": "/builds/slave/test", 23:16:27 INFO - "buildnumber": 695, 23:16:27 INFO - "slavename": "talos-linux64-ix-020", 23:16:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:16:27 INFO - "platform": "ubuntu64_hw", 23:16:27 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 23:16:27 INFO - "branch": "fx-team", 23:16:27 INFO - "repo_path": "integration/fx-team", 23:16:27 INFO - "revision": "64f4ea57b6fde8ed315f5bc8c9caefe389bb8923", 23:16:27 INFO - "stage_platform": "linux64-pgo", 23:16:27 INFO - "builduid": "89c629ce0b0741e0ad2b7eadb635b997", 23:16:27 INFO - "slavebuilddir": "test" 23:16:27 INFO - } 23:16:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 23:16:27 INFO - Running post-action listener: _resource_record_post_action 23:16:27 INFO - [mozharness: 2016-08-22 06:16:27.315130Z] Finished read-buildbot-config step (success) 23:16:27 INFO - [mozharness: 2016-08-22 06:16:27.315219Z] Running download-and-extract step. 23:16:27 INFO - Running pre-action listener: _resource_record_pre_action 23:16:27 INFO - Running main action method: download_and_extract 23:16:27 INFO - mkdir: /builds/slave/test/build/tests 23:16: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')]} 23:16:27 INFO - trying https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:16:27 INFO - Downloading https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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 23:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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 23:16:27 INFO - Downloaded 1361 bytes. 23:16:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 23:16:27 INFO - Using the following test package requirements: 23:16:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:16:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:16:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'jsshell-linux-x86_64.zip'], 23:16:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:16:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 23:16:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:16:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:16:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:16:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 23:16:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:16:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:16: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')]} 23:16:27 INFO - trying https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:27 INFO - Downloading https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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 23:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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 23:16:28 INFO - Downloaded 21920470 bytes. 23:16:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 23:16:33 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 23:16: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')]} 23:16:33 INFO - trying https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 23:16:33 INFO - Downloading https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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 23:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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 23:16:33 INFO - Downloaded 21920470 bytes. 23:16:33 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 23:16: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')]} 23:16:38 INFO - trying https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 23:16:38 INFO - Downloading https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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 23:16:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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 23:16:39 INFO - Downloaded 14413981 bytes. 23:16:39 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 23:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:39 INFO - trying https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:39 INFO - Downloading https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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 23:16:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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 23:16:40 INFO - Downloaded 59704317 bytes. 23:16:40 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:40 INFO - mkdir: /builds/slave/test/properties 23:16:40 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:16:40 INFO - Writing to file /builds/slave/test/properties/build_url 23:16:40 INFO - Contents: 23:16:40 INFO - build_url:https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 23:16:41 INFO - Running post-action listener: _resource_record_post_action 23:16:41 INFO - Running post-action listener: set_extra_try_arguments 23:16:41 INFO - [mozharness: 2016-08-22 06:16:41.331359Z] Finished download-and-extract step (success) 23:16:41 INFO - [mozharness: 2016-08-22 06:16:41.331583Z] Running populate-webroot step. 23:16:41 INFO - Running pre-action listener: _resource_record_pre_action 23:16:41 INFO - Running main action method: populate_webroot 23:16:41 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:16:41 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:16:41 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:16:41 INFO - '--tppagecycles', 23:16:41 INFO - '7'], 23:16:41 INFO - 'tests': ['tsvgm']}}, 23:16:41 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:16:41 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:16:41 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:16:41 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:16:41 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:41 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:16:41 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['damp', 'tps']}, 23:16:41 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'tests': ['damp', 'tps']}, 23:16:41 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['dromaeo_dom']}, 23:16:41 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:16:41 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['basic_compositor_video']}, 23:16:41 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:16:41 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'other-e10s': {'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['a11yr', 23:16:41 INFO - 'ts_paint', 23:16:41 INFO - 'tpaint', 23:16:41 INFO - 'sessionrestore', 23:16:41 INFO - 'sessionrestore_no_auto_restore', 23:16:41 INFO - 'tabpaint']}, 23:16:41 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['tsvgx', 23:16:41 INFO - 'tsvgr_opacity', 23:16:41 INFO - 'tart', 23:16:41 INFO - 'tscrollx', 23:16:41 INFO - 'cart']}, 23:16:41 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:16:41 INFO - 'tsvgr_opacity', 23:16:41 INFO - 'tart', 23:16:41 INFO - 'tscrollx', 23:16:41 INFO - 'cart']}, 23:16:41 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'talos_options': ['--disable-e10s'], 23:16:41 INFO - 'tests': ['tp5o']}, 23:16:41 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'tests': ['tp5o']}, 23:16:41 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'talos_options': ['--disable-e10s', 23:16:41 INFO - '--xperf_path', 23:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:41 INFO - 'tests': ['tp5n']}, 23:16:41 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:16:41 INFO - 'talos_options': ['--xperf_path', 23:16:41 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:16:41 INFO - 'tests': ['tp5n']}}, 23:16:41 INFO - 'talos.zip': {'path': '', 23:16:41 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:16:41 INFO - Running post-action listener: _resource_record_post_action 23:16:41 INFO - [mozharness: 2016-08-22 06:16:41.346869Z] Finished populate-webroot step (success) 23:16:41 INFO - [mozharness: 2016-08-22 06:16:41.346957Z] Running create-virtualenv step. 23:16:41 INFO - Running pre-action listener: _resource_record_pre_action 23:16:41 INFO - Running main action method: create_virtualenv 23:16:41 INFO - Creating virtualenv /builds/slave/test/build/venv 23:16:41 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 23:16:41 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:16:41 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:16:41 INFO - Using real prefix '/usr' 23:16:41 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:16:41 INFO - Installing distribute.............................................................................................................................................................................................done. 23:16:43 INFO - Installing pip.................done. 23:16:43 INFO - Return code: 0 23:16:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37819f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1670850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b370>, '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 0x166e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166ed80>, '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': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', '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 23:16: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', 'pip>=1.5'] in /builds/slave/test/build 23:16: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 pip>=1.5 23:16:43 INFO - Using env: {'DISPLAY': ':0', 23:16:43 INFO - 'HOME': '/home/cltbld', 23:16:43 INFO - 'LANG': 'en_US.UTF-8', 23:16:43 INFO - 'LANGUAGE': 'en_US:en', 23:16:43 INFO - 'LOGNAME': 'cltbld', 23:16:43 INFO - 'MAIL': '/var/mail/cltbld', 23:16:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:43 INFO - 'MOZ_NO_REMOTE': '1', 23:16:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:43 INFO - 'NO_EM_RESTART': '1', 23:16:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:43 INFO - 'PWD': '/builds/slave/test', 23:16:43 INFO - 'SHELL': '/bin/bash', 23:16:43 INFO - 'SHLVL': '1', 23:16:43 INFO - 'TERM': 'linux', 23:16:43 INFO - 'TMOUT': '86400', 23:16:43 INFO - 'USER': 'cltbld', 23:16:43 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', 23:16:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:43 INFO - '_': '/tools/buildbot/bin/python'} 23:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:44 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 23:16:44 INFO - Cleaning up... 23:16:44 INFO - Return code: 0 23:16:44 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:44 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 0x7f37819f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1670850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b370>, '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 0x166e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166ed80>, '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': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', '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 23:16:44 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 23:16:44 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 23:16:44 INFO - Using env: {'DISPLAY': ':0', 23:16:44 INFO - 'HOME': '/home/cltbld', 23:16:44 INFO - 'LANG': 'en_US.UTF-8', 23:16:44 INFO - 'LANGUAGE': 'en_US:en', 23:16:44 INFO - 'LOGNAME': 'cltbld', 23:16:44 INFO - 'MAIL': '/var/mail/cltbld', 23:16:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:44 INFO - 'MOZ_NO_REMOTE': '1', 23:16:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:44 INFO - 'NO_EM_RESTART': '1', 23:16:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:44 INFO - 'PWD': '/builds/slave/test', 23:16:44 INFO - 'SHELL': '/bin/bash', 23:16:44 INFO - 'SHLVL': '1', 23:16:44 INFO - 'TERM': 'linux', 23:16:44 INFO - 'TMOUT': '86400', 23:16:44 INFO - 'USER': 'cltbld', 23:16:44 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', 23:16:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:44 INFO - '_': '/tools/buildbot/bin/python'} 23:16:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:44 INFO - Downloading/unpacking psutil>=3.1.1 23:16:44 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 23:16:44 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 23:16:44 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 23:16:44 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 23:16:44 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 23:16:44 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 23:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:16:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:46 INFO - Installing collected packages: psutil 23:16:46 INFO - Running setup.py install for psutil 23:16:46 INFO - building 'psutil._psutil_linux' extension 23:16:46 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 23:16:46 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 23:16:46 INFO - building 'psutil._psutil_posix' extension 23:16:46 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 23:16:46 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 23:16:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:16:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:16:46 INFO - Successfully installed psutil 23:16:46 INFO - Cleaning up... 23:16:46 INFO - Return code: 0 23:16:46 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f37819f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1670850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b370>, '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 0x166e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166ed80>, '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': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', '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 23:16: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:16: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 mozsystemmonitor==0.3 23:16:46 INFO - Using env: {'DISPLAY': ':0', 23:16:46 INFO - 'HOME': '/home/cltbld', 23:16:46 INFO - 'LANG': 'en_US.UTF-8', 23:16:46 INFO - 'LANGUAGE': 'en_US:en', 23:16:46 INFO - 'LOGNAME': 'cltbld', 23:16:46 INFO - 'MAIL': '/var/mail/cltbld', 23:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:46 INFO - 'MOZ_NO_REMOTE': '1', 23:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:46 INFO - 'NO_EM_RESTART': '1', 23:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:46 INFO - 'PWD': '/builds/slave/test', 23:16:46 INFO - 'SHELL': '/bin/bash', 23:16:46 INFO - 'SHLVL': '1', 23:16:46 INFO - 'TERM': 'linux', 23:16:46 INFO - 'TMOUT': '86400', 23:16:46 INFO - 'USER': 'cltbld', 23:16:46 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', 23:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:46 INFO - '_': '/tools/buildbot/bin/python'} 23:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:16:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:16:49 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:16:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:16:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:16:49 INFO - Installing collected packages: mozsystemmonitor 23:16:49 INFO - Running setup.py install for mozsystemmonitor 23:16:49 INFO - Successfully installed mozsystemmonitor 23:16:49 INFO - Cleaning up... 23:16:49 INFO - Return code: 0 23:16:49 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:16: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')]} 23:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16: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')]} 23:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:49 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 0x7f37819f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1670850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b370>, '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 0x166e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166ed80>, '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': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', '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 23:16:49 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 23:16:49 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 23:16:49 INFO - Using env: {'DISPLAY': ':0', 23:16:49 INFO - 'HOME': '/home/cltbld', 23:16:49 INFO - 'LANG': 'en_US.UTF-8', 23:16:49 INFO - 'LANGUAGE': 'en_US:en', 23:16:49 INFO - 'LOGNAME': 'cltbld', 23:16:49 INFO - 'MAIL': '/var/mail/cltbld', 23:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:49 INFO - 'MOZ_NO_REMOTE': '1', 23:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:49 INFO - 'NO_EM_RESTART': '1', 23:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:49 INFO - 'PWD': '/builds/slave/test', 23:16:49 INFO - 'SHELL': '/bin/bash', 23:16:49 INFO - 'SHLVL': '1', 23:16:49 INFO - 'TERM': 'linux', 23:16:49 INFO - 'TMOUT': '86400', 23:16:49 INFO - 'USER': 'cltbld', 23:16:49 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', 23:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:49 INFO - '_': '/tools/buildbot/bin/python'} 23:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:49 INFO - Downloading/unpacking jsonschema==2.5.1 23:16:49 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 23:16:49 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 23:16:49 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 23:16:49 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 23:16:49 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 23:16:49 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 23:16:51 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:16:51 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:16:51 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 23:16:51 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 23:16:51 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 23:16:51 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 23:16:51 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 23:16:51 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 23:16:51 INFO - Downloading functools32-3.2.3-2.tar.gz 23:16:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:16:51 INFO - warning: no files found matching '*.txt' 23:16:51 INFO - no previously-included directories found matching 'build' 23:16:51 INFO - no previously-included directories found matching 'dist' 23:16:51 INFO - no previously-included directories found matching '.git*' 23:16:51 INFO - Installing collected packages: jsonschema, functools32 23:16:51 INFO - Running setup.py install for functools32 23:16:51 INFO - warning: no files found matching '*.txt' 23:16:51 INFO - no previously-included directories found matching 'build' 23:16:51 INFO - no previously-included directories found matching 'dist' 23:16:51 INFO - no previously-included directories found matching '.git*' 23:16:51 INFO - Successfully installed jsonschema functools32 23:16:51 INFO - Cleaning up... 23:16:51 INFO - Return code: 0 23:16:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 23:16:51 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')]} 23:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:51 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')]} 23:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:51 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 0x7f37819f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1670850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b370>, '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 0x166e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166ed80>, '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': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', '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 23:16:51 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 23:16:51 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 23:16:51 INFO - Using env: {'DISPLAY': ':0', 23:16:51 INFO - 'HOME': '/home/cltbld', 23:16:51 INFO - 'LANG': 'en_US.UTF-8', 23:16:51 INFO - 'LANGUAGE': 'en_US:en', 23:16:51 INFO - 'LOGNAME': 'cltbld', 23:16:51 INFO - 'MAIL': '/var/mail/cltbld', 23:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:51 INFO - 'MOZ_NO_REMOTE': '1', 23:16:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:51 INFO - 'NO_EM_RESTART': '1', 23:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:52 INFO - 'PWD': '/builds/slave/test', 23:16:52 INFO - 'SHELL': '/bin/bash', 23:16:52 INFO - 'SHLVL': '1', 23:16:52 INFO - 'TERM': 'linux', 23:16:52 INFO - 'TMOUT': '86400', 23:16:52 INFO - 'USER': 'cltbld', 23:16:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', 23:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:52 INFO - '_': '/tools/buildbot/bin/python'} 23:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 23:16:52 INFO - Cleaning up... 23:16:52 INFO - Return code: 0 23:16:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:16:52 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')]} 23:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:52 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')]} 23:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:52 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 0x7f37819f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1670850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b370>, '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 0x166e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166ed80>, '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': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', '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 23:16:52 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 23:16:52 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 23:16:52 INFO - Using env: {'DISPLAY': ':0', 23:16:52 INFO - 'HOME': '/home/cltbld', 23:16:52 INFO - 'LANG': 'en_US.UTF-8', 23:16:52 INFO - 'LANGUAGE': 'en_US:en', 23:16:52 INFO - 'LOGNAME': 'cltbld', 23:16:52 INFO - 'MAIL': '/var/mail/cltbld', 23:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:52 INFO - 'MOZ_NO_REMOTE': '1', 23:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:52 INFO - 'NO_EM_RESTART': '1', 23:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:52 INFO - 'PWD': '/builds/slave/test', 23:16:52 INFO - 'SHELL': '/bin/bash', 23:16:52 INFO - 'SHLVL': '1', 23:16:52 INFO - 'TERM': 'linux', 23:16:52 INFO - 'TMOUT': '86400', 23:16:52 INFO - 'USER': 'cltbld', 23:16:52 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', 23:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:52 INFO - '_': '/tools/buildbot/bin/python'} 23:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:52 INFO - Downloading/unpacking blobuploader==1.2.4 23:16:52 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 23:16:52 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 23:16:52 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 23:16:52 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 23:16:52 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 23:16:52 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 23:16:54 INFO - Downloading blobuploader-1.2.4.tar.gz 23:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:16:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:16:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16: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 23:16:55 INFO - Downloading docopt-0.6.1.tar.gz 23:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:16:55 INFO - Installing collected packages: blobuploader, requests, docopt 23:16:55 INFO - Running setup.py install for blobuploader 23:16:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:16:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:16:55 INFO - Running setup.py install for requests 23:16:55 INFO - Running setup.py install for docopt 23:16:55 INFO - Successfully installed blobuploader requests docopt 23:16:55 INFO - Cleaning up... 23:16:55 INFO - Return code: 0 23:16:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:55 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')]} 23:16:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:55 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')]} 23:16:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:55 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 0x7f37819f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1670850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b370>, '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 0x166e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166ed80>, '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': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', '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 23:16:55 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 23:16:55 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 23:16:55 INFO - Using env: {'DISPLAY': ':0', 23:16:55 INFO - 'HOME': '/home/cltbld', 23:16:55 INFO - 'LANG': 'en_US.UTF-8', 23:16:55 INFO - 'LANGUAGE': 'en_US:en', 23:16:55 INFO - 'LOGNAME': 'cltbld', 23:16:55 INFO - 'MAIL': '/var/mail/cltbld', 23:16:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:55 INFO - 'MOZ_NO_REMOTE': '1', 23:16:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:55 INFO - 'NO_EM_RESTART': '1', 23:16:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:55 INFO - 'PWD': '/builds/slave/test', 23:16:55 INFO - 'SHELL': '/bin/bash', 23:16:55 INFO - 'SHLVL': '1', 23:16:55 INFO - 'TERM': 'linux', 23:16:55 INFO - 'TMOUT': '86400', 23:16:55 INFO - 'USER': 'cltbld', 23:16:55 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', 23:16:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:55 INFO - '_': '/tools/buildbot/bin/python'} 23:16:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:55 INFO - Running setup.py (path:/tmp/pip-NLNL07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:55 INFO - Running setup.py (path:/tmp/pip-YG7zIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:56 INFO - Running setup.py (path:/tmp/pip-DFvJKv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:56 INFO - Running setup.py (path:/tmp/pip-JqrRiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:56 INFO - Running setup.py (path:/tmp/pip-wNeN7w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:56 INFO - Running setup.py (path:/tmp/pip-cp_PDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:56 INFO - Running setup.py (path:/tmp/pip-Z7kSJA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:56 INFO - Running setup.py (path:/tmp/pip-b1eK5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:56 INFO - Running setup.py (path:/tmp/pip-D1Gcj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:56 INFO - Running setup.py (path:/tmp/pip-tCtCNb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:56 INFO - Running setup.py (path:/tmp/pip-8JgUVU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:56 INFO - Running setup.py (path:/tmp/pip-vwJANb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:16:56 INFO - Running setup.py (path:/tmp/pip-jZkQq3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:16:56 INFO - Running setup.py (path:/tmp/pip-DXoddM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:56 INFO - Running setup.py (path:/tmp/pip-7Wsfve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:16:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:16:56 INFO - Running setup.py (path:/tmp/pip-_pvD_5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:16:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:16:57 INFO - Running setup.py (path:/tmp/pip-MELsDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:16:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:16:57 INFO - Running setup.py install for manifestparser 23:16:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Running setup.py install for mozcrash 23:16:57 INFO - Running setup.py install for mozdebug 23:16:57 INFO - Running setup.py install for mozdevice 23:16:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Running setup.py install for mozfile 23:16:57 INFO - Running setup.py install for mozhttpd 23:16:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Running setup.py install for mozinfo 23:16:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Running setup.py install for mozInstall 23:16:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:16:57 INFO - Running setup.py install for mozleak 23:16:58 INFO - Running setup.py install for mozlog 23:16:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for moznetwork 23:16:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for mozprocess 23:16:58 INFO - Running setup.py install for mozprofile 23:16:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for mozrunner 23:16:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Running setup.py install for mozscreenshot 23:16:58 INFO - Running setup.py install for moztest 23:16:58 INFO - Running setup.py install for mozversion 23:16:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:16:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:16:58 INFO - Cleaning up... 23:16:58 INFO - Return code: 0 23:16:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:16:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:16:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:16:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:16:58 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 0x7f37819f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1670850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b370>, '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 0x166e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166ed80>, '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': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', '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 23:16:58 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 23:16:58 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 23:16:58 INFO - Using env: {'DISPLAY': ':0', 23:16:58 INFO - 'HOME': '/home/cltbld', 23:16:58 INFO - 'LANG': 'en_US.UTF-8', 23:16:58 INFO - 'LANGUAGE': 'en_US:en', 23:16:58 INFO - 'LOGNAME': 'cltbld', 23:16:58 INFO - 'MAIL': '/var/mail/cltbld', 23:16:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:16:58 INFO - 'MOZ_NO_REMOTE': '1', 23:16:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:16:58 INFO - 'NO_EM_RESTART': '1', 23:16:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:16:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:16:58 INFO - 'PWD': '/builds/slave/test', 23:16:58 INFO - 'SHELL': '/bin/bash', 23:16:58 INFO - 'SHLVL': '1', 23:16:58 INFO - 'TERM': 'linux', 23:16:58 INFO - 'TMOUT': '86400', 23:16:58 INFO - 'USER': 'cltbld', 23:16:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', 23:16:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:16:58 INFO - '_': '/tools/buildbot/bin/python'} 23:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:16:59 INFO - Running setup.py (path:/tmp/pip-R_aqbo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:16:59 INFO - Running setup.py (path:/tmp/pip-ASqI8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:16:59 INFO - Running setup.py (path:/tmp/pip-chu8Qr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:16:59 INFO - Running setup.py (path:/tmp/pip-bnQkoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:16:59 INFO - Running setup.py (path:/tmp/pip-39KFLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:16:59 INFO - Running setup.py (path:/tmp/pip-QqwnHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:16:59 INFO - Running setup.py (path:/tmp/pip-GO0Na7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:16:59 INFO - Running setup.py (path:/tmp/pip-4BfPtG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:16:59 INFO - Running setup.py (path:/tmp/pip-mb9Hcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:16:59 INFO - Running setup.py (path:/tmp/pip-ozY0Za-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:16:59 INFO - Running setup.py (path:/tmp/pip-VXa1Ae-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:16:59 INFO - Running setup.py (path:/tmp/pip-zSTwgN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:16:59 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)) 23:16:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:17:00 INFO - Running setup.py (path:/tmp/pip-fR5wF8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:17:00 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)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:17:00 INFO - Running setup.py (path:/tmp/pip-pKsYA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:17:00 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)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:00 INFO - Running setup.py (path:/tmp/pip-8BpyOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:17:00 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)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:17:00 INFO - Running setup.py (path:/tmp/pip-sazH7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:17:00 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)) 23:17:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:17:00 INFO - Running setup.py (path:/tmp/pip-1ucjda-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:17:00 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)) 23:17:00 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)) 23:17:00 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)) 23:17:00 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)) 23:17:00 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)) 23:17:00 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)) 23:17:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:17:00 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 23:17:00 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 23:17:00 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 23:17:00 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 23:17:00 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 23:17:00 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 23:17:02 INFO - Downloading blessings-1.6.tar.gz 23:17:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:17:02 INFO - Installing collected packages: blessings 23:17:02 INFO - Running setup.py install for blessings 23:17:02 INFO - Successfully installed blessings 23:17:02 INFO - Cleaning up... 23:17:02 INFO - Return code: 0 23:17:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:17:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:02 INFO - Reading from file tmpfile_stdout 23:17:02 INFO - Current package versions: 23:17:02 INFO - argparse == 1.2.1 23:17:02 INFO - blessings == 1.6 23:17:02 INFO - blobuploader == 1.2.4 23:17:02 INFO - docopt == 0.6.1 23:17:02 INFO - functools32 == 3.2.3-2 23:17:02 INFO - jsonschema == 2.5.1 23:17:02 INFO - manifestparser == 1.1 23:17:02 INFO - mozInstall == 1.12 23:17:02 INFO - mozcrash == 0.17 23:17:02 INFO - mozdebug == 0.1 23:17:02 INFO - mozdevice == 0.48 23:17:02 INFO - mozfile == 1.2 23:17:02 INFO - mozhttpd == 0.7 23:17:02 INFO - mozinfo == 0.9 23:17:02 INFO - mozleak == 0.1 23:17:02 INFO - mozlog == 3.3 23:17:02 INFO - moznetwork == 0.27 23:17:02 INFO - mozprocess == 0.23 23:17:02 INFO - mozprofile == 0.28 23:17:02 INFO - mozrunner == 6.12 23:17:02 INFO - mozscreenshot == 0.1 23:17:02 INFO - mozsystemmonitor == 0.3 23:17:02 INFO - moztest == 0.7 23:17:02 INFO - mozversion == 1.4 23:17:02 INFO - psutil == 3.1.1 23:17:02 INFO - requests == 1.2.3 23:17:02 INFO - wsgiref == 0.1.2 23:17:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:17:02 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')]} 23:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:02 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')]} 23:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:02 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 0x7f37819f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1670850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b370>, '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 0x166e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166ed80>, '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': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', '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 23:17:02 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 23:17:02 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 23:17:02 INFO - Using env: {'DISPLAY': ':0', 23:17:02 INFO - 'HOME': '/home/cltbld', 23:17:02 INFO - 'LANG': 'en_US.UTF-8', 23:17:02 INFO - 'LANGUAGE': 'en_US:en', 23:17:02 INFO - 'LOGNAME': 'cltbld', 23:17:02 INFO - 'MAIL': '/var/mail/cltbld', 23:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:02 INFO - 'MOZ_NO_REMOTE': '1', 23:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:02 INFO - 'NO_EM_RESTART': '1', 23:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:02 INFO - 'PWD': '/builds/slave/test', 23:17:02 INFO - 'SHELL': '/bin/bash', 23:17:02 INFO - 'SHLVL': '1', 23:17:02 INFO - 'TERM': 'linux', 23:17:02 INFO - 'TMOUT': '86400', 23:17:02 INFO - 'USER': 'cltbld', 23:17:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', 23:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:02 INFO - '_': '/tools/buildbot/bin/python'} 23:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 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)) 23:17:02 INFO - Cleaning up... 23:17:02 INFO - Return code: 0 23:17:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:17:02 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')]} 23:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:17:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:02 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')]} 23:17:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:17:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:17:02 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 0x7f37819f8f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15a38a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1670850>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x166b370>, '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 0x166e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166ed80>, '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': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', '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 23:17:02 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 23:17:02 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 23:17:02 INFO - Using env: {'DISPLAY': ':0', 23:17:02 INFO - 'HOME': '/home/cltbld', 23:17:02 INFO - 'LANG': 'en_US.UTF-8', 23:17:02 INFO - 'LANGUAGE': 'en_US:en', 23:17:02 INFO - 'LOGNAME': 'cltbld', 23:17:02 INFO - 'MAIL': '/var/mail/cltbld', 23:17:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:02 INFO - 'MOZ_NO_REMOTE': '1', 23:17:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:02 INFO - 'NO_EM_RESTART': '1', 23:17:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:02 INFO - 'PWD': '/builds/slave/test', 23:17:02 INFO - 'SHELL': '/bin/bash', 23:17:02 INFO - 'SHLVL': '1', 23:17:02 INFO - 'TERM': 'linux', 23:17:02 INFO - 'TMOUT': '86400', 23:17:02 INFO - 'USER': 'cltbld', 23:17:02 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', 23:17:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:02 INFO - '_': '/tools/buildbot/bin/python'} 23:17:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:17:03 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:17:03 INFO - Cleaning up... 23:17:03 INFO - Return code: 0 23:17:03 INFO - Running post-action listener: _resource_record_post_action 23:17:03 INFO - Running post-action listener: _start_resource_monitoring 23:17:03 INFO - Starting resource monitoring. 23:17:03 INFO - [mozharness: 2016-08-22 06:17:03.176747Z] Finished create-virtualenv step (success) 23:17:03 INFO - [mozharness: 2016-08-22 06:17:03.177206Z] Running install step. 23:17:03 INFO - Running pre-action listener: _resource_record_pre_action 23:17:03 INFO - Running main action method: install 23:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:17:03 INFO - Reading from file tmpfile_stdout 23:17:03 INFO - Detecting whether we're running mozinstall >=1.0... 23:17:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:17:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:17:03 INFO - Reading from file tmpfile_stdout 23:17:03 INFO - Output received: 23:17:03 INFO - Usage: mozinstall [options] installer 23:17:03 INFO - Options: 23:17:03 INFO - -h, --help show this help message and exit 23:17:03 INFO - -d DEST, --destination=DEST 23:17:03 INFO - Directory to install application into. [default: 23:17:03 INFO - "/builds/slave/test"] 23:17:03 INFO - --app=APP Application being installed. [default: firefox] 23:17:03 INFO - mkdir: /builds/slave/test/build/application 23:17:03 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'] 23:17:03 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 23:17:20 INFO - Reading from file tmpfile_stdout 23:17:20 INFO - Output received: 23:17:20 INFO - /builds/slave/test/build/application/firefox/firefox 23:17:20 INFO - Running post-action listener: _resource_record_post_action 23:17:20 INFO - [mozharness: 2016-08-22 06:17:20.480121Z] Finished install step (success) 23:17:20 INFO - [mozharness: 2016-08-22 06:17:20.480367Z] Running run-tests step. 23:17:20 INFO - Running pre-action listener: _resource_record_pre_action 23:17:20 INFO - Running main action method: run_tests 23:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:17:20 INFO - Python 2.7.3 23:17:20 INFO - Return code: 0 23:17:20 INFO - grabbing minidump binary from tooltool 23:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 23:17:20 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 0x166b370>, '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 0x166e8f0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x166ed80>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:17:20 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 23:17:20 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 23:17:20 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 23:17:20 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:17:20 INFO - Return code: 0 23:17:20 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:17:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:17:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:17:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:17:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:17:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 23:17:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --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 23:17:20 INFO - Using env: {'DISPLAY': ':0', 23:17:20 INFO - 'HOME': '/home/cltbld', 23:17:20 INFO - 'LANG': 'en_US.UTF-8', 23:17:20 INFO - 'LANGUAGE': 'en_US:en', 23:17:20 INFO - 'LOGNAME': 'cltbld', 23:17:20 INFO - 'MAIL': '/var/mail/cltbld', 23:17:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:17:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:17:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:17:20 INFO - 'MOZ_NO_REMOTE': '1', 23:17:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:17:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:17:20 INFO - 'NO_EM_RESTART': '1', 23:17:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:17:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:17:20 INFO - 'PWD': '/builds/slave/test', 23:17:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:17:20 INFO - 'SHELL': '/bin/bash', 23:17:20 INFO - 'SHLVL': '1', 23:17:20 INFO - 'TERM': 'linux', 23:17:20 INFO - 'TMOUT': '86400', 23:17:20 INFO - 'USER': 'cltbld', 23:17:20 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889', 23:17:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:17:20 INFO - '_': '/tools/buildbot/bin/python'} 23:17:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--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 23:17:20 INFO - mozversion application_buildid: 20160821203026 23:17:20 INFO - mozversion application_changeset: 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 23:17:20 INFO - mozversion application_display_name: Nightly 23:17:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:17:20 INFO - mozversion application_name: Firefox 23:17:20 INFO - mozversion application_remotingname: firefox 23:17:20 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 23:17:20 INFO - mozversion application_vendor: Mozilla 23:17:20 INFO - mozversion application_version: 51.0a1 23:17:20 INFO - mozversion platform_buildid: 20160821203026 23:17:20 INFO - mozversion platform_changeset: 64f4ea57b6fde8ed315f5bc8c9caefe389bb8923 23:17:20 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 23:17:20 INFO - mozversion platform_version: 51.0a1 23:17:20 INFO - using testdate: 1471846640 23:17:20 INFO - actual date: 1471846640 23:17:20 INFO - starting webserver on 'localhost:37630' 23:17:20 INFO - SUITE-START | Running 2 tests 23:17:20 INFO - TEST-START | dromaeo_css 23:17:20 INFO - operating with platform_type : linux_ 23:17:20 INFO - Initialising browser for dromaeo_css test... 23:17:20 INFO - TEST-INFO | started process 6968 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLh0z_w/profile http://localhost:37630/getInfo.html) 23:17:25 INFO - PROCESS | 6968 | __metrics Screen width/height:1600/1200 23:17:25 INFO - PROCESS | 6968 | colorDepth:24 23:17:25 INFO - PROCESS | 6968 | Browser inner width/height: 1024/697 23:17:25 INFO - PROCESS | 6968 | __metrics 23:17:26 ERROR - PROCESS | 6968 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 23:17:27 INFO - TEST-INFO | 6968: exit 0 23:17:27 INFO - Browser initialized. 23:17:27 INFO - Running cycle 1/1 for dromaeo_css test... 23:17:27 INFO - TEST-INFO | started process 7088 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLh0z_w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:17:39 INFO - PROCESS | 7088 | RSS: Main: 186920960 23:17:39 INFO - PROCESS | 7088 | 23:18:28 INFO - PROCESS | 7088 | 1471846708826 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] 23:20:38 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37630/tests/dromaeo/cssquery-ext.html) 23:20:39 INFO - PROCESS | 7088 | RSS: Main: 199467008 23:20:39 INFO - PROCESS | 7088 | 23:23:41 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-ext.html (next: http://localhost:37630/tests/dromaeo/cssquery-jquery.html) 23:23:42 INFO - PROCESS | 7088 | RSS: Main: 198225920 23:23:42 INFO - PROCESS | 7088 | 23:26:44 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37630/tests/dromaeo/cssquery-mootools.html) 23:26:44 INFO - PROCESS | 7088 | RSS: Main: 199368704 23:26:44 INFO - PROCESS | 7088 | 23:29:46 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37630/tests/dromaeo/cssquery-prototype.html) 23:29:47 INFO - PROCESS | 7088 | RSS: Main: 196796416 23:29:47 INFO - PROCESS | 7088 | 23:32:49 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37630/tests/dromaeo/cssquery-yui.html) 23:32:50 INFO - PROCESS | 7088 | RSS: Main: 199471104 23:32:50 INFO - PROCESS | 7088 | 23:35:53 INFO - PROCESS | 7088 | Cycle 1(1): loaded http://localhost:37630/tests/dromaeo/cssquery-yui.html (next: http://localhost:37630/tests/dromaeo/cssquery-dojo.html) 23:35:53 INFO - PROCESS | 7088 | RSS: Main: 199741440 23:35:53 INFO - PROCESS | 7088 | 23:35:53 INFO - PROCESS | 7088 | __start_tp_report 23:35:53 INFO - PROCESS | 7088 | _x_x_mozilla_page_load 23:35:53 INFO - PROCESS | 7088 | _x_x_mozilla_page_load_details 23:35:53 INFO - PROCESS | 7088 | |i|pagename|runs| 23:35:53 INFO - PROCESS | 7088 | |0;dojo.html;3108.782385233034;3143.7485001199907;3150.968490315096;3152.8423578821066;3162.335909459012;5292.470752924715;5448.346198456185;5481.643693159952;5526.143447765603;5541.002619528484;5357.464253574641;5360.839174824761;5410.810621628244;5440.591955603326;5450.373207081187;4732.337472753818;4917.655764096515;4998.925016124743;5061.417936937244;5068.315777370045;5000.224965130411;5010.774515146809;5056.19100943849;5056.924146137811;5061.54446099851;4809.038192361524;4867.853964381075;4905.681130726492;4932.2108462646165;4934.185859333224;4926.8768280793265;4945.876353091166;4980.626453016002;4995.775190116454;5003.249512573107;4920.065187614342;4959.032988567231;4963.1810751226;4986.526280003394;4993.375828021497;5311.867203319909;5401.189821526802;5405.081136206854;5429.131338985783;5463.262459567947;5903.527717782567;5936.406359364072;5944.7027648617395;5948.464638182541;5950.077737950624;5934.228550288478;5938.257717785277;5941.821745347646;5945.702714864239;5972.552058595579;5234.607404444644;5332.066888294533;5345.331833520771;5369.24830523727;5452.809151679751;5927.110933359944;5930.822075337746;5938.257717785277;5950.672713000827;5955.970220148958;5650.180723795109;5675.432456754292;5717.113847353667;5725.255716756795;5726.599138060295;5602.523785478198;5693.4875861172695;5724;5749.913751293734;5796.478316951495;5770.365259821417;5785.103308987113;5788.27646544182;5808.6224395414165;5809.448102430262;5767.077267637158;5806.854828629318;5825.796097136665;5830.125481177857;5832.941670583325;4379.540148284448;4431.800568974404;4456.131054444417;4458.665600080007;4556.225441674923;4020.336644453691;4024.7182697210915;4024.9798751006056;4028.315186418316;4033.072393349546;5618.85952851182;5624.6625202487985;5627.915581266284;5631.971840140773;5643.266375371176;5756.510696590837;5761.193432919395;5766.221560089334;5837.6497410155525;5862.824115276549;5555.3333599967455;5559.722013899289;5559.805406810823;5567.192757050286;5575.219469274305;4954.950450495521;5036.924446133311;5041.0422019816115;5046.646734728607;5051.823186188466;5931.673757943268;5993.31076926159;6018.3680713524445;6049.334573197033;6052.54605904559;5832.037713777179;5839.912401313899;5840.445157710011;5856.59003869725;5860.824175274749;5826.592138550261;5904.793332233351;6018.879622407615;6049.243844519435;6054.212952316171;5673.092305231144;5793.768249269982;5797.188393624811;5800.564957628279;5801.419858014165;5822.592418530662;5833.533317334688;5863.706814659165;5880.206172166702;5886.764529418947;5576.721163941867;5656.547476201977;5736.254286942671;5752.482276595127;5755.8561035974435;5677.063284558167;5765.509931655856;5768.278965129359;5773.53811695055;5778.56660750437;5650.547956163415;5669.064604340238;5712.885742285048;5714.657120572779;5744.741486633028;5563.7496312666835;5616.129499927518;5763.250777398911;5772.7690892363835;5784.479396854304;5487.560995120461;5613;5631.746571404215;5636.661800291996;5654.6324488908085 23:35:53 INFO - PROCESS | 7088 | |1;ext.html;575.8819442014386;586.4692453329739;589.3340525206513;593.8871614393266;618.6597371445704;39764.801175994115;43611.78194109029;43684.78157609215;43771;43798.12403751923;43825;44163.337549936776;44433.111337773225;44555.77722111393;44594.55405445945;8838.91161088389;8971.416857904247;8999.5050272235;9000.819983600324;9021.909780902206;8848.867266991001;8883.200511953923;8927.732168034969;8929.642814287454;9010.54947252638;9055.366124371296;9055.954720226422;9099.863502047474;9113.863292050624;9116.726498205064;8909.331800114953;8947.597358118835;8962.327825413087;9015.729528114167;9044.502552359618;8827.117288271185;8884.600192991331;8905.73282801517;8945.552722363856;8949.910500894974;41530;41803.790981045204;41995.37006944898;41997;42053.78973105115;3538.327717733648;3622.4747411625167;3633.7638053526434;3681.44778283257;3729.9067523311865;31475.842620786978;32286.35427291441;32429.837850810833;32494;32799.83600082008;4409;4566.931496027562;4678.204705200124;4749.596284315838;4762.714237145748;356179;358592.31261499017;358751;358817.20591397135;359688;34414.31171376609;35443.29113417717;57939;58191.12713309304;58614.70692646595;37446.43830342547;37566.81216593954;37604.247915041546;37656.623433765315;37841.62158378436;15735.527934161993;15837.68324633501;15882.285297161425;16035;16054.598635034217;13287.601371958857;13427.731445371039;13430.328483575782;13473.326333683277;13479.05646604748;8654.394192406471;8674.306055515544;8678.218960293478;8727.734478500583;8739;3342.5153352763714;3355.647656996029;3409.488576713513;3420.2304481491465;3441.483777433405;996.0437979539578;1035.3684252605904;1044.472541366605;1114.2367478277406;1214.3867346989891;32944.505832412535;33084.503732444035;33358;33454;34491.31017379638;1101.5758932810925;1155.566662501562;1169.1698893785338;1170.6488053583892;1223.473906220316;16814.411495597597;17732.20205090774;17843.73234401485;17928.103594820208;17961.461156165336;566459;568938;570244;571247;575886;61026;61235.38764612297;61354.38645613576;61359.38640613537;61519.6924015386;1332.9800052999212;1348.0496250143626;1357.803118547805;1365.092213677913;1393.6933874547583;31223.687763122987;31853.840730796197;32604.347913041132;33846.66153338435;34327.31345373129;53013.33706584545;53602.46397536131;53811;53979.73010134924;54276;443051;444774;445674;447619;449550;29230.56154157647;29467;29613.407731845673;29616.851915740284;29627.963021294152;49500;49587;49994.75002625109;50362.49637503725;50953.23570146377;40799.55202687848;42897;43050;43293.567064328956;44038.77980610076;42556.36165457583;42869;43918.34122488229;44455;44562.55437445584;41814.37278440765;43002.78498607612;43441.34837977496;44239;44283.77858110818;36919.26161476702;38638.420423693104;38798.80600596979;38931.610683892795;39463;29200.707992919797;29376.7062329374;29555.26111847135;29681.554776677935;29830.70169298366 23:35:53 INFO - PROCESS | 7088 | |2;jquery.html;388.1770646229993;389.41393203229154;406.0842799487156;406.8169323804288;411.68466748737774;18436.723449148256;19756.604867902668;20347.898260508697;20401.979901004946;20980.37058888232;17635.382761603345;17872.463826085204;18708.719369209437;19098.427047188605;19118.13968371423;5366.436524164965;5371.57027437805;5402.702851343174;5409.6213265071465;5441.455854414547;5398.16328469086;5404.91892621611;5430.864228394302;5440.183972404151;5445.319335083114;4959.578435832958;4995.425526064513;5019.322391477159;5059.16523773577;5359.866003349908;5302.416734159239;5351.117065684158;5357.624966252364;5385.21914322423;5415.079436495806;5141.10030744622;5220.530152286313;5260.132078207092;5304.575633949275;5313.521783039507;14420.567382978528;14518.564443066725;14632.341544630517;14798;14798.334074966653;2270.2962081754545;2350.9882450587806;2357.823163262745;2403.194929698553;2747.738964798341;10613.257072004963;11083.224174307801;11270.211085224038;12501.687457813627;12623.810642840364;1895.2134864031411;1908.3988543608718;1997.6703843865744;2032.9695054574192;2070.968935465969;85605;85625.4405655241;86552.56723716404;87432;88390.11609883947;11262.774744505065;11555.88444115565;11661.708457288636;11671.88328116725;11722.413879306001;15884.44404445862;15896.12571308566;15924.92037539805;16000;16020;7980.960095199487;8216.712415065444;8409.873851892227;8470.788230294293;8492.915070849336;7506.62466876654;7508.924910750932;7935.444518883738;7998.240167184108;8184.54984975832;4785.3300537924715;4821.349117869113;4830.6135509159185;4859.635527335393;4996.275540046673;1934.3423236099793;1995.4911497568028;2033.1054336092072;2072.782357852434;2085.624587574251;878.1350369885657;904.6607522179182;1003.668789299544;1014.4369874719602;1035.8342665173686;19805.60388792245;20264.29074982398;20453.897730511253;20487;20571.38285851427;997.9101880830615;1033.302520798458;1047.512906498482;1050.968470945873;1051.321897376188;11095.83356249657;11304.378259195659;11422.371769552588;11491.885081149081;11631.185816992898;493264;504206;528481;528954;531847;93443.53278233702;95342.52328738311;95775;96681.51659241659;96719.51640241894;986.6793292180071;1006.0945149365483;1024.2113572549245;1027.5684212630713;1028.783955369366;17518.73721894147;17829.197686103897;18165;18208.45374638763;18277.54306142357;42854;43811;43985.560144399424;44317;44822.551774481835;60061.39938600733;60660.393396065476;61054;62092;62342.34954785713;8611.13888611159;8646.221840034426;8727;8832.91167088321;9352.392094513834;11909.583164589545;13003.154794938298;13426.664333391744;13467.259300738553;13745.656358591115;11625;11861.406929653655;11864.703382415508;11864.822027669765;12098.395080246128;11443.713907152387;11616.593419230287;11670.70823229426;11808.822867657163;12058.095642826647;11776.941115294712;11872.789401115208;12093.213941093802;12467.376631168587;12884.420201090787;8557.914420855712;8630.136986301319;8803.911960880308;8842.159994800484;9118.270538357048;11172.435858979912;11867.940660296643;12135.817962730744;12173.878261217274;12258.816117758419 23:35:53 INFO - PROCESS | 7088 | |3;mootools.html;1353.560092969785;1422.75813111771;1499.512658386025;1669.382328538441;1700.1924086059116;7338.412926965843;7819.218078192178;7956.363490920727;8436.704715334965;8483.024452187992;7992.840143197132;8310.626021829017;8319.168083191678;8343.707970221043;8349.749507514769;2327.441414060626;2345.659879317498;2347.929562113139;2353.7410884802657;2357.2928121563464;2270.648049552322;2318.211807985285;2341.496578235679;2347.119830063726;2347.753485883983;2328.883555822202;2330.627099664054;2356.446235134742;2358.363241924688;2359.1271229645054;2256.537409830981;2273.3407311879537;2290.393045842853;2291.4958709083976;2324.3491822289616;2312.2947501012186;2312.3294244669028;2317.5596636638984;2318.8376813623054;2319.744828068911;8304.916950830475;8428.789280268042;8488.702895398632;8489.320854331638;8506.702265420743;4904.509549045102;4954.355933728628;4972.303877457159;4972.7513624318635;5042.747862606855;3332.1169889979174;3391.220019395528;3457.8789742358895;3519.1554027033585;3530.276293359855;1164.4992653159138;1207.8912897839148;1214.1440284599337;1239.5103933946132;1239.7582471418077;11329.773404531945;11355.943220283929;11462.312261264267;11484.966353028267;11487.597934072352;4335.458067741532;4448.421705178306;4574.6340292776495;4630.791614377361;4669.4630117536235;9608.231341492663;9652.469114198786;9685.903140968641;9740.561674724655;9762.95118524417;5015.3730783652045;5032.79868805251;5035.949640503622;5042.369703787027;5045.672031317952;4099.733517321364;4543.273076307841;4621.468531118897;4631.884202894955;4662.696924699883;3861.7876016819346;3876.3604005339366;3918.5101862267215;3987.342088555356;4028.254772867029;1280.8975281977418;1297.772889744291;1308.718625495523;1318.4726109556254;1325.0790700463085;991.9801603968025;1005.5826831864695;1015.9034891685278;1027.9743006424899;1028.7633844215723;5883.970580147072;5885.234919460443;5901.58688891782;6009.969950150221;6186.257649082049;471.09314569454347;477.7205334879135;477.93308936748883;484.6704241116004;491.268010664115;4114.835406583703;4132.586741325843;4182.351735481006;4199.811008504625;4260.190563792869;9403.717888463358;9654.75863103414;9748.658796942214;9785.657501987538;9846.606135754633;9686.128248457673;9691.12779849817;9738.269629777653;9752.804943901083;9786.804263914682;7395.482316237812;7513.586752728653;7522.3605993491165;7528.360089392353;7581.3934885209055;5663.858403539944;5668.178114173339;5670.858228544154;5776.249087618751;5836.358000619844;8949.194572488508;9102.954485227532;9130.04134565861;9180.44917304964;9223.44659320443;9081.591328390106;9085.273178145864;9137.543122843965;9398.133569261441;9562.426254424758;6408.61548307103;7244.529105608119;7253.238409966877;7259.274072592699;7311.634418279171;8074.192580741878;8108.83782324362;8154.510729356258;8159.224873636995;8191.05802832658;7204.639768011473;7463.141738700119;7484.513506622052;7550.546967181767;7568.243175682388;7113.82215444618;7166.605836679033;7228.168760592389;7277.417806575567;7328.890066648898;6802.8639427212165;6829.726810927706;6914.723411063501;6915.792526224222;6917.896231556631;5097.872553186052;5178.32681751385;5215.087359711959;5279.920801188062;5310.734463276898;5157.432682404858;5217.2434996925995;5279.07011608561;5281.419043905091;5412.458754124556 23:35:53 INFO - PROCESS | 7088 | |4;prototype.html;332.15976690542675;334.75562839127434;342.6025810060329;344.77934122161804;346.06734849580374;5414.7834086636585;5415.64798288111;5528.253685752422;5581.748821303041;5591.384947655754;5447.591430642708;5466;5470.972645136779;5479.698616576096;5484.2176292704935;4350.477942646887;4362.585554372329;4365.36702178184;4366.257736184856;4395.9560404396025;4079.2453396121664;4289.721168124078;4297.677674174433;4395.604395604395;4411.470623525165;4237.555056719047;4253.234417804794;4258;4263.275243208662;4263.701540892139;4263.2965560682605;4278.379634952946;4281.657467402601;4288.785560721952;4308.547602501723;3659.048647351681;3785.0915780212827;3791.8293676784333;3798.3542797724176;3799.8410484802125;5271.973640131775;5301.7084060376665;5344.492273234076;5363.892722145574;5368.141097424433;4954;5024.522670346311;5024.874378140576;5027.824026159104;5028.245763135523;5545.833624991256;5739.426057394269;5746.678263999303;5799.217105690762;5809.477147056785;4219.746815191068;4226.3026600610865;4230.788460576959;4246.851360202409;4254.276772948575;5959.821205363846;5979.760809567656;5982.551308651869;5989.490893274077;6030.698465076773;4115.42384066231;4186.225548273579;4196.517400498981;4198.3702444633545;4204.642605378577;4284;4285.61429471349;4286.314189729691;4292.5063617683745;4298.161858437637;4862.41651001882;4899.657024008286;4914.877128071756;4916.188828843201;4927.187014142698;5702.51528620072;5736.848102331898;5808.157817116495;5822.912656310159;5825.79609713658;1510.9017913835567;1525.9694806104037;1535.4549135057118;1541.306412114553;1541.745611974034;939.4081728510994;972.3130368810109;982.6266018912768;984.2913102566141;994.125169850527;4918.680285781413;4932.506749325111;4952.702837829742;4980.477049909708;5002.324686167393;5218.478152184751;5230.189320655304;5237.240600112962;5238.554722848525;5241.31862857826;5033.496650334937;5038.9592215152925;5039.294498770175;5216.191490319006;5670.8015219467125;3138.1997590614246;3178.6344570374704;3181.316017056344;3181.5068664357063;3181.7136457718916;5967.433093856077;6173.290071641729;6230.6884655767935;6248.4064013918605;6257.56197066201;6036.305824830113;6064.757409703562;6090.6041107328765;6098.26820781509;6108.914997926019;6105.412592725835;6119.724612392364;6149.96925015381;6180.351063138306;6184.196054512884;5821.126830975388;5854.536365908523;5905.320888097924;5954.732037058429;5997.220361352996;5885.61743486672;5914.645121292736;5919.763209471573;5941.554383421347;5957.76168953237;6089.50807052275;6108;6186.133941248138;6218.626882387071;6223.3465486125115;4125.50493940729;4168.478940132483;4184.075325350373;4199.937000944928;4223.32426811721;5941.1385349125;5952.8809423812145;5981.431763982415;6061.181740464981;6091.8781624366375;5611.943880561143;5778.479936805707;5819.82540523785;5908.911366329595;5919.53707081345;5808.448197421239;5820.359760426434;5825.077724351038;5845.532357411312;5859.853503662443;5786;5787.594868359343;5858.414158584107;5865.354810970875;5885.205012471066;5560.360558535658;5848.403232012197;5882.558808089325;5889.646621202742;5900.970495147497;5778.595498315078;5785.566082543742;5792.175464728597;5793.784449630495;5811.418858114154 23:35:53 INFO - PROCESS | 7088 | |5;yui.html;705.3651713457889;792.437369467678;818.6602559937626;842.7092653034705;856.5631527920758;15836.129012904286;16374.508764737047;16546.255418506167;16600.086995215275;16650;15485.535433937;16058.116803575798;16250.349986000545;16858.409955651554;16878;803.2289002557552;837.3552364679193;840.5503055865113;840.6469282901196;841.1042240014365;813.6785969542057;828.45736042892;829.3738227638124;840.1514470384925;849.1084361420515;893.5130353957109;896.256107430834;896.3770179725094;896.5696465696469;896.6547879066574;881.0792721605937;881.2289246908955;885.8051228729669;886.3883920095113;886.9113088691144;642.7686033028153;643.2024289880561;643.4562794438692;644.1593720195143;645.4320198225531;15042.924785376003;15053.247337633074;15056.397744090224;15063.246837658073;15101.47144849936;15486.61283467911;15630.45293414725;15701.607459813597;15813.92093039539;15972.680546389007;12169;12195.630378892452;12203.521607599498;12240.387980600934;12272.44773985164;3897.1815918657117;3907.2185562887253;3930.567637559866;3988.3818008208773;4015.738976966488;80744;81373.59313203456;81703.18296817015;81971;82543;11709.355985420883;11751.353675547927;11797.823032654516;11945.522179112739;12081.637550873487;22518.211862584732;22529;22766.31701048971;22860;22861.885690571442;8695.391322607484;8813.559322033872;8873.423227490193;8880.333974951904;9176.17414432691;4989.101961646938;5002.174641184237;5024.924626130611;5031.52200540948;5232.92150617741;3647.507586475845;3734.738568300193;3771.340015497277;3772.302124107049;3781.4327850822046;606.9514438844882;622.8847663182326;640.759715106835;653.0595941843729;654.4273760459598;755.267390631087;766.1878408886487;768.5772824946368;796.2793671727096;800.507687772016;10226.23303252259;10285.537150828231;10431.634892778717;10717.303375280582;10787.676369708764;691.7302252121676;766.2490759056045;778.0935210479728;778.5250996891891;778.657390748069;5074.847754567369;5186.481351864859;5215.504527069922;5247.842564723064;5266.710330931759;71984;93366.53316733374;127669;128363.35818321035;131965.34017330044;65430;70623;107846;108558;113425;95005.5249723747;95887.52056239813;96223;98130;98788;9891.505424728879;10062.446565438971;10203.13273371742;10346.534405951901;10375.27373083877;53322;53690.73154634202;54314;55587;56947.43052569587;70796.93804592833;84685.15314846773;85414.57292713497;85727.57136214279;96997.51501242448;14698.779518307449;14912.7763083556;14972.925135374253;15227.619309517351;15409.075455472708;15610.891366015368;15888.443904463289;16089.356425743308;16874.578135546708;16960.491185264462;12847.807282890577;13104.903215485858;13943.930280348533;14175.43298268099;14186;14541.418343266574;14815.25923703789;15103.697926041197;15708.13605251722;15901.125438101015;13857.376418061413;13870.72258554803;14215.715685686022;14734.77897831512;14939.551813445614;11143.944280278547;11329.490172942402;11453;11775.342520193431;12506.249625022529;11437.485313160762;11705.180637355303;12707.916833266767;12739.61781146567;12926.547570834975 23:35:53 INFO - PROCESS | 7088 | __end_tp_report 23:35:53 INFO - PROCESS | 7088 | __start_cc_report 23:35:53 INFO - PROCESS | 7088 | _x_x_mozilla_cycle_collect,327 23:35:53 INFO - PROCESS | 7088 | __end_cc_report 23:35:53 INFO - PROCESS | 7088 | __startTimestamp1471847753279__endTimestamp 23:35:53 INFO - PROCESS | 7088 | 23:35:53 INFO - PROCESS | 7088 | ------- Summary: start ------- 23:35:53 INFO - PROCESS | 7088 | Number of tests: 6 23:35:53 INFO - PROCESS | 7088 | 23:35:53 INFO - PROCESS | 7088 | [#0] dojo.html Cycles:165 Average:5418.77 Median:5643.27 stddev:613.69 (10.9%) stddev-sans-first:588.21 23:35:53 INFO - PROCESS | 7088 | Values: 3108.8 3143.7 3151.0 3152.8 3162.3 5292.5 5448.3 5481.6 5526.1 5541.0 5357.5 5360.8 5410.8 5440.6 5450.4 4732.3 4917.7 4998.9 5061.4 5068.3 5000.2 5010.8 5056.2 5056.9 5061.5 4809.0 4867.9 4905.7 4932.2 4934.2 4926.9 4945.9 4980.6 4995.8 5003.2 4920.1 4959.0 4963.2 4986.5 4993.4 5311.9 5401.2 5405.1 5429.1 5463.3 5903.5 5936.4 5944.7 5948.5 5950.1 5934.2 5938.3 5941.8 5945.7 5972.6 5234.6 5332.1 5345.3 5369.2 5452.8 5927.1 5930.8 5938.3 5950.7 5956.0 5650.2 5675.4 5717.1 5725.3 5726.6 5602.5 5693.5 5724.0 5749.9 5796.5 5770.4 5785.1 5788.3 5808.6 5809.4 5767.1 5806.9 5825.8 5830.1 5832.9 4379.5 4431.8 4456.1 4458.7 4556.2 4020.3 4024.7 4025.0 4028.3 4033.1 5618.9 5624.7 5627.9 5632.0 5643.3 5756.5 5761.2 5766.2 5837.6 5862.8 5555.3 5559.7 5559.8 5567.2 5575.2 4955.0 5036.9 5041.0 5046.6 5051.8 5931.7 5993.3 6018.4 6049.3 6052.5 5832.0 5839.9 5840.4 5856.6 5860.8 5826.6 5904.8 6018.9 6049.2 6054.2 5673.1 5793.8 5797.2 5800.6 5801.4 5822.6 5833.5 5863.7 5880.2 5886.8 5576.7 5656.5 5736.3 5752.5 5755.9 5677.1 5765.5 5768.3 5773.5 5778.6 5650.5 5669.1 5712.9 5714.7 5744.7 5563.7 5616.1 5763.3 5772.8 5784.5 5487.6 5613.0 5631.7 5636.7 5654.6 23:35:53 INFO - PROCESS | 7088 | 23:35:53 INFO - PROCESS | 7088 | [#1] ext.html Cycles:180 Average:61062.13 Median:42883.00 stddev:124041.69 (289.3%) stddev-sans-first:124306.52 23:35:53 INFO - PROCESS | 7088 | Values: 575.9 586.5 589.3 593.9 618.7 39764.8 43611.8 43684.8 43771.0 43798.1 43825.0 44163.3 44433.1 44555.8 44594.6 8838.9 8971.4 8999.5 9000.8 9021.9 8848.9 8883.2 8927.7 8929.6 9010.5 9055.4 9056.0 9099.9 9113.9 9116.7 8909.3 8947.6 8962.3 9015.7 9044.5 8827.1 8884.6 8905.7 8945.6 8949.9 41530.0 41803.8 41995.4 41997.0 42053.8 3538.3 3622.5 3633.8 3681.4 3729.9 31475.8 32286.4 32429.8 32494.0 32799.8 4409.0 4566.9 4678.2 4749.6 4762.7 356179.0 358592.3 358751.0 358817.2 359688.0 34414.3 35443.3 57939.0 58191.1 58614.7 37446.4 37566.8 37604.2 37656.6 37841.6 15735.5 15837.7 15882.3 16035.0 16054.6 13287.6 13427.7 13430.3 13473.3 13479.1 8654.4 8674.3 8678.2 8727.7 8739.0 3342.5 3355.6 3409.5 3420.2 3441.5 996.0 1035.4 1044.5 1114.2 1214.4 32944.5 33084.5 33358.0 33454.0 34491.3 1101.6 1155.6 1169.2 1170.6 1223.5 16814.4 17732.2 17843.7 17928.1 17961.5 566459.0 568938.0 570244.0 571247.0 575886.0 61026.0 61235.4 61354.4 61359.4 61519.7 1333.0 1348.0 1357.8 1365.1 1393.7 31223.7 31853.8 32604.3 33846.7 34327.3 53013.3 53602.5 53811.0 53979.7 54276.0 443051.0 444774.0 445674.0 447619.0 449550.0 29230.6 29467.0 29613.4 29616.9 29628.0 49500.0 49587.0 49994.8 50362.5 50953.2 40799.6 42897.0 43050.0 43293.6 44038.8 42556.4 42869.0 43918.3 44455.0 44562.6 41814.4 43002.8 43441.3 44239.0 44283.8 36919.3 38638.4 38798.8 38931.6 39463.0 29200.7 29376.7 29555.3 29681.6 29830.7 23:35:53 INFO - PROCESS | 7088 | 23:35:53 INFO - PROCESS | 7088 | [#2] jquery.html Cycles:180 Average:30073.10 Median:11625.33 stddev:85423.58 (734.8%) stddev-sans-first:85634.13 23:35:53 INFO - PROCESS | 7088 | Values: 388.2 389.4 406.1 406.8 411.7 18436.7 19756.6 20347.9 20402.0 20980.4 17635.4 17872.5 18708.7 19098.4 19118.1 5366.4 5371.6 5402.7 5409.6 5441.5 5398.2 5404.9 5430.9 5440.2 5445.3 4959.6 4995.4 5019.3 5059.2 5359.9 5302.4 5351.1 5357.6 5385.2 5415.1 5141.1 5220.5 5260.1 5304.6 5313.5 14420.6 14518.6 14632.3 14798.0 14798.3 2270.3 2351.0 2357.8 2403.2 2747.7 10613.3 11083.2 11270.2 12501.7 12623.8 1895.2 1908.4 1997.7 2033.0 2071.0 85605.0 85625.4 86552.6 87432.0 88390.1 11262.8 11555.9 11661.7 11671.9 11722.4 15884.4 15896.1 15924.9 16000.0 16020.0 7981.0 8216.7 8409.9 8470.8 8492.9 7506.6 7508.9 7935.4 7998.2 8184.5 4785.3 4821.3 4830.6 4859.6 4996.3 1934.3 1995.5 2033.1 2072.8 2085.6 878.1 904.7 1003.7 1014.4 1035.8 19805.6 20264.3 20453.9 20487.0 20571.4 997.9 1033.3 1047.5 1051.0 1051.3 11095.8 11304.4 11422.4 11491.9 11631.2 493264.0 504206.0 528481.0 528954.0 531847.0 93443.5 95342.5 95775.0 96681.5 96719.5 986.7 1006.1 1024.2 1027.6 1028.8 17518.7 17829.2 18165.0 18208.5 18277.5 42854.0 43811.0 43985.6 44317.0 44822.6 60061.4 60660.4 61054.0 62092.0 62342.3 8611.1 8646.2 8727.0 8832.9 9352.4 11909.6 13003.2 13426.7 13467.3 13745.7 11625.0 11861.4 11864.7 11864.8 12098.4 11443.7 11616.6 11670.7 11808.8 12058.1 11776.9 11872.8 12093.2 12467.4 12884.4 8557.9 8630.1 8803.9 8842.2 9118.3 11172.4 11867.9 12135.8 12173.9 12258.8 23:35:53 INFO - PROCESS | 7088 | 23:35:53 INFO - PROCESS | 7088 | [#3] mootools.html Cycles:180 Average:5496.23 Median:5167.88 stddev:2986.64 (57.8%) stddev-sans-first:2978.79 23:35:53 INFO - PROCESS | 7088 | Values: 1353.6 1422.8 1499.5 1669.4 1700.2 7338.4 7819.2 7956.4 8436.7 8483.0 7992.8 8310.6 8319.2 8343.7 8349.7 2327.4 2345.7 2347.9 2353.7 2357.3 2270.6 2318.2 2341.5 2347.1 2347.8 2328.9 2330.6 2356.4 2358.4 2359.1 2256.5 2273.3 2290.4 2291.5 2324.3 2312.3 2312.3 2317.6 2318.8 2319.7 8304.9 8428.8 8488.7 8489.3 8506.7 4904.5 4954.4 4972.3 4972.8 5042.7 3332.1 3391.2 3457.9 3519.2 3530.3 1164.5 1207.9 1214.1 1239.5 1239.8 11329.8 11355.9 11462.3 11485.0 11487.6 4335.5 4448.4 4574.6 4630.8 4669.5 9608.2 9652.5 9685.9 9740.6 9763.0 5015.4 5032.8 5035.9 5042.4 5045.7 4099.7 4543.3 4621.5 4631.9 4662.7 3861.8 3876.4 3918.5 3987.3 4028.3 1280.9 1297.8 1308.7 1318.5 1325.1 992.0 1005.6 1015.9 1028.0 1028.8 5884.0 5885.2 5901.6 6010.0 6186.3 471.1 477.7 477.9 484.7 491.3 4114.8 4132.6 4182.4 4199.8 4260.2 9403.7 9654.8 9748.7 9785.7 9846.6 9686.1 9691.1 9738.3 9752.8 9786.8 7395.5 7513.6 7522.4 7528.4 7581.4 5663.9 5668.2 5670.9 5776.2 5836.4 8949.2 9103.0 9130.0 9180.4 9223.4 9081.6 9085.3 9137.5 9398.1 9562.4 6408.6 7244.5 7253.2 7259.3 7311.6 8074.2 8108.8 8154.5 8159.2 8191.1 7204.6 7463.1 7484.5 7550.5 7568.2 7113.8 7166.6 7228.2 7277.4 7328.9 6802.9 6829.7 6914.7 6915.8 6917.9 5097.9 5178.3 5215.1 5279.9 5310.7 5157.4 5217.2 5279.1 5281.4 5412.5 23:35:53 INFO - PROCESS | 7088 | 23:35:53 INFO - PROCESS | 7088 | [#4] prototype.html Cycles:180 Average:4846.38 Median:5431.62 stddev:1423.81 (26.2%) stddev-sans-first:1386.90 23:35:53 INFO - PROCESS | 7088 | Values: 332.2 334.8 342.6 344.8 346.1 5414.8 5415.6 5528.3 5581.7 5591.4 5447.6 5466.0 5471.0 5479.7 5484.2 4350.5 4362.6 4365.4 4366.3 4396.0 4079.2 4289.7 4297.7 4395.6 4411.5 4237.6 4253.2 4258.0 4263.3 4263.7 4263.3 4278.4 4281.7 4288.8 4308.5 3659.0 3785.1 3791.8 3798.4 3799.8 5272.0 5301.7 5344.5 5363.9 5368.1 4954.0 5024.5 5024.9 5027.8 5028.2 5545.8 5739.4 5746.7 5799.2 5809.5 4219.7 4226.3 4230.8 4246.9 4254.3 5959.8 5979.8 5982.6 5989.5 6030.7 4115.4 4186.2 4196.5 4198.4 4204.6 4284.0 4285.6 4286.3 4292.5 4298.2 4862.4 4899.7 4914.9 4916.2 4927.2 5702.5 5736.8 5808.2 5822.9 5825.8 1510.9 1526.0 1535.5 1541.3 1541.7 939.4 972.3 982.6 984.3 994.1 4918.7 4932.5 4952.7 4980.5 5002.3 5218.5 5230.2 5237.2 5238.6 5241.3 5033.5 5039.0 5039.3 5216.2 5670.8 3138.2 3178.6 3181.3 3181.5 3181.7 5967.4 6173.3 6230.7 6248.4 6257.6 6036.3 6064.8 6090.6 6098.3 6108.9 6105.4 6119.7 6150.0 6180.4 6184.2 5821.1 5854.5 5905.3 5954.7 5997.2 5885.6 5914.6 5919.8 5941.6 5957.8 6089.5 6108.0 6186.1 6218.6 6223.3 4125.5 4168.5 4184.1 4199.9 4223.3 5941.1 5952.9 5981.4 6061.2 6091.9 5611.9 5778.5 5819.8 5908.9 5919.5 5808.4 5820.4 5825.1 5845.5 5859.9 5786.0 5787.6 5858.4 5865.4 5885.2 5560.4 5848.4 5882.6 5889.6 5901.0 5778.6 5785.6 5792.2 5793.8 5811.4 23:35:53 INFO - PROCESS | 7088 | 23:35:53 INFO - PROCESS | 7088 | [#5] yui.html Cycles:180 Average:21808.68 Median:3902.20 stddev:31131.74 (797.8%) stddev-sans-first:31178.74 23:35:53 INFO - PROCESS | 7088 | Values: 705.4 792.4 818.7 842.7 856.6 15836.1 16374.5 16546.3 16600.1 16650.0 15485.5 16058.1 16250.3 16858.4 16878.0 803.2 837.4 840.6 840.6 841.1 813.7 828.5 829.4 840.2 849.1 893.5 896.3 896.4 896.6 896.7 881.1 881.2 885.8 886.4 886.9 642.8 643.2 643.5 644.2 645.4 15042.9 15053.2 15056.4 15063.2 15101.5 15486.6 15630.5 15701.6 15813.9 15972.7 12169.0 12195.6 12203.5 12240.4 12272.4 3897.2 3907.2 3930.6 3988.4 4015.7 80744.0 81373.6 81703.2 81971.0 82543.0 11709.4 11751.4 11797.8 11945.5 12081.6 22518.2 22529.0 22766.3 22860.0 22861.9 8695.4 8813.6 8873.4 8880.3 9176.2 4989.1 5002.2 5024.9 5031.5 5232.9 3647.5 3734.7 3771.3 3772.3 3781.4 607.0 622.9 640.8 653.1 654.4 755.3 766.2 768.6 796.3 800.5 10226.2 10285.5 10431.6 10717.3 10787.7 691.7 766.2 778.1 778.5 778.7 5074.8 5186.5 5215.5 5247.8 5266.7 71984.0 93366.5 127669.0 128363.4 131965.3 65430.0 70623.0 107846.0 108558.0 113425.0 95005.5 95887.5 96223.0 98130.0 98788.0 9891.5 10062.4 10203.1 10346.5 10375.3 53322.0 53690.7 54314.0 55587.0 56947.4 70796.9 84685.2 85414.6 85727.6 96997.5 14698.8 14912.8 14972.9 15227.6 15409.1 15610.9 15888.4 16089.4 16874.6 16960.5 12847.8 13104.9 13943.9 14175.4 14186.0 14541.4 14815.3 15103.7 15708.1 15901.1 13857.4 13870.7 14215.7 14734.8 14939.6 11143.9 11329.5 11453.0 11775.3 12506.2 11437.5 11705.2 12707.9 12739.6 12926.5 23:35:53 INFO - PROCESS | 7088 | -------- Summary: end -------- 23:35:53 INFO - PROCESS | 7088 | 23:35:54 INFO - TEST-INFO | 7088: exit 0 23:35:54 INFO - TEST-OK | dromaeo_css | took 1113544ms 23:35:54 INFO - TEST-START | kraken 23:35:54 INFO - operating with platform_type : linux_ 23:35:54 INFO - Initialising browser for kraken test... 23:35:54 INFO - TEST-INFO | started process 7449 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN1BvcX/profile http://localhost:37630/getInfo.html) 23:35:59 INFO - PROCESS | 7449 | __metrics Screen width/height:1600/1200 23:35:59 INFO - PROCESS | 7449 | colorDepth:24 23:35:59 INFO - PROCESS | 7449 | Browser inner width/height: 1024/697 23:35:59 INFO - PROCESS | 7449 | __metrics 23:35:59 ERROR - PROCESS | 7449 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3061: TypeError: this.tabs is undefined 23:36:00 INFO - TEST-INFO | 7449: exit 0 23:36:00 INFO - Browser initialized. 23:36:00 INFO - Running cycle 1/1 for kraken test... 23:36:00 INFO - TEST-INFO | started process 7568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpN1BvcX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:36:12 INFO - PROCESS | 7568 | RSS: Main: 187150336 23:36:12 INFO - PROCESS | 7568 | 23:36:15 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37630/tests/kraken/driver.html?testName=audio-beat-detection) 23:36:16 INFO - PROCESS | 7568 | RSS: Main: 200126464 23:36:16 INFO - PROCESS | 7568 | 23:36:19 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37630/tests/kraken/driver.html?testName=audio-dft) 23:36:19 INFO - PROCESS | 7568 | RSS: Main: 199036928 23:36:19 INFO - PROCESS | 7568 | 23:36:22 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37630/tests/kraken/driver.html?testName=audio-fft) 23:36:23 INFO - PROCESS | 7568 | RSS: Main: 195317760 23:36:23 INFO - PROCESS | 7568 | 23:36:25 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37630/tests/kraken/driver.html?testName=audio-oscillator) 23:36:26 INFO - PROCESS | 7568 | RSS: Main: 196272128 23:36:26 INFO - PROCESS | 7568 | 23:36:28 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37630/tests/kraken/driver.html?testName=imaging-gaussian-blur) 23:36:28 INFO - PROCESS | 7568 | RSS: Main: 196292608 23:36:28 INFO - PROCESS | 7568 | 23:36:32 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37630/tests/kraken/driver.html?testName=imaging-darkroom) 23:36:32 INFO - PROCESS | 7568 | RSS: Main: 196657152 23:36:32 INFO - PROCESS | 7568 | 23:36:36 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37630/tests/kraken/driver.html?testName=imaging-desaturate) 23:36:36 INFO - PROCESS | 7568 | RSS: Main: 194039808 23:36:36 INFO - PROCESS | 7568 | 23:36:39 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37630/tests/kraken/driver.html?testName=json-parse-financial) 23:36:40 INFO - PROCESS | 7568 | RSS: Main: 195719168 23:36:40 INFO - PROCESS | 7568 | 23:36:41 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37630/tests/kraken/driver.html?testName=json-stringify-tinderbox) 23:36:42 INFO - PROCESS | 7568 | RSS: Main: 195973120 23:36:42 INFO - PROCESS | 7568 | 23:36:44 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-aes) 23:36:45 INFO - PROCESS | 7568 | RSS: Main: 195821568 23:36:45 INFO - PROCESS | 7568 | 23:36:47 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-ccm) 23:36:47 INFO - PROCESS | 7568 | RSS: Main: 195887104 23:36:47 INFO - PROCESS | 7568 | 23:36:50 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 23:36:51 INFO - PROCESS | 7568 | RSS: Main: 196333568 23:36:51 INFO - PROCESS | 7568 | 23:36:54 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 23:36:54 INFO - PROCESS | 7568 | RSS: Main: 196337664 23:36:54 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | Cycle 1(1): loaded http://localhost:37630/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37630/tests/kraken/driver.html?testName=ai-astar) 23:36:56 INFO - PROCESS | 7568 | RSS: Main: 198062080 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | __start_tp_report 23:36:56 INFO - PROCESS | 7568 | _x_x_mozilla_page_load 23:36:56 INFO - PROCESS | 7568 | _x_x_mozilla_page_load_details 23:36:56 INFO - PROCESS | 7568 | |i|pagename|runs| 23:36:56 INFO - PROCESS | 7568 | |0;ai-astar;103;113;111;114;112;112;118;116;112;126 23:36:56 INFO - PROCESS | 7568 | |1;audio-beat-detection;146;121;146;186;129;154;154;122;184;121 23:36:56 INFO - PROCESS | 7568 | |2;audio-dft;165;166;168;178;179;167;166;165;164;166 23:36:56 INFO - PROCESS | 7568 | |3;audio-fft;79;79;77;191;77;78;79;76;183;77 23:36:56 INFO - PROCESS | 7568 | |4;audio-oscillator;86;87;163;87;87;87;159;88;87;140 23:36:56 INFO - PROCESS | 7568 | |5;imaging-gaussian-blur;118;119;119;119;119;120;120;117;118;117 23:36:56 INFO - PROCESS | 7568 | |6;imaging-darkroom;147;147;147;147;147;147;147;150;149;147 23:36:56 INFO - PROCESS | 7568 | |7;imaging-desaturate;96;97;97;96;97;96;96;97;96;118 23:36:56 INFO - PROCESS | 7568 | |8;json-parse-financial;54;56;53;54;53;69;56;53;54;53 23:36:56 INFO - PROCESS | 7568 | |9;json-stringify-tinderbox;63;66;63;63;64;64;62;65;62;63 23:36:56 INFO - PROCESS | 7568 | |10;stanford-crypto-aes;82;80;90;83;82;80;80;81;98;84 23:36:56 INFO - PROCESS | 7568 | |11;stanford-crypto-ccm;136;126;127;133;141;127;134;125;196;128 23:36:56 INFO - PROCESS | 7568 | |12;stanford-crypto-pbkdf2;167;179;188;169;168;172;173;166;164;164 23:36:56 INFO - PROCESS | 7568 | |13;stanford-crypto-sha256-iterative;65;72;70;67;72;66;66;68;67;73 23:36:56 INFO - PROCESS | 7568 | __end_tp_report 23:36:56 INFO - PROCESS | 7568 | __start_cc_report 23:36:56 INFO - PROCESS | 7568 | _x_x_mozilla_cycle_collect,868 23:36:56 INFO - PROCESS | 7568 | __end_cc_report 23:36:56 INFO - PROCESS | 7568 | __startTimestamp1471847816644__endTimestamp 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | ------- Summary: start ------- 23:36:56 INFO - PROCESS | 7568 | Number of tests: 14 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#0] ai-astar Cycles:10 Average:113.70 Median:113.50 stddev:5.83 (5.1%) stddev-sans-first:4.73 23:36:56 INFO - PROCESS | 7568 | Values: 103.0 113.0 111.0 114.0 112.0 112.0 118.0 116.0 112.0 126.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#1] audio-beat-detection Cycles:10 Average:146.30 Median:150.00 stddev:24.24 (16.2%) stddev-sans-first:25.71 23:36:56 INFO - PROCESS | 7568 | Values: 146.0 121.0 146.0 186.0 129.0 154.0 154.0 122.0 184.0 121.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#2] audio-dft Cycles:10 Average:168.40 Median:166.50 stddev:5.44 (3.3%) stddev-sans-first:5.63 23:36:56 INFO - PROCESS | 7568 | Values: 165.0 166.0 168.0 178.0 179.0 167.0 166.0 165.0 164.0 166.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#3] audio-fft Cycles:10 Average:99.60 Median:77.50 stddev:46.11 (59.5%) stddev-sans-first:48.30 23:36:56 INFO - PROCESS | 7568 | Values: 79.0 79.0 77.0 191.0 77.0 78.0 79.0 76.0 183.0 77.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#4] audio-oscillator Cycles:10 Average:107.10 Median:87.00 stddev:32.88 (37.8%) stddev-sans-first:33.98 23:36:56 INFO - PROCESS | 7568 | Values: 86.0 87.0 163.0 87.0 87.0 87.0 159.0 88.0 87.0 140.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:119.00 stddev:1.07 (0.9%) stddev-sans-first:1.12 23:36:56 INFO - PROCESS | 7568 | Values: 118.0 119.0 119.0 119.0 119.0 120.0 120.0 117.0 118.0 117.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#6] imaging-darkroom Cycles:10 Average:147.50 Median:147.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 23:36:56 INFO - PROCESS | 7568 | Values: 147.0 147.0 147.0 147.0 147.0 147.0 147.0 150.0 149.0 147.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#7] imaging-desaturate Cycles:10 Average:98.60 Median:96.50 stddev:6.83 (7.1%) stddev-sans-first:7.18 23:36:56 INFO - PROCESS | 7568 | Values: 96.0 97.0 97.0 96.0 97.0 96.0 96.0 97.0 96.0 118.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.00 stddev:4.88 (9.0%) stddev-sans-first:5.15 23:36:56 INFO - PROCESS | 7568 | Values: 54.0 56.0 53.0 54.0 53.0 69.0 56.0 53.0 54.0 53.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#9] json-stringify-tinderbox Cycles:10 Average:63.50 Median:63.50 stddev:1.27 (2.0%) stddev-sans-first:1.33 23:36:56 INFO - PROCESS | 7568 | Values: 63.0 66.0 63.0 63.0 64.0 64.0 62.0 65.0 62.0 63.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:82.50 stddev:5.75 (7.0%) stddev-sans-first:6.06 23:36:56 INFO - PROCESS | 7568 | Values: 82.0 80.0 90.0 83.0 82.0 80.0 80.0 81.0 98.0 84.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#11] stanford-crypto-ccm Cycles:10 Average:137.30 Median:133.50 stddev:21.26 (15.9%) stddev-sans-first:22.55 23:36:56 INFO - PROCESS | 7568 | Values: 136.0 126.0 127.0 133.0 141.0 127.0 134.0 125.0 196.0 128.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.00 Median:170.50 stddev:7.53 (4.4%) stddev-sans-first:7.84 23:36:56 INFO - PROCESS | 7568 | Values: 167.0 179.0 188.0 169.0 168.0 172.0 173.0 166.0 164.0 164.0 23:36:56 INFO - PROCESS | 7568 | 23:36:56 INFO - PROCESS | 7568 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:2.91 (4.2%) stddev-sans-first:2.78 23:36:56 INFO - PROCESS | 7568 | Values: 65.0 72.0 70.0 67.0 72.0 66.0 66.0 68.0 67.0 73.0 23:36:56 INFO - PROCESS | 7568 | -------- Summary: end -------- 23:36:56 INFO - PROCESS | 7568 | 23:36:57 INFO - TEST-INFO | 7568: exit 0 23:36:57 INFO - TEST-OK | kraken | took 63513ms 23:36:57 INFO - SUITE-END | took 1177s 23:36:58 INFO - Completed test suite (00:19:37) 23:36:58 INFO - javascript benchmark 23:36:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7290.071395393834, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3108.782385233034, 3143.7485001199907, 3150.968490315096, 3152.8423578821066, 3162.335909459012, 5292.470752924715, 5448.346198456185, 5481.643693159952, 5526.143447765603, 5541.002619528484, 5357.464253574641, 5360.839174824761, 5410.810621628244, 5440.591955603326, 5450.373207081187, 4732.337472753818, 4917.655764096515, 4998.925016124743, 5061.417936937244, 5068.315777370045, 5000.224965130411, 5010.774515146809, 5056.19100943849, 5056.924146137811, 5061.54446099851, 4809.038192361524, 4867.853964381075, 4905.681130726492, 4932.2108462646165, 4934.185859333224, 4926.8768280793265, 4945.876353091166, 4980.626453016002, 4995.775190116454, 5003.249512573107, 4920.065187614342, 4959.032988567231, 4963.1810751226, 4986.526280003394, 4993.375828021497, 5311.867203319909, 5401.189821526802, 5405.081136206854, 5429.131338985783, 5463.262459567947, 5903.527717782567, 5936.406359364072, 5944.7027648617395, 5948.464638182541, 5950.077737950624, 5934.228550288478, 5938.257717785277, 5941.821745347646, 5945.702714864239, 5972.552058595579, 5234.607404444644, 5332.066888294533, 5345.331833520771, 5369.24830523727, 5452.809151679751, 5927.110933359944, 5930.822075337746, 5938.257717785277, 5950.672713000827, 5955.970220148958, 5650.180723795109, 5675.432456754292, 5717.113847353667, 5725.255716756795, 5726.599138060295, 5602.523785478198, 5693.4875861172695, 5724.0, 5749.913751293734, 5796.478316951495, 5770.365259821417, 5785.103308987113, 5788.27646544182, 5808.6224395414165, 5809.448102430262, 5767.077267637158, 5806.854828629318, 5825.796097136665, 5830.125481177857, 5832.941670583325, 4379.540148284448, 4431.800568974404, 4456.131054444417, 4458.665600080007, 4556.225441674923, 4020.336644453691, 4024.7182697210915, 4024.9798751006056, 4028.315186418316, 4033.072393349546, 5618.85952851182, 5624.6625202487985, 5627.915581266284, 5631.971840140773, 5643.266375371176, 5756.510696590837, 5761.193432919395, 5766.221560089334, 5837.6497410155525, 5862.824115276549, 5555.3333599967455, 5559.722013899289, 5559.805406810823, 5567.192757050286, 5575.219469274305, 4954.950450495521, 5036.924446133311, 5041.0422019816115, 5046.646734728607, 5051.823186188466, 5931.673757943268, 5993.31076926159, 6018.3680713524445, 6049.334573197033, 6052.54605904559, 5832.037713777179, 5839.912401313899, 5840.445157710011, 5856.59003869725, 5860.824175274749, 5826.592138550261, 5904.793332233351, 6018.879622407615, 6049.243844519435, 6054.212952316171, 5673.092305231144, 5793.768249269982, 5797.188393624811, 5800.564957628279, 5801.419858014165, 5822.592418530662, 5833.533317334688, 5863.706814659165, 5880.206172166702, 5886.764529418947, 5576.721163941867, 5656.547476201977, 5736.254286942671, 5752.482276595127, 5755.8561035974435, 5677.063284558167, 5765.509931655856, 5768.278965129359, 5773.53811695055, 5778.56660750437, 5650.547956163415, 5669.064604340238, 5712.885742285048, 5714.657120572779, 5744.741486633028, 5563.7496312666835, 5616.129499927518, 5763.250777398911, 5772.7690892363835, 5784.479396854304, 5487.560995120461, 5613.0, 5631.746571404215, 5636.661800291996, 5654.6324488908085], "value": 5377.363096147913, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.8819442014386, 586.4692453329739, 589.3340525206513, 593.8871614393266, 618.6597371445704, 39764.801175994115, 43611.78194109029, 43684.78157609215, 43771.0, 43798.12403751923, 43825.0, 44163.337549936776, 44433.111337773225, 44555.77722111393, 44594.55405445945, 8838.91161088389, 8971.416857904247, 8999.5050272235, 9000.819983600324, 9021.909780902206, 8848.867266991001, 8883.200511953923, 8927.732168034969, 8929.642814287454, 9010.54947252638, 9055.366124371296, 9055.954720226422, 9099.863502047474, 9113.863292050624, 9116.726498205064, 8909.331800114953, 8947.597358118835, 8962.327825413087, 9015.729528114167, 9044.502552359618, 8827.117288271185, 8884.600192991331, 8905.73282801517, 8945.552722363856, 8949.910500894974, 41530.0, 41803.790981045204, 41995.37006944898, 41997.0, 42053.78973105115, 3538.327717733648, 3622.4747411625167, 3633.7638053526434, 3681.44778283257, 3729.9067523311865, 31475.842620786978, 32286.35427291441, 32429.837850810833, 32494.0, 32799.83600082008, 4409.0, 4566.931496027562, 4678.204705200124, 4749.596284315838, 4762.714237145748, 356179.0, 358592.31261499017, 358751.0, 358817.20591397135, 359688.0, 34414.31171376609, 35443.29113417717, 57939.0, 58191.12713309304, 58614.70692646595, 37446.43830342547, 37566.81216593954, 37604.247915041546, 37656.623433765315, 37841.62158378436, 15735.527934161993, 15837.68324633501, 15882.285297161425, 16035.0, 16054.598635034217, 13287.601371958857, 13427.731445371039, 13430.328483575782, 13473.326333683277, 13479.05646604748, 8654.394192406471, 8674.306055515544, 8678.218960293478, 8727.734478500583, 8739.0, 3342.5153352763714, 3355.647656996029, 3409.488576713513, 3420.2304481491465, 3441.483777433405, 996.0437979539578, 1035.3684252605904, 1044.472541366605, 1114.2367478277406, 1214.3867346989891, 32944.505832412535, 33084.503732444035, 33358.0, 33454.0, 34491.31017379638, 1101.5758932810925, 1155.566662501562, 1169.1698893785338, 1170.6488053583892, 1223.473906220316, 16814.411495597597, 17732.20205090774, 17843.73234401485, 17928.103594820208, 17961.461156165336, 566459.0, 568938.0, 570244.0, 571247.0, 575886.0, 61026.0, 61235.38764612297, 61354.38645613576, 61359.38640613537, 61519.6924015386, 1332.9800052999212, 1348.0496250143626, 1357.803118547805, 1365.092213677913, 1393.6933874547583, 31223.687763122987, 31853.840730796197, 32604.347913041132, 33846.66153338435, 34327.31345373129, 53013.33706584545, 53602.46397536131, 53811.0, 53979.73010134924, 54276.0, 443051.0, 444774.0, 445674.0, 447619.0, 449550.0, 29230.56154157647, 29467.0, 29613.407731845673, 29616.851915740284, 29627.963021294152, 49500.0, 49587.0, 49994.75002625109, 50362.49637503725, 50953.23570146377, 40799.55202687848, 42897.0, 43050.0, 43293.567064328956, 44038.77980610076, 42556.36165457583, 42869.0, 43918.34122488229, 44455.0, 44562.55437445584, 41814.37278440765, 43002.78498607612, 43441.34837977496, 44239.0, 44283.77858110818, 36919.26161476702, 38638.420423693104, 38798.80600596979, 38931.610683892795, 39463.0, 29200.707992919797, 29376.7062329374, 29555.26111847135, 29681.554776677935, 29830.70169298366], "value": 19415.735318205727, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [388.1770646229993, 389.41393203229154, 406.0842799487156, 406.8169323804288, 411.68466748737774, 18436.723449148256, 19756.604867902668, 20347.898260508697, 20401.979901004946, 20980.37058888232, 17635.382761603345, 17872.463826085204, 18708.719369209437, 19098.427047188605, 19118.13968371423, 5366.436524164965, 5371.57027437805, 5402.702851343174, 5409.6213265071465, 5441.455854414547, 5398.16328469086, 5404.91892621611, 5430.864228394302, 5440.183972404151, 5445.319335083114, 4959.578435832958, 4995.425526064513, 5019.322391477159, 5059.16523773577, 5359.866003349908, 5302.416734159239, 5351.117065684158, 5357.624966252364, 5385.21914322423, 5415.079436495806, 5141.10030744622, 5220.530152286313, 5260.132078207092, 5304.575633949275, 5313.521783039507, 14420.567382978528, 14518.564443066725, 14632.341544630517, 14798.0, 14798.334074966653, 2270.2962081754545, 2350.9882450587806, 2357.823163262745, 2403.194929698553, 2747.738964798341, 10613.257072004963, 11083.224174307801, 11270.211085224038, 12501.687457813627, 12623.810642840364, 1895.2134864031411, 1908.3988543608718, 1997.6703843865744, 2032.9695054574192, 2070.968935465969, 85605.0, 85625.4405655241, 86552.56723716404, 87432.0, 88390.11609883947, 11262.774744505065, 11555.88444115565, 11661.708457288636, 11671.88328116725, 11722.413879306001, 15884.44404445862, 15896.12571308566, 15924.92037539805, 16000.0, 16020.0, 7980.960095199487, 8216.712415065444, 8409.873851892227, 8470.788230294293, 8492.915070849336, 7506.62466876654, 7508.924910750932, 7935.444518883738, 7998.240167184108, 8184.54984975832, 4785.3300537924715, 4821.349117869113, 4830.6135509159185, 4859.635527335393, 4996.275540046673, 1934.3423236099793, 1995.4911497568028, 2033.1054336092072, 2072.782357852434, 2085.624587574251, 878.1350369885657, 904.6607522179182, 1003.668789299544, 1014.4369874719602, 1035.8342665173686, 19805.60388792245, 20264.29074982398, 20453.897730511253, 20487.0, 20571.38285851427, 997.9101880830615, 1033.302520798458, 1047.512906498482, 1050.968470945873, 1051.321897376188, 11095.83356249657, 11304.378259195659, 11422.371769552588, 11491.885081149081, 11631.185816992898, 493264.0, 504206.0, 528481.0, 528954.0, 531847.0, 93443.53278233702, 95342.52328738311, 95775.0, 96681.51659241659, 96719.51640241894, 986.6793292180071, 1006.0945149365483, 1024.2113572549245, 1027.5684212630713, 1028.783955369366, 17518.73721894147, 17829.197686103897, 18165.0, 18208.45374638763, 18277.54306142357, 42854.0, 43811.0, 43985.560144399424, 44317.0, 44822.551774481835, 60061.39938600733, 60660.393396065476, 61054.0, 62092.0, 62342.34954785713, 8611.13888611159, 8646.221840034426, 8727.0, 8832.91167088321, 9352.392094513834, 11909.583164589545, 13003.154794938298, 13426.664333391744, 13467.259300738553, 13745.656358591115, 11625.0, 11861.406929653655, 11864.703382415508, 11864.822027669765, 12098.395080246128, 11443.713907152387, 11616.593419230287, 11670.70823229426, 11808.822867657163, 12058.095642826647, 11776.941115294712, 11872.789401115208, 12093.213941093802, 12467.376631168587, 12884.420201090787, 8557.914420855712, 8630.136986301319, 8803.911960880308, 8842.159994800484, 9118.270538357048, 11172.435858979912, 11867.940660296643, 12135.817962730744, 12173.878261217274, 12258.816117758419], "value": 9250.816421105543, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1353.560092969785, 1422.75813111771, 1499.512658386025, 1669.382328538441, 1700.1924086059116, 7338.412926965843, 7819.218078192178, 7956.363490920727, 8436.704715334965, 8483.024452187992, 7992.840143197132, 8310.626021829017, 8319.168083191678, 8343.707970221043, 8349.749507514769, 2327.441414060626, 2345.659879317498, 2347.929562113139, 2353.7410884802657, 2357.2928121563464, 2270.648049552322, 2318.211807985285, 2341.496578235679, 2347.119830063726, 2347.753485883983, 2328.883555822202, 2330.627099664054, 2356.446235134742, 2358.363241924688, 2359.1271229645054, 2256.537409830981, 2273.3407311879537, 2290.393045842853, 2291.4958709083976, 2324.3491822289616, 2312.2947501012186, 2312.3294244669028, 2317.5596636638984, 2318.8376813623054, 2319.744828068911, 8304.916950830475, 8428.789280268042, 8488.702895398632, 8489.320854331638, 8506.702265420743, 4904.509549045102, 4954.355933728628, 4972.303877457159, 4972.7513624318635, 5042.747862606855, 3332.1169889979174, 3391.220019395528, 3457.8789742358895, 3519.1554027033585, 3530.276293359855, 1164.4992653159138, 1207.8912897839148, 1214.1440284599337, 1239.5103933946132, 1239.7582471418077, 11329.773404531945, 11355.943220283929, 11462.312261264267, 11484.966353028267, 11487.597934072352, 4335.458067741532, 4448.421705178306, 4574.6340292776495, 4630.791614377361, 4669.4630117536235, 9608.231341492663, 9652.469114198786, 9685.903140968641, 9740.561674724655, 9762.95118524417, 5015.3730783652045, 5032.79868805251, 5035.949640503622, 5042.369703787027, 5045.672031317952, 4099.733517321364, 4543.273076307841, 4621.468531118897, 4631.884202894955, 4662.696924699883, 3861.7876016819346, 3876.3604005339366, 3918.5101862267215, 3987.342088555356, 4028.254772867029, 1280.8975281977418, 1297.772889744291, 1308.718625495523, 1318.4726109556254, 1325.0790700463085, 991.9801603968025, 1005.5826831864695, 1015.9034891685278, 1027.9743006424899, 1028.7633844215723, 5883.970580147072, 5885.234919460443, 5901.58688891782, 6009.969950150221, 6186.257649082049, 471.09314569454347, 477.7205334879135, 477.93308936748883, 484.6704241116004, 491.268010664115, 4114.835406583703, 4132.586741325843, 4182.351735481006, 4199.811008504625, 4260.190563792869, 9403.717888463358, 9654.75863103414, 9748.658796942214, 9785.657501987538, 9846.606135754633, 9686.128248457673, 9691.12779849817, 9738.269629777653, 9752.804943901083, 9786.804263914682, 7395.482316237812, 7513.586752728653, 7522.3605993491165, 7528.360089392353, 7581.3934885209055, 5663.858403539944, 5668.178114173339, 5670.858228544154, 5776.249087618751, 5836.358000619844, 8949.194572488508, 9102.954485227532, 9130.04134565861, 9180.44917304964, 9223.44659320443, 9081.591328390106, 9085.273178145864, 9137.543122843965, 9398.133569261441, 9562.426254424758, 6408.61548307103, 7244.529105608119, 7253.238409966877, 7259.274072592699, 7311.634418279171, 8074.192580741878, 8108.83782324362, 8154.510729356258, 8159.224873636995, 8191.05802832658, 7204.639768011473, 7463.141738700119, 7484.513506622052, 7550.546967181767, 7568.243175682388, 7113.82215444618, 7166.605836679033, 7228.168760592389, 7277.417806575567, 7328.890066648898, 6802.8639427212165, 6829.726810927706, 6914.723411063501, 6915.792526224222, 6917.896231556631, 5097.872553186052, 5178.32681751385, 5215.087359711959, 5279.920801188062, 5310.734463276898, 5157.432682404858, 5217.2434996925995, 5279.07011608561, 5281.419043905091, 5412.458754124556], "value": 4420.605451461976, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.15976690542675, 334.75562839127434, 342.6025810060329, 344.77934122161804, 346.06734849580374, 5414.7834086636585, 5415.64798288111, 5528.253685752422, 5581.748821303041, 5591.384947655754, 5447.591430642708, 5466.0, 5470.972645136779, 5479.698616576096, 5484.2176292704935, 4350.477942646887, 4362.585554372329, 4365.36702178184, 4366.257736184856, 4395.9560404396025, 4079.2453396121664, 4289.721168124078, 4297.677674174433, 4395.604395604395, 4411.470623525165, 4237.555056719047, 4253.234417804794, 4258.0, 4263.275243208662, 4263.701540892139, 4263.2965560682605, 4278.379634952946, 4281.657467402601, 4288.785560721952, 4308.547602501723, 3659.048647351681, 3785.0915780212827, 3791.8293676784333, 3798.3542797724176, 3799.8410484802125, 5271.973640131775, 5301.7084060376665, 5344.492273234076, 5363.892722145574, 5368.141097424433, 4954.0, 5024.522670346311, 5024.874378140576, 5027.824026159104, 5028.245763135523, 5545.833624991256, 5739.426057394269, 5746.678263999303, 5799.217105690762, 5809.477147056785, 4219.746815191068, 4226.3026600610865, 4230.788460576959, 4246.851360202409, 4254.276772948575, 5959.821205363846, 5979.760809567656, 5982.551308651869, 5989.490893274077, 6030.698465076773, 4115.42384066231, 4186.225548273579, 4196.517400498981, 4198.3702444633545, 4204.642605378577, 4284.0, 4285.61429471349, 4286.314189729691, 4292.5063617683745, 4298.161858437637, 4862.41651001882, 4899.657024008286, 4914.877128071756, 4916.188828843201, 4927.187014142698, 5702.51528620072, 5736.848102331898, 5808.157817116495, 5822.912656310159, 5825.79609713658, 1510.9017913835567, 1525.9694806104037, 1535.4549135057118, 1541.306412114553, 1541.745611974034, 939.4081728510994, 972.3130368810109, 982.6266018912768, 984.2913102566141, 994.125169850527, 4918.680285781413, 4932.506749325111, 4952.702837829742, 4980.477049909708, 5002.324686167393, 5218.478152184751, 5230.189320655304, 5237.240600112962, 5238.554722848525, 5241.31862857826, 5033.496650334937, 5038.9592215152925, 5039.294498770175, 5216.191490319006, 5670.8015219467125, 3138.1997590614246, 3178.6344570374704, 3181.316017056344, 3181.5068664357063, 3181.7136457718916, 5967.433093856077, 6173.290071641729, 6230.6884655767935, 6248.4064013918605, 6257.56197066201, 6036.305824830113, 6064.757409703562, 6090.6041107328765, 6098.26820781509, 6108.914997926019, 6105.412592725835, 6119.724612392364, 6149.96925015381, 6180.351063138306, 6184.196054512884, 5821.126830975388, 5854.536365908523, 5905.320888097924, 5954.732037058429, 5997.220361352996, 5885.61743486672, 5914.645121292736, 5919.763209471573, 5941.554383421347, 5957.76168953237, 6089.50807052275, 6108.0, 6186.133941248138, 6218.626882387071, 6223.3465486125115, 4125.50493940729, 4168.478940132483, 4184.075325350373, 4199.937000944928, 4223.32426811721, 5941.1385349125, 5952.8809423812145, 5981.431763982415, 6061.181740464981, 6091.8781624366375, 5611.943880561143, 5778.479936805707, 5819.82540523785, 5908.911366329595, 5919.53707081345, 5808.448197421239, 5820.359760426434, 5825.077724351038, 5845.532357411312, 5859.853503662443, 5786.0, 5787.594868359343, 5858.414158584107, 5865.354810970875, 5885.205012471066, 5560.360558535658, 5848.403232012197, 5882.558808089325, 5889.646621202742, 5900.970495147497, 5778.595498315078, 5785.566082543742, 5792.175464728597, 5793.784449630495, 5811.418858114154], "value": 4393.796524033856, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.3651713457889, 792.437369467678, 818.6602559937626, 842.7092653034705, 856.5631527920758, 15836.129012904286, 16374.508764737047, 16546.255418506167, 16600.086995215275, 16650.0, 15485.535433937, 16058.116803575798, 16250.349986000545, 16858.409955651554, 16878.0, 803.2289002557552, 837.3552364679193, 840.5503055865113, 840.6469282901196, 841.1042240014365, 813.6785969542057, 828.45736042892, 829.3738227638124, 840.1514470384925, 849.1084361420515, 893.5130353957109, 896.256107430834, 896.3770179725094, 896.5696465696469, 896.6547879066574, 881.0792721605937, 881.2289246908955, 885.8051228729669, 886.3883920095113, 886.9113088691144, 642.7686033028153, 643.2024289880561, 643.4562794438692, 644.1593720195143, 645.4320198225531, 15042.924785376003, 15053.247337633074, 15056.397744090224, 15063.246837658073, 15101.47144849936, 15486.61283467911, 15630.45293414725, 15701.607459813597, 15813.92093039539, 15972.680546389007, 12169.0, 12195.630378892452, 12203.521607599498, 12240.387980600934, 12272.44773985164, 3897.1815918657117, 3907.2185562887253, 3930.567637559866, 3988.3818008208773, 4015.738976966488, 80744.0, 81373.59313203456, 81703.18296817015, 81971.0, 82543.0, 11709.355985420883, 11751.353675547927, 11797.823032654516, 11945.522179112739, 12081.637550873487, 22518.211862584732, 22529.0, 22766.31701048971, 22860.0, 22861.885690571442, 8695.391322607484, 8813.559322033872, 8873.423227490193, 8880.333974951904, 9176.17414432691, 4989.101961646938, 5002.174641184237, 5024.924626130611, 5031.52200540948, 5232.92150617741, 3647.507586475845, 3734.738568300193, 3771.340015497277, 3772.302124107049, 3781.4327850822046, 606.9514438844882, 622.8847663182326, 640.759715106835, 653.0595941843729, 654.4273760459598, 755.267390631087, 766.1878408886487, 768.5772824946368, 796.2793671727096, 800.507687772016, 10226.23303252259, 10285.537150828231, 10431.634892778717, 10717.303375280582, 10787.676369708764, 691.7302252121676, 766.2490759056045, 778.0935210479728, 778.5250996891891, 778.657390748069, 5074.847754567369, 5186.481351864859, 5215.504527069922, 5247.842564723064, 5266.710330931759, 71984.0, 93366.53316733374, 127669.0, 128363.35818321035, 131965.34017330044, 65430.0, 70623.0, 107846.0, 108558.0, 113425.0, 95005.5249723747, 95887.52056239813, 96223.0, 98130.0, 98788.0, 9891.505424728879, 10062.446565438971, 10203.13273371742, 10346.534405951901, 10375.27373083877, 53322.0, 53690.73154634202, 54314.0, 55587.0, 56947.43052569587, 70796.93804592833, 84685.15314846773, 85414.57292713497, 85727.57136214279, 96997.51501242448, 14698.779518307449, 14912.7763083556, 14972.925135374253, 15227.619309517351, 15409.075455472708, 15610.891366015368, 15888.443904463289, 16089.356425743308, 16874.578135546708, 16960.491185264462, 12847.807282890577, 13104.903215485858, 13943.930280348533, 14175.43298268099, 14186.0, 14541.418343266574, 14815.25923703789, 15103.697926041197, 15708.13605251722, 15901.125438101015, 13857.376418061413, 13870.72258554803, 14215.715685686022, 14734.77897831512, 14939.551813445614, 11143.944280278547, 11329.490172942402, 11453.0, 11775.342520193431, 12506.249625022529, 11437.485313160762, 11705.180637355303, 12707.916833266767, 12739.61781146567, 12926.547570834975], "value": 8000.584772669882, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1579.7, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 111.0, 114.0, 112.0, 112.0, 118.0, 116.0, 112.0, 126.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 121.0, 146.0, 186.0, 129.0, 154.0, 154.0, 122.0, 184.0, 121.0], "value": 146.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 166.0, 168.0, 178.0, 179.0, 167.0, 166.0, 165.0, 164.0, 166.0], "value": 168.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 77.0, 191.0, 77.0, 78.0, 79.0, 76.0, 183.0, 77.0], "value": 99.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 163.0, 87.0, 87.0, 87.0, 159.0, 88.0, 87.0, 140.0], "value": 107.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 119.0, 119.0, 119.0, 119.0, 120.0, 120.0, 117.0, 118.0, 117.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0, 150.0, 149.0, 147.0], "value": 147.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 118.0], "value": 98.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 56.0, 53.0, 54.0, 53.0, 69.0, 56.0, 53.0, 54.0, 53.0], "value": 55.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 66.0, 63.0, 63.0, 64.0, 64.0, 62.0, 65.0, 62.0, 63.0], "value": 63.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 80.0, 90.0, 83.0, 82.0, 80.0, 80.0, 81.0, 98.0, 84.0], "value": 84.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [136.0, 126.0, 127.0, 133.0, 141.0, 127.0, 134.0, 125.0, 196.0, 128.0], "value": 137.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 179.0, 188.0, 169.0, 168.0, 172.0, 173.0, 166.0, 164.0, 164.0], "value": 171.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 72.0, 70.0, 67.0, 72.0, 66.0, 66.0, 68.0, 67.0, 73.0], "value": 68.6, "unit": "score"}]}]} 23:36:58 INFO - Return code: 0 23:36:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 23:36:58 ERROR - # TBPL SUCCESS # 23:36:58 INFO - Running post-action listener: _resource_record_post_action 23:36:58 INFO - [mozharness: 2016-08-22 06:36:58.426438Z] Finished run-tests step (success) 23:36:58 INFO - Running post-run listener: _resource_record_post_run 23:36:58 INFO - Total resource usage - Wall time: 1195s; CPU: 14.0%; Read bytes: 8192; Write bytes: 423051264; Read time: 168; Write time: 440092 23:36:58 INFO - TinderboxPrint: CPU usage
13.8% 23:36:58 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 168 23:36:58 INFO - TinderboxPrint: I/O write bytes / time
423,051,264 / 440,092 23:36:58 INFO - TinderboxPrint: CPU idle
8,209.6 (86.1%) 23:36:58 INFO - TinderboxPrint: CPU user
1,219.7 (12.8%) 23:36:58 INFO - TinderboxPrint: Swap in / out
0 / 0 23:36:58 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 134111232; Read time: 0; Write time: 138028 23:36:58 INFO - run-tests - Wall time: 1178s; CPU: 14.0%; Read bytes: 4096; Write bytes: 288038912; Read time: 152; Write time: 302036 23:36:59 INFO - Running post-run listener: _upload_blobber_files 23:36:59 INFO - Blob upload gear active. 23:36:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 23:36:59 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 23:36:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 23:36:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 23:36:59 INFO - (blobuploader) - INFO - Open directory for files ... 23:36:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 23:36:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:36:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 23:37:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:03 INFO - (blobuploader) - INFO - Done attempting. 23:37:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 23:37:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 23:37:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:04 INFO - (blobuploader) - INFO - Done attempting. 23:37:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 23:37:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 23:37:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 23:37:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 23:37:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 23:37:05 INFO - (blobuploader) - INFO - Done attempting. 23:37:05 INFO - (blobuploader) - INFO - Iteration through files over. 23:37:05 INFO - Return code: 0 23:37:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 23:37:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 23:37:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96c84030987de91147dd53d51193674fef860310759f7f6a85067bf4d95fe79bfdba2197323c695f7c18b207e6db7c90aedc9c3f73f14594d8ddebe36af42dde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d40a8d6ee61a604f61a91414d07822e6c78493ae60fa73ea414bc99e2c54fbe6952eb497bc9136e094dae4816eab813fa2c22e0a1d454aa89e3aca248cf7f4d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec548b31de8379d77fd7ee5d60656fa85c7128d0d640f7e67c227811f774435f2ef10fb10c0a749053b723bad43757cf844cf0526bed65e907d0a1dfc84ad8af"} 23:37:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 23:37:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 23:37:05 INFO - Contents: 23:37:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96c84030987de91147dd53d51193674fef860310759f7f6a85067bf4d95fe79bfdba2197323c695f7c18b207e6db7c90aedc9c3f73f14594d8ddebe36af42dde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d40a8d6ee61a604f61a91414d07822e6c78493ae60fa73ea414bc99e2c54fbe6952eb497bc9136e094dae4816eab813fa2c22e0a1d454aa89e3aca248cf7f4d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec548b31de8379d77fd7ee5d60656fa85c7128d0d640f7e67c227811f774435f2ef10fb10c0a749053b723bad43757cf844cf0526bed65e907d0a1dfc84ad8af"} 23:37:05 INFO - Running post-run listener: copy_logs_to_upload_dir 23:37:05 INFO - Copying logs to upload dir... 23:37:05 INFO - mkdir: /builds/slave/test/build/upload/logs 23:37:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.253721 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-08-21 23:37:04.520611) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 23:37:04.526451) ========= 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=af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/96c84030987de91147dd53d51193674fef860310759f7f6a85067bf4d95fe79bfdba2197323c695f7c18b207e6db7c90aedc9c3f73f14594d8ddebe36af42dde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d40a8d6ee61a604f61a91414d07822e6c78493ae60fa73ea414bc99e2c54fbe6952eb497bc9136e094dae4816eab813fa2c22e0a1d454aa89e3aca248cf7f4d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec548b31de8379d77fd7ee5d60656fa85c7128d0d640f7e67c227811f774435f2ef10fb10c0a749053b723bad43757cf844cf0526bed65e907d0a1dfc84ad8af"} build_url:https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011202 build_url: 'https://queue.taskcluster.net/v1/task/L4D7dMo7RGeZUZB-DzmVwA/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/sha512/96c84030987de91147dd53d51193674fef860310759f7f6a85067bf4d95fe79bfdba2197323c695f7c18b207e6db7c90aedc9c3f73f14594d8ddebe36af42dde", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d40a8d6ee61a604f61a91414d07822e6c78493ae60fa73ea414bc99e2c54fbe6952eb497bc9136e094dae4816eab813fa2c22e0a1d454aa89e3aca248cf7f4d6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ec548b31de8379d77fd7ee5d60656fa85c7128d0d640f7e67c227811f774435f2ef10fb10c0a749053b723bad43757cf844cf0526bed65e907d0a1dfc84ad8af"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-21 23:37:04.551933) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:37:04.552280) ========= 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=af724c981e2a0f424dbabf99000001e7-1471845471.16801-1884131889 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004444 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-21 23:37:04.637495) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-21 23:37:04.637987) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-21 23:37:04.638423) ========= ========= Total master_lag: 0.18 =========