builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-046 starttime: 1470798384.63 results: success (0) buildid: 20160809173001 builduid: 6435277cc98240df8c74c5b73a4d7486 revision: 13abad48dfb674a240bc019ab7c7305504f1eb93 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:24.632167) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:24.632712) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:24.633010) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:24.667189) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:24.667477) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-09 20:06:24-- 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% 66.6M=0s 2016-08-09 20:06:24 (66.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.090774 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:24.773770) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:24.774121) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018465 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:24.823923) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:24.824292) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 13abad48dfb674a240bc019ab7c7305504f1eb93 --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 13abad48dfb674a240bc019ab7c7305504f1eb93 --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=652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-09 20:06:24,985 truncating revision to first 12 chars 2016-08-09 20:06:24,985 Setting DEBUG logging. 2016-08-09 20:06:24,985 attempt 1/10 2016-08-09 20:06:24,985 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/13abad48dfb6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-09 20:06:25,303 unpacking tar archive at: fx-team-13abad48dfb6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640165 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:25.477968) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:25.478310) ========= script_repo_revision: 13abad48dfb674a240bc019ab7c7305504f1eb93 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:25.478693) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:25.478956) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-09 20:06:25.488631) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-09 20:06:25.489039) ========= /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=652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 20:06:25 INFO - MultiFileLogger online at 20160809 20:06:25 in /builds/slave/test 20:06:25 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 20:06:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:06:25 INFO - {'append_to_log': False, 20:06:25 INFO - 'base_work_dir': '/builds/slave/test', 20:06:25 INFO - 'blob_upload_branch': 'Fx-Team', 20:06:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:06:25 INFO - 'branch': 'Fx-Team', 20:06:25 INFO - 'buildbot_json_path': 'buildprops.json', 20:06:25 INFO - 'config_files': ('talos/linux_config.py',), 20:06:25 INFO - 'default_actions': ('clobber', 20:06:25 INFO - 'read-buildbot-config', 20:06:25 INFO - 'download-and-extract', 20:06:25 INFO - 'populate-webroot', 20:06:25 INFO - 'create-virtualenv', 20:06:25 INFO - 'install', 20:06:25 INFO - 'run-tests'), 20:06:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:06:25 INFO - 'download_minidump_stackwalk': True, 20:06:25 INFO - 'download_symbols': 'ondemand', 20:06:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:06:25 INFO - 'tooltool.py': '/tools/tooltool.py', 20:06:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:06:25 INFO - '/tools/misc-python/virtualenv.py')}, 20:06:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:06:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:06:25 INFO - 'installer_path': 'installer.exe', 20:06:25 INFO - 'log_level': 'info', 20:06:25 INFO - 'log_name': 'talos', 20:06:25 INFO - 'log_to_console': True, 20:06:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 20:06:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 20:06:25 INFO - 'opt_config_files': (), 20:06:25 INFO - 'pip_index': False, 20:06:25 INFO - 'sps_profile': False, 20:06:25 INFO - 'sps_profile_interval': 0, 20:06:25 INFO - 'suite': 'dromaeojs-e10s', 20:06:25 INFO - 'system_bits': '32', 20:06:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:06:25 INFO - 'title': 'talos-linux64-ix-046', 20:06:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:06:25 INFO - 'use_talos_json': True, 20:06:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:06:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:06:25 INFO - 'work_dir': 'build'} 20:06:25 INFO - [mozharness: 2016-08-10 03:06:25.742428Z] Running clobber step. 20:06:25 INFO - Running pre-action listener: _resource_record_pre_action 20:06:25 INFO - Running main action method: clobber 20:06:25 INFO - rmtree: /builds/slave/test/build 20:06:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:06:26 INFO - Running post-action listener: _resource_record_post_action 20:06:26 INFO - [mozharness: 2016-08-10 03:06:26.731678Z] Finished clobber step (success) 20:06:26 INFO - [mozharness: 2016-08-10 03:06:26.731779Z] Running read-buildbot-config step. 20:06:26 INFO - Running pre-action listener: _resource_record_pre_action 20:06:26 INFO - Running main action method: read_buildbot_config 20:06:26 INFO - Using buildbot properties: 20:06:26 INFO - { 20:06:26 INFO - "project": "", 20:06:26 INFO - "product": "firefox", 20:06:26 INFO - "script_repo_revision": "production", 20:06:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 20:06:26 INFO - "repository": "", 20:06:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 20:06:26 INFO - "buildid": "20160809173001", 20:06:26 INFO - "pgo_build": "True", 20:06:26 INFO - "basedir": "/builds/slave/test", 20:06:26 INFO - "buildnumber": 660, 20:06:26 INFO - "slavename": "talos-linux64-ix-046", 20:06:26 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 20:06:26 INFO - "platform": "ubuntu64_hw", 20:06:26 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 20:06:26 INFO - "branch": "fx-team", 20:06:26 INFO - "repo_path": "integration/fx-team", 20:06:26 INFO - "revision": "13abad48dfb674a240bc019ab7c7305504f1eb93", 20:06:26 INFO - "stage_platform": "linux64-pgo", 20:06:26 INFO - "builduid": "6435277cc98240df8c74c5b73a4d7486", 20:06:26 INFO - "slavebuilddir": "test" 20:06:26 INFO - } 20:06:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 20:06:26 INFO - Running post-action listener: _resource_record_post_action 20:06:26 INFO - [mozharness: 2016-08-10 03:06:26.734208Z] Finished read-buildbot-config step (success) 20:06:26 INFO - [mozharness: 2016-08-10 03:06:26.734297Z] Running download-and-extract step. 20:06:26 INFO - Running pre-action listener: _resource_record_pre_action 20:06:26 INFO - Running main action method: download_and_extract 20:06:26 INFO - mkdir: /builds/slave/test/build/tests 20:06:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:26 INFO - trying https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:06:26 INFO - Downloading https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 20:06:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 20:06:27 INFO - Downloaded 1361 bytes. 20:06:27 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 20:06:27 INFO - Using the following test package requirements: 20:06:27 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:27 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 20:06:27 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 20:06:27 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:27 INFO - u'jsshell-linux-x86_64.zip'], 20:06:27 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 20:06:27 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 20:06:27 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 20:06:27 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 20:06:27 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 20:06:27 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 20:06:27 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 20:06:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 20:06: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')]} 20:06:27 INFO - trying https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:27 INFO - Downloading https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 20:06:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 20:06:28 INFO - Downloaded 21831225 bytes. 20:06:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:06:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:06:29 INFO - Return code: 0 20:06:29 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 20:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:29 INFO - trying https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 20:06:29 INFO - Downloading https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 20:06:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 20:06:30 INFO - Downloaded 21831225 bytes. 20:06:30 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:06:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 20:06:31 INFO - Return code: 0 20:06:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:31 INFO - trying https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 20:06:31 INFO - Downloading https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 20:06:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 20:06:32 INFO - Downloaded 14413723 bytes. 20:06:32 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 20:06:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 20:06:32 INFO - Return code: 0 20:06:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:32 INFO - trying https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:32 INFO - Downloading https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 20:06:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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 20:06:33 INFO - Downloaded 59331046 bytes. 20:06:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:33 INFO - mkdir: /builds/slave/test/properties 20:06:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:06:33 INFO - Writing to file /builds/slave/test/properties/build_url 20:06:33 INFO - Contents: 20:06:33 INFO - build_url:https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 20:06:34 INFO - Running post-action listener: _resource_record_post_action 20:06:34 INFO - Running post-action listener: set_extra_try_arguments 20:06:34 INFO - [mozharness: 2016-08-10 03:06:34.460297Z] Finished download-and-extract step (success) 20:06:34 INFO - [mozharness: 2016-08-10 03:06:34.460529Z] Running populate-webroot step. 20:06:34 INFO - Running pre-action listener: _resource_record_pre_action 20:06:34 INFO - Running main action method: populate_webroot 20:06:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:06:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:06:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:06:34 INFO - '--tppagecycles', 20:06:34 INFO - '7'], 20:06:34 INFO - 'tests': ['tsvgm']}}, 20:06:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:06:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:06:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:06:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:06:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:06:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['damp', 'tps']}, 20:06:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'tests': ['damp', 'tps']}, 20:06:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['dromaeo_dom']}, 20:06:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:06:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['basic_compositor_video']}, 20:06:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:06:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other-e10s': {'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['a11yr', 20:06:34 INFO - 'ts_paint', 20:06:34 INFO - 'tpaint', 20:06:34 INFO - 'sessionrestore', 20:06:34 INFO - 'sessionrestore_no_auto_restore', 20:06:34 INFO - 'tabpaint']}, 20:06:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['tsvgx', 20:06:34 INFO - 'tsvgr_opacity', 20:06:34 INFO - 'tart', 20:06:34 INFO - 'tscrollx', 20:06:34 INFO - 'cart']}, 20:06:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:06:34 INFO - 'tsvgr_opacity', 20:06:34 INFO - 'tart', 20:06:34 INFO - 'tscrollx', 20:06:34 INFO - 'cart']}, 20:06:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s'], 20:06:34 INFO - 'tests': ['tp5o']}, 20:06:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'tests': ['tp5o']}, 20:06:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--disable-e10s', 20:06:34 INFO - '--xperf_path', 20:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:34 INFO - 'tests': ['tp5n']}, 20:06:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:06:34 INFO - 'talos_options': ['--xperf_path', 20:06:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:06:34 INFO - 'tests': ['tp5n']}}, 20:06:34 INFO - 'talos.zip': {'path': '', 20:06:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:06:34 INFO - Running post-action listener: _resource_record_post_action 20:06:34 INFO - [mozharness: 2016-08-10 03:06:34.476850Z] Finished populate-webroot step (success) 20:06:34 INFO - [mozharness: 2016-08-10 03:06:34.476938Z] Running create-virtualenv step. 20:06:34 INFO - Running pre-action listener: _resource_record_pre_action 20:06:34 INFO - Running main action method: create_virtualenv 20:06:34 INFO - Creating virtualenv /builds/slave/test/build/venv 20:06:34 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 20:06:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:06:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:06:34 INFO - Using real prefix '/usr' 20:06:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:06:35 INFO - Installing distribute.............................................................................................................................................................................................done. 20:06:37 INFO - Installing pip.................done. 20:06:37 INFO - Return code: 0 20:06:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:06:37 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')]} 20:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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')]} 20:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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 0x17b2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a713b0>, '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 0x1a722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a72740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', '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 20:06:37 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 20:06:37 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 20:06:37 INFO - Using env: {'DISPLAY': ':0', 20:06:37 INFO - 'HOME': '/home/cltbld', 20:06:37 INFO - 'LANG': 'en_US.UTF-8', 20:06:37 INFO - 'LANGUAGE': 'en_US:en', 20:06:37 INFO - 'LOGNAME': 'cltbld', 20:06:37 INFO - 'MAIL': '/var/mail/cltbld', 20:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:37 INFO - 'MOZ_NO_REMOTE': '1', 20:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:37 INFO - 'NO_EM_RESTART': '1', 20:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:37 INFO - 'PWD': '/builds/slave/test', 20:06:37 INFO - 'SHELL': '/bin/bash', 20:06:37 INFO - 'SHLVL': '1', 20:06:37 INFO - 'TERM': 'linux', 20:06:37 INFO - 'TMOUT': '86400', 20:06:37 INFO - 'USER': 'cltbld', 20:06:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', 20:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:37 INFO - '_': '/tools/buildbot/bin/python'} 20:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:37 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 20:06:37 INFO - Cleaning up... 20:06:37 INFO - Return code: 0 20:06:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:06:37 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')]} 20:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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')]} 20:06:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:37 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 0x17b2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a713b0>, '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 0x1a722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a72740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', '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 20:06:37 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 20:06:37 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 20:06:37 INFO - Using env: {'DISPLAY': ':0', 20:06:37 INFO - 'HOME': '/home/cltbld', 20:06:37 INFO - 'LANG': 'en_US.UTF-8', 20:06:37 INFO - 'LANGUAGE': 'en_US:en', 20:06:37 INFO - 'LOGNAME': 'cltbld', 20:06:37 INFO - 'MAIL': '/var/mail/cltbld', 20:06:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:37 INFO - 'MOZ_NO_REMOTE': '1', 20:06:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:37 INFO - 'NO_EM_RESTART': '1', 20:06:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:37 INFO - 'PWD': '/builds/slave/test', 20:06:37 INFO - 'SHELL': '/bin/bash', 20:06:37 INFO - 'SHLVL': '1', 20:06:37 INFO - 'TERM': 'linux', 20:06:37 INFO - 'TMOUT': '86400', 20:06:37 INFO - 'USER': 'cltbld', 20:06:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', 20:06:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:37 INFO - '_': '/tools/buildbot/bin/python'} 20:06:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:37 INFO - Downloading/unpacking psutil>=3.1.1 20:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:06:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:39 INFO - Installing collected packages: psutil 20:06:39 INFO - Running setup.py install for psutil 20:06:39 INFO - building 'psutil._psutil_linux' extension 20:06:39 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 20:06:39 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 20:06:39 INFO - building 'psutil._psutil_posix' extension 20:06:39 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 20:06:39 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 20:06:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:06:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:06:40 INFO - Successfully installed psutil 20:06:40 INFO - Cleaning up... 20:06:40 INFO - Return code: 0 20:06:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:06:40 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')]} 20:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:40 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')]} 20:06:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:40 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 0x17b2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a713b0>, '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 0x1a722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a72740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', '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 20:06:40 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 20:06:40 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 20:06:40 INFO - Using env: {'DISPLAY': ':0', 20:06:40 INFO - 'HOME': '/home/cltbld', 20:06:40 INFO - 'LANG': 'en_US.UTF-8', 20:06:40 INFO - 'LANGUAGE': 'en_US:en', 20:06:40 INFO - 'LOGNAME': 'cltbld', 20:06:40 INFO - 'MAIL': '/var/mail/cltbld', 20:06:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:40 INFO - 'MOZ_NO_REMOTE': '1', 20:06:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:40 INFO - 'NO_EM_RESTART': '1', 20:06:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:40 INFO - 'PWD': '/builds/slave/test', 20:06:40 INFO - 'SHELL': '/bin/bash', 20:06:40 INFO - 'SHLVL': '1', 20:06:40 INFO - 'TERM': 'linux', 20:06:40 INFO - 'TMOUT': '86400', 20:06:40 INFO - 'USER': 'cltbld', 20:06:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', 20:06:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:40 INFO - '_': '/tools/buildbot/bin/python'} 20:06:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:06:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:06:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:06:42 INFO - Installing collected packages: mozsystemmonitor 20:06:42 INFO - Running setup.py install for mozsystemmonitor 20:06:42 INFO - Successfully installed mozsystemmonitor 20:06:42 INFO - Cleaning up... 20:06:42 INFO - Return code: 0 20:06:42 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:06:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x17b2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a713b0>, '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 0x1a722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a72740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', '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 20:06:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 20:06:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 20:06:42 INFO - Using env: {'DISPLAY': ':0', 20:06:42 INFO - 'HOME': '/home/cltbld', 20:06:42 INFO - 'LANG': 'en_US.UTF-8', 20:06:42 INFO - 'LANGUAGE': 'en_US:en', 20:06:42 INFO - 'LOGNAME': 'cltbld', 20:06:42 INFO - 'MAIL': '/var/mail/cltbld', 20:06:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:42 INFO - 'MOZ_NO_REMOTE': '1', 20:06:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:42 INFO - 'NO_EM_RESTART': '1', 20:06:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:42 INFO - 'PWD': '/builds/slave/test', 20:06:42 INFO - 'SHELL': '/bin/bash', 20:06:42 INFO - 'SHLVL': '1', 20:06:42 INFO - 'TERM': 'linux', 20:06:42 INFO - 'TMOUT': '86400', 20:06:42 INFO - 'USER': 'cltbld', 20:06:42 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', 20:06:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:42 INFO - '_': '/tools/buildbot/bin/python'} 20:06:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:42 INFO - Downloading/unpacking jsonschema==2.5.1 20:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:44 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:06:44 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:44 INFO - Downloading functools32-3.2.3-2.tar.gz 20:06:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:06:44 INFO - warning: no files found matching '*.txt' 20:06:44 INFO - no previously-included directories found matching 'build' 20:06:44 INFO - no previously-included directories found matching 'dist' 20:06:44 INFO - no previously-included directories found matching '.git*' 20:06:44 INFO - Installing collected packages: jsonschema, functools32 20:06:44 INFO - Running setup.py install for functools32 20:06:44 INFO - warning: no files found matching '*.txt' 20:06:44 INFO - no previously-included directories found matching 'build' 20:06:44 INFO - no previously-included directories found matching 'dist' 20:06:44 INFO - no previously-included directories found matching '.git*' 20:06:44 INFO - Successfully installed jsonschema functools32 20:06:44 INFO - Cleaning up... 20:06:44 INFO - Return code: 0 20:06:44 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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', '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 0x17b2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a713b0>, '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 0x1a722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a72740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', '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 20:06: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 20:06: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 functools32==3.2.3-2 20:06:44 INFO - Using env: {'DISPLAY': ':0', 20:06:44 INFO - 'HOME': '/home/cltbld', 20:06:44 INFO - 'LANG': 'en_US.UTF-8', 20:06:44 INFO - 'LANGUAGE': 'en_US:en', 20:06:44 INFO - 'LOGNAME': 'cltbld', 20:06:44 INFO - 'MAIL': '/var/mail/cltbld', 20:06:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:44 INFO - 'MOZ_NO_REMOTE': '1', 20:06:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:44 INFO - 'NO_EM_RESTART': '1', 20:06:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:44 INFO - 'PWD': '/builds/slave/test', 20:06:44 INFO - 'SHELL': '/bin/bash', 20:06:44 INFO - 'SHLVL': '1', 20:06:44 INFO - 'TERM': 'linux', 20:06:44 INFO - 'TMOUT': '86400', 20:06:44 INFO - 'USER': 'cltbld', 20:06:44 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', 20:06:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:44 INFO - '_': '/tools/buildbot/bin/python'} 20:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:06:45 INFO - Cleaning up... 20:06:45 INFO - Return code: 0 20:06:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:06:45 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')]} 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:45 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')]} 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:45 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 0x17b2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a713b0>, '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 0x1a722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a72740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', '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 20:06:45 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 20:06:45 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 20:06:45 INFO - Using env: {'DISPLAY': ':0', 20:06:45 INFO - 'HOME': '/home/cltbld', 20:06:45 INFO - 'LANG': 'en_US.UTF-8', 20:06:45 INFO - 'LANGUAGE': 'en_US:en', 20:06:45 INFO - 'LOGNAME': 'cltbld', 20:06:45 INFO - 'MAIL': '/var/mail/cltbld', 20:06:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:45 INFO - 'MOZ_NO_REMOTE': '1', 20:06:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:45 INFO - 'NO_EM_RESTART': '1', 20:06:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:45 INFO - 'PWD': '/builds/slave/test', 20:06:45 INFO - 'SHELL': '/bin/bash', 20:06:45 INFO - 'SHLVL': '1', 20:06:45 INFO - 'TERM': 'linux', 20:06:45 INFO - 'TMOUT': '86400', 20:06:45 INFO - 'USER': 'cltbld', 20:06:45 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', 20:06:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:45 INFO - '_': '/tools/buildbot/bin/python'} 20:06:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:45 INFO - Downloading/unpacking blobuploader==1.2.4 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:06:47 INFO - Downloading blobuploader-1.2.4.tar.gz 20:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:06:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:06:47 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06: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 20:06:47 INFO - Downloading docopt-0.6.1.tar.gz 20:06:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:06:48 INFO - Installing collected packages: blobuploader, requests, docopt 20:06:48 INFO - Running setup.py install for blobuploader 20:06:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:06:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:06:48 INFO - Running setup.py install for requests 20:06:48 INFO - Running setup.py install for docopt 20:06:48 INFO - Successfully installed blobuploader requests docopt 20:06:48 INFO - Cleaning up... 20:06:48 INFO - Return code: 0 20:06:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06:48 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')]} 20:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:48 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')]} 20:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:48 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 0x17b2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a713b0>, '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 0x1a722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a72740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', '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 20:06:48 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 20:06:48 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 20:06:48 INFO - Using env: {'DISPLAY': ':0', 20:06:48 INFO - 'HOME': '/home/cltbld', 20:06:48 INFO - 'LANG': 'en_US.UTF-8', 20:06:48 INFO - 'LANGUAGE': 'en_US:en', 20:06:48 INFO - 'LOGNAME': 'cltbld', 20:06:48 INFO - 'MAIL': '/var/mail/cltbld', 20:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:48 INFO - 'MOZ_NO_REMOTE': '1', 20:06:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:48 INFO - 'NO_EM_RESTART': '1', 20:06:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:48 INFO - 'PWD': '/builds/slave/test', 20:06:48 INFO - 'SHELL': '/bin/bash', 20:06:48 INFO - 'SHLVL': '1', 20:06:48 INFO - 'TERM': 'linux', 20:06:48 INFO - 'TMOUT': '86400', 20:06:48 INFO - 'USER': 'cltbld', 20:06:48 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', 20:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:48 INFO - '_': '/tools/buildbot/bin/python'} 20:06:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:48 INFO - Running setup.py (path:/tmp/pip-qMJ5Ya-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:48 INFO - Running setup.py (path:/tmp/pip-9A96vB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:49 INFO - Running setup.py (path:/tmp/pip-Mn8gRY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:49 INFO - Running setup.py (path:/tmp/pip-30YZbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:49 INFO - Running setup.py (path:/tmp/pip-T7lUyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:49 INFO - Running setup.py (path:/tmp/pip-xltlxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:49 INFO - Running setup.py (path:/tmp/pip-IUV8CD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:49 INFO - Running setup.py (path:/tmp/pip-_ZSOnO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:49 INFO - Running setup.py (path:/tmp/pip-TD5ett-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:49 INFO - Running setup.py (path:/tmp/pip-GsvD4X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:49 INFO - Running setup.py (path:/tmp/pip-akpgCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:49 INFO - Running setup.py (path:/tmp/pip-ugyUuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:49 INFO - Running setup.py (path:/tmp/pip-X86kuM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:49 INFO - Running setup.py (path:/tmp/pip-Fc43Un-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:49 INFO - Running setup.py (path:/tmp/pip-nPcQ_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:49 INFO - Running setup.py (path:/tmp/pip-iHfcy5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:50 INFO - Running setup.py (path:/tmp/pip-Rdcnd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:06:50 INFO - Running setup.py install for manifestparser 20:06:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Running setup.py install for mozcrash 20:06:50 INFO - Running setup.py install for mozdebug 20:06:50 INFO - Running setup.py install for mozdevice 20:06:50 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Running setup.py install for mozfile 20:06:50 INFO - Running setup.py install for mozhttpd 20:06:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Running setup.py install for mozinfo 20:06:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Running setup.py install for mozInstall 20:06:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:06:50 INFO - Running setup.py install for mozleak 20:06:51 INFO - Running setup.py install for mozlog 20:06:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:06:51 INFO - Running setup.py install for moznetwork 20:06:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:06:51 INFO - Running setup.py install for mozprocess 20:06:51 INFO - Running setup.py install for mozprofile 20:06:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:06:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:06:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:06:51 INFO - Running setup.py install for mozrunner 20:06:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:06:51 INFO - Running setup.py install for mozscreenshot 20:06:51 INFO - Running setup.py install for moztest 20:06:51 INFO - Running setup.py install for mozversion 20:06:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:06:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:06:51 INFO - Cleaning up... 20:06:51 INFO - Return code: 0 20:06:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:51 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 0x17b2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a713b0>, '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 0x1a722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a72740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', '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 20:06:51 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 20:06:51 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 20:06:51 INFO - Using env: {'DISPLAY': ':0', 20:06:51 INFO - 'HOME': '/home/cltbld', 20:06:51 INFO - 'LANG': 'en_US.UTF-8', 20:06:51 INFO - 'LANGUAGE': 'en_US:en', 20:06:51 INFO - 'LOGNAME': 'cltbld', 20:06:51 INFO - 'MAIL': '/var/mail/cltbld', 20:06:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:51 INFO - 'MOZ_NO_REMOTE': '1', 20:06:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:51 INFO - 'NO_EM_RESTART': '1', 20:06:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:51 INFO - 'PWD': '/builds/slave/test', 20:06:51 INFO - 'SHELL': '/bin/bash', 20:06:51 INFO - 'SHLVL': '1', 20:06:51 INFO - 'TERM': 'linux', 20:06:51 INFO - 'TMOUT': '86400', 20:06:51 INFO - 'USER': 'cltbld', 20:06:51 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', 20:06:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:51 INFO - '_': '/tools/buildbot/bin/python'} 20:06:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:06:52 INFO - Running setup.py (path:/tmp/pip-VTVaoy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:06:52 INFO - Running setup.py (path:/tmp/pip-dntXbs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:06:52 INFO - Running setup.py (path:/tmp/pip-NupnVq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:06:52 INFO - Running setup.py (path:/tmp/pip-c_9XDA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:06:52 INFO - Running setup.py (path:/tmp/pip-HjXnYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:06:52 INFO - Running setup.py (path:/tmp/pip-50Oq4e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:06:52 INFO - Running setup.py (path:/tmp/pip-3AXyW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:06:52 INFO - Running setup.py (path:/tmp/pip-dYXnj1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:06:52 INFO - Running setup.py (path:/tmp/pip-v7KB8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:06:52 INFO - Running setup.py (path:/tmp/pip-BmMX97-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:06:52 INFO - Running setup.py (path:/tmp/pip-Bja6BF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:06:52 INFO - Running setup.py (path:/tmp/pip-11dpaG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:06:52 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)) 20:06:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:06:52 INFO - Running setup.py (path:/tmp/pip-Ly_pRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:06:53 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)) 20:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:06:53 INFO - Running setup.py (path:/tmp/pip-7iaTWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:06:53 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)) 20:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:53 INFO - Running setup.py (path:/tmp/pip-0XwKv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:06:53 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)) 20:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:06:53 INFO - Running setup.py (path:/tmp/pip-5g3D_2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:06:53 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)) 20:06:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:06:53 INFO - Running setup.py (path:/tmp/pip-pyg3a2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:06:53 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)) 20:06:53 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)) 20:06:53 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)) 20:06:53 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)) 20:06:53 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)) 20:06:53 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)) 20:06:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:06:53 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 20:06:53 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 20:06:53 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 20:06:53 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 20:06:53 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 20:06:53 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 20:06:55 INFO - Downloading blessings-1.6.tar.gz 20:06:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:06:55 INFO - Installing collected packages: blessings 20:06:55 INFO - Running setup.py install for blessings 20:06:55 INFO - Successfully installed blessings 20:06:55 INFO - Cleaning up... 20:06:55 INFO - Return code: 0 20:06:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:06:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:55 INFO - Reading from file tmpfile_stdout 20:06:55 INFO - Current package versions: 20:06:55 INFO - argparse == 1.2.1 20:06:55 INFO - blessings == 1.6 20:06:55 INFO - blobuploader == 1.2.4 20:06:55 INFO - docopt == 0.6.1 20:06:55 INFO - functools32 == 3.2.3-2 20:06:55 INFO - jsonschema == 2.5.1 20:06:55 INFO - manifestparser == 1.1 20:06:55 INFO - mozInstall == 1.12 20:06:55 INFO - mozcrash == 0.17 20:06:55 INFO - mozdebug == 0.1 20:06:55 INFO - mozdevice == 0.48 20:06:55 INFO - mozfile == 1.2 20:06:55 INFO - mozhttpd == 0.7 20:06:55 INFO - mozinfo == 0.9 20:06:55 INFO - mozleak == 0.1 20:06:55 INFO - mozlog == 3.3 20:06:55 INFO - moznetwork == 0.27 20:06:55 INFO - mozprocess == 0.23 20:06:55 INFO - mozprofile == 0.28 20:06:55 INFO - mozrunner == 6.12 20:06:55 INFO - mozscreenshot == 0.1 20:06:55 INFO - mozsystemmonitor == 0.3 20:06:55 INFO - moztest == 0.7 20:06:55 INFO - mozversion == 1.4 20:06:55 INFO - psutil == 3.1.1 20:06:55 INFO - requests == 1.2.3 20:06:55 INFO - wsgiref == 0.1.2 20:06:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:55 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 0x17b2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a713b0>, '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 0x1a722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a72740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', '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 20:06:55 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 20:06:55 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 20:06:55 INFO - Using env: {'DISPLAY': ':0', 20:06:55 INFO - 'HOME': '/home/cltbld', 20:06:55 INFO - 'LANG': 'en_US.UTF-8', 20:06:55 INFO - 'LANGUAGE': 'en_US:en', 20:06:55 INFO - 'LOGNAME': 'cltbld', 20:06:55 INFO - 'MAIL': '/var/mail/cltbld', 20:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:55 INFO - 'MOZ_NO_REMOTE': '1', 20:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:55 INFO - 'NO_EM_RESTART': '1', 20:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:55 INFO - 'PWD': '/builds/slave/test', 20:06:55 INFO - 'SHELL': '/bin/bash', 20:06:55 INFO - 'SHLVL': '1', 20:06:55 INFO - 'TERM': 'linux', 20:06:55 INFO - 'TMOUT': '86400', 20:06:55 INFO - 'USER': 'cltbld', 20:06:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', 20:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:55 INFO - '_': '/tools/buildbot/bin/python'} 20:06:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:55 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)) 20:06:55 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)) 20:06:55 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)) 20:06:55 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)) 20:06:55 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)) 20:06:55 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)) 20:06:55 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)) 20:06:55 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)) 20:06:55 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)) 20:06:55 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)) 20:06:55 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)) 20:06:55 INFO - Cleaning up... 20:06:55 INFO - Return code: 0 20:06:55 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:06: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')]} 20:06:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:06:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06: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')]} 20:06:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:06:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:06:55 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 0x17b2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x19158a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a73180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a713b0>, '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 0x1a722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a72740>, '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': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', '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 20:06:55 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 20:06:55 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 20:06:55 INFO - Using env: {'DISPLAY': ':0', 20:06:55 INFO - 'HOME': '/home/cltbld', 20:06:55 INFO - 'LANG': 'en_US.UTF-8', 20:06:55 INFO - 'LANGUAGE': 'en_US:en', 20:06:55 INFO - 'LOGNAME': 'cltbld', 20:06:55 INFO - 'MAIL': '/var/mail/cltbld', 20:06:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:06:55 INFO - 'MOZ_NO_REMOTE': '1', 20:06:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:06:55 INFO - 'NO_EM_RESTART': '1', 20:06:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:06:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:06:55 INFO - 'PWD': '/builds/slave/test', 20:06:55 INFO - 'SHELL': '/bin/bash', 20:06:55 INFO - 'SHLVL': '1', 20:06:55 INFO - 'TERM': 'linux', 20:06:55 INFO - 'TMOUT': '86400', 20:06:55 INFO - 'USER': 'cltbld', 20:06:55 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', 20:06:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:06:55 INFO - '_': '/tools/buildbot/bin/python'} 20:06:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:06:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:06:56 INFO - Cleaning up... 20:06:56 INFO - Return code: 0 20:06:56 INFO - Running post-action listener: _resource_record_post_action 20:06:56 INFO - Running post-action listener: _start_resource_monitoring 20:06:56 INFO - Starting resource monitoring. 20:06:56 INFO - [mozharness: 2016-08-10 03:06:56.174855Z] Finished create-virtualenv step (success) 20:06:56 INFO - [mozharness: 2016-08-10 03:06:56.175297Z] Running install step. 20:06:56 INFO - Running pre-action listener: _resource_record_pre_action 20:06:56 INFO - Running main action method: install 20:06:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:06:56 INFO - Reading from file tmpfile_stdout 20:06:56 INFO - Detecting whether we're running mozinstall >=1.0... 20:06:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:06:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:06:56 INFO - Reading from file tmpfile_stdout 20:06:56 INFO - Output received: 20:06:56 INFO - Usage: mozinstall [options] installer 20:06:56 INFO - Options: 20:06:56 INFO - -h, --help show this help message and exit 20:06:56 INFO - -d DEST, --destination=DEST 20:06:56 INFO - Directory to install application into. [default: 20:06:56 INFO - "/builds/slave/test"] 20:06:56 INFO - --app=APP Application being installed. [default: firefox] 20:06:56 INFO - mkdir: /builds/slave/test/build/application 20:06:56 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'] 20:06:56 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 20:07:13 INFO - Reading from file tmpfile_stdout 20:07:13 INFO - Output received: 20:07:13 INFO - /builds/slave/test/build/application/firefox/firefox 20:07:13 INFO - Running post-action listener: _resource_record_post_action 20:07:13 INFO - [mozharness: 2016-08-10 03:07:13.340673Z] Finished install step (success) 20:07:13 INFO - [mozharness: 2016-08-10 03:07:13.340923Z] Running run-tests step. 20:07:13 INFO - Running pre-action listener: _resource_record_pre_action 20:07:13 INFO - Running main action method: run_tests 20:07:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:07:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:07:13 INFO - Python 2.7.3 20:07:13 INFO - Return code: 0 20:07:13 INFO - grabbing minidump binary from tooltool 20:07:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:07:13 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a713b0>, '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 0x1a722b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1a72740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:07:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 20:07:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 20:07:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 20:07:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:07:13 INFO - Return code: 0 20:07:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:07:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:07:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:07:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:07:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:07:13 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/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 20:07:13 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/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --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 20:07:13 INFO - Using env: {'DISPLAY': ':0', 20:07:13 INFO - 'HOME': '/home/cltbld', 20:07:13 INFO - 'LANG': 'en_US.UTF-8', 20:07:13 INFO - 'LANGUAGE': 'en_US:en', 20:07:13 INFO - 'LOGNAME': 'cltbld', 20:07:13 INFO - 'MAIL': '/var/mail/cltbld', 20:07:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:07:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:07:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:07:13 INFO - 'MOZ_NO_REMOTE': '1', 20:07:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:07:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:07:13 INFO - 'NO_EM_RESTART': '1', 20:07:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:07:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:07:13 INFO - 'PWD': '/builds/slave/test', 20:07:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:07:13 INFO - 'SHELL': '/bin/bash', 20:07:13 INFO - 'SHLVL': '1', 20:07:13 INFO - 'TERM': 'linux', 20:07:13 INFO - 'TMOUT': '86400', 20:07:13 INFO - 'USER': 'cltbld', 20:07:13 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249', 20:07:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:07:13 INFO - '_': '/tools/buildbot/bin/python'} 20:07:13 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/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--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 20:07:13 INFO - mozversion application_buildid: 20160809173001 20:07:13 INFO - mozversion application_changeset: 13abad48dfb674a240bc019ab7c7305504f1eb93 20:07:13 INFO - mozversion application_display_name: Nightly 20:07:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:07:13 INFO - mozversion application_name: Firefox 20:07:13 INFO - mozversion application_remotingname: firefox 20:07:13 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 20:07:13 INFO - mozversion application_vendor: Mozilla 20:07:13 INFO - mozversion application_version: 51.0a1 20:07:13 INFO - mozversion platform_buildid: 20160809173001 20:07:13 INFO - mozversion platform_changeset: 13abad48dfb674a240bc019ab7c7305504f1eb93 20:07:13 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 20:07:13 INFO - mozversion platform_version: 51.0a1 20:07:13 INFO - using testdate: 1470798433 20:07:13 INFO - actual date: 1470798433 20:07:13 INFO - starting webserver on 'localhost:43014' 20:07:13 INFO - SUITE-START | Running 2 tests 20:07:13 INFO - TEST-START | dromaeo_css 20:07:13 INFO - operating with platform_type : linux_ 20:07:13 INFO - Initialising browser for dromaeo_css test... 20:07:13 INFO - TEST-INFO | started process 29257 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBYT1gS/profile http://localhost:43014/getInfo.html) 20:07:18 INFO - PROCESS | 29257 | __metrics Screen width/height:1600/1200 20:07:18 INFO - PROCESS | 29257 | colorDepth:24 20:07:18 INFO - PROCESS | 29257 | Browser inner width/height: 1024/697 20:07:18 INFO - PROCESS | 29257 | __metrics 20:07:18 ERROR - PROCESS | 29257 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:07:19 INFO - TEST-INFO | 29257: exit 0 20:07:19 INFO - Browser initialized. 20:07:19 INFO - Running cycle 1/1 for dromaeo_css test... 20:07:19 INFO - TEST-INFO | started process 29378 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBYT1gS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:07:31 INFO - PROCESS | 29378 | RSS: Main: 163160064 20:07:31 INFO - PROCESS | 29378 | 20:08:20 INFO - PROCESS | 29378 | 1470798500945 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] 20:10:30 INFO - PROCESS | 29378 | Cycle 1(1): loaded http://localhost:43014/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43014/tests/dromaeo/cssquery-ext.html) 20:10:31 INFO - PROCESS | 29378 | RSS: Main: 165736448 20:10:31 INFO - PROCESS | 29378 | 20:13:33 INFO - PROCESS | 29378 | Cycle 1(1): loaded http://localhost:43014/tests/dromaeo/cssquery-ext.html (next: http://localhost:43014/tests/dromaeo/cssquery-jquery.html) 20:13:34 INFO - PROCESS | 29378 | RSS: Main: 164638720 20:13:34 INFO - PROCESS | 29378 | 20:16:36 INFO - PROCESS | 29378 | Cycle 1(1): loaded http://localhost:43014/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43014/tests/dromaeo/cssquery-mootools.html) 20:16:37 INFO - PROCESS | 29378 | RSS: Main: 168087552 20:16:37 INFO - PROCESS | 29378 | 20:19:38 INFO - PROCESS | 29378 | Cycle 1(1): loaded http://localhost:43014/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43014/tests/dromaeo/cssquery-prototype.html) 20:19:39 INFO - PROCESS | 29378 | RSS: Main: 163127296 20:19:39 INFO - PROCESS | 29378 | 20:22:41 INFO - PROCESS | 29378 | Cycle 1(1): loaded http://localhost:43014/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43014/tests/dromaeo/cssquery-yui.html) 20:22:42 INFO - PROCESS | 29378 | RSS: Main: 165298176 20:22:42 INFO - PROCESS | 29378 | 20:25:45 INFO - PROCESS | 29378 | Cycle 1(1): loaded http://localhost:43014/tests/dromaeo/cssquery-yui.html (next: http://localhost:43014/tests/dromaeo/cssquery-dojo.html) 20:25:46 INFO - PROCESS | 29378 | RSS: Main: 168484864 20:25:46 INFO - PROCESS | 29378 | 20:25:46 INFO - PROCESS | 29378 | __start_tp_report 20:25:46 INFO - PROCESS | 29378 | _x_x_mozilla_page_load 20:25:46 INFO - PROCESS | 29378 | _x_x_mozilla_page_load_details 20:25:46 INFO - PROCESS | 29378 | |i|pagename|runs| 20:25:46 INFO - PROCESS | 29378 | |0;dojo.html;3085.8302793346365;3086.8456577171137;3115.7818952673306;3125.7186853183225;3135.169180167256;5365.919511207335;5377.354717433914;5408.864778380543;5440.727963601819;5470.5623550116;5405.405405405402;5446.074167391543;5469.316335458067;5477.616566840323;5491.450854914507;4816.63875209359;4923.606111511089;4949.381327334083;4985.351904252442;5045.117104506715;4975.4527002029745;4996.050750357421;4996.600271978233;5041.546260836524;5042.218456139304;4787.305840653121;4844.079624871263;4907.2639104134305;4954.133026720309;4980.651354405193;4854.927176092361;4900.191468407708;4907.484714105039;4945.431275403339;4952.504749525055;4837.4920633333695;4865.148598995197;4878.390201224847;4899.338589290436;4923.335349727777;5214.791408343662;5300.363956325227;5352.652077614943;5380.542653874425;5395.406505284415;5685.943140568583;5766.279215098113;5778.59549831512;5790.478856902857;5798.246227990377;5773.134029895507;5777.451142141532;5787.768489260425;5788.305403351583;5824.24284842972;5303.840884773463;5323.787048518094;5368;5392.91910621341;5404.054290499186;5827.184194212814;5905;5911.527077833763;5944.554158438134;5978.521718262528;5662.320521537442;5672.12082127271;5682.6306290091015;5683.062294721325;5693.772249110072;5582.218489411485;5688.9715551422805;5731.996900542472;5759.884802303931;5769.624974376652;5663.037283661705;5697.829065128053;5729.7708091676695;5768.480836724715;5778.162166485836;5699.145128230799;5723.570732195102;5751.367349591542;5777.220075289866;5782.710864456844;4366.345048242725;4396.296592545177;4446.599806017474;4446.666500012448;4496.7301961882395;3916.060145565101;3961.8613348532663;4002.479677641888;4014.698897582693;4017.879463616096;5503.697296648643;5519.558435325164;5542.057850165482;5551.361593416808;5554.0835762099605;5553.8333849984565;5635.887282254332;5825.941740582624;5833.416658334133;5858.062709966385;5472.863178420492;5476.945230547723;5482.150266708666;5574.386817450078;5601.859953501195;4974.801007959641;4983.9252411213865;4993.975030124826;5005.849824505271;5034.043531728959;5738.196652468574;6046.486048685823;6059.818205453844;6065.120557519223;6078.270607527125;5703.315602127771;5717.256756621613;5753.050746626927;5799.3040835100055;5825.650460972355;5992.250968628921;6000.459958603747;6005.249343832021;6008.939910600838;6014.158017877413;5503.724813759376;5649.717514124195;5679.375268720355;5697.173909783141;5708.229389032427;5667.829965101054;5731.455511726379;5743.195952566561;5747.655140691572;5772.018756811268;5628.802991895264;5630.634008789416;5633.8309850704545;5638.520725738194;5723.084306510938;5626.324841019104;5635.098384258499;5640.633358831663;5658.603897727119;5668.603197776116;5420.701861397661;5497.972510137423;5513.779448822002;5539.058360078716;5610.9158362623775;5675.31896172462;5687.60186786921;5690.203371527907;5692.231548740867;5743.052396354555;5495.53287970527;5498.505134537911;5551.195076713934;5551.389347171888;5561.610687251854 20:25:46 INFO - PROCESS | 29378 | |1;ext.html;553.39588265669;588.7438964050635;591.373144466865;605.5004621187519;608.9421504957029;32667.346653066925;35910.2817943641;42183.367249491246;43440;43443.78278108613;46064.76967615157;46450;46502.069958600805;46547;46639.53360466403;8955.686550970717;9048.185663290302;9081.318901082412;9119.817603647924;9130.08699130085;8839.46963182208;8923.509206993613;8930.419522731001;8992.145746154105;8996.145366190201;8947.64209431622;9006.729798106067;9081.046490118542;9087.95456022719;9094.226990705765;8976.057513961037;9019.23336516397;9041.81916361669;9073.183413492818;9073.546322683873;8868.822623547558;8990.955045224797;9041.819163616756;9042.050584688579;9045.231155351803;42708.78645606752;42735;42912.57087429117;43025;43027.78486107581;3565.732570057256;3679.2825399047197;4205.831766729327;4378.1462614790125;4409.096135292258;33169.6683033169;33501.6649833501;33685.83157084199;33716.32567348639;35391.82304088489;4474.977625111854;4494.48299965052;4502.819887204508;4508.909821803545;4715.41057367829;375258;375474;382825;383051;383181;58198.41801582015;59371.70314148488;59513;59601.70199148977;59713.10430343548;61850.69074654598;62729.372706272356;62970.685146573975;62980.37019629837;63076;17317.913410432866;17393.391231307098;17476.563085922953;17556.824431755773;17599.120043997747;13506.527271545448;13572.117812342167;13626.250556219306;13632.454701811816;13635.727285454434;15107.39570417171;16605.50183494497;16649.583760405843;16669.49991500257;16796.832031679525;5946.851328716817;6019.247594050744;6153.969230153821;6162.845928851725;6185;962.9133377996014;1013.8732658417698;1068.6580294305902;1102.448775612194;1119.9384033878214;33446.498302525484;33767;33806.830965845016;33829.955304022755;33853.49219761706;1060.3955745225148;1109.91120710343;1215.8388738754468;1227.4967263421954;1263.8357013588175;16768.161591920354;17123;17232.741508877378;17285.222165002604;17315.826841731672;570067;756827;765669;766520;768115;60718.392816072155;61321.38678613246;61381.38618613846;61521.692391537756;61566.384336156065;1363.8704323089291;1368.7673095573775;1385.3765805387616;1393.7700279453777;1397.0849093843751;32042.839785801854;34002.39649574615;34237;34395;34714.30571388508;51814.740926295126;52118;52204.21693674522;52221;52264;364203;365424;365642;367492;368924;28460.288492787848;28610.85694571514;28866.567001495416;29141.628755686816;29367.706322937353;48633.5136648629;48646.5135348642;49438.258426124354;49916;50981;41797.1640567193;41823;43133.3529997044;43280.78359608182;44408.55591444044;41173;41611;41646.37530436985;42832;43057.784711076245;41464;42255.1548969025;43367.78316108399;43650.12699746051;43694.34458483189;34241.486377703855;37475.43786843145;37795.54328968608;37987.810060949516;38552.614473854905;28540;28607.570886436304;28739;28741.28146796263;29041.128766137048 20:25:46 INFO - PROCESS | 29378 | |2;jquery.html;386.9264839680462;389.28177512489464;407.36451136227487;409.1183499558452;424.310495444902;13864.584062478116;18366.35717749879;18514.72227916579;19960.90019549902;20028.499287517818;19398.806011939876;19611.509712257164;19646;20312;20499.385018449433;5760.164776107473;5928.318243402021;5942.5840191186635;5948.702564871739;5964.731587078571;5768;5959.1359252908305;5959.3146788119275;5962.284525856903;5965.135055416962;5748.223989761392;5834.154047663107;5881.05903055509;5916.467517923407;5936.020556608154;5841.999999999979;5914.5268378530045;5920.171176035358;5941.4355636214705;6006.189164462785;5669.801556945528;5686.232358631614;5704.1443783432405;5758.3665796762325;5774.5091667208335;14683.706325873423;18733.250669973186;18786.530336741554;23896;24122.87938560296;2274.363178310076;2293.6788849561076;2333.7782910623464;2363.6572696959015;2413.227767114524;10610.151187905027;10857.945710271477;11024.283421577571;11884.881151188463;15254.618634534114;1901.8668693191482;1945.7956914524054;1965.3121407507401;1977.4759688682511;1980.7326010988477;86187;86189.84525386852;87962;89756.55121724415;89781.55109224477;11193.888061119447;11200.831987520194;11234.438278086063;11276.252180911972;11426.314421134759;15930.920345398199;16000;16036.919815400848;16090.919545402197;16143.192840357935;8310.418270721113;8420.873686894702;8553.230209281195;8594.87107693385;8656.6537338507;8099.554524501209;8128.39037072222;8250.958745206235;8391.07698153215;8478.406511544255;4821.9035619287415;4862.270659401118;4888.242322440027;4914.65597408178;4923.310736496894;1989.1844343818964;2025.3620109665408;2040.326692191603;2067.338451695473;2104.3266154830612;891.6210610490516;958.3148049144755;1028.7428142964259;1028.9691309260734;1029.7425643589104;20305.390838274874;20460.897695511725;20553.794462055488;20616.175352985712;20722.48193795167;950.5342382232657;989.7525618595351;1002.3234316836252;1028.5268776362807;1032.3805716569998;10757.139428845674;11311.773764524663;11319.773604527863;11335.14986376025;11382.260153090023;402848;547112;548526;553443;558052.9362944555;88104;103527;107083;109346;113327;982.1357205658975;1026.3328836256494;1055.1031623120286;1086.8532748078908;1090.574675876409;17584.38454654081;18259.269629214683;18802.905985469984;18806.247750089842;18889.622207556047;45198;45448.90959813633;45671;45711;46491.76754116208;63548.68225659027;64769.67615161894;66188;66202;67520.3247967514;7734.92265077342;8286.295664868312;8796.91203087961;8817.559122044;9044.773880652772;12828.55100071493;13707.109037912902;13785;13997.930010349883;14163.017177594938;12036.819447708467;12199.329036903055;12280.631581052583;12483.375831208585;12586.433610487733;11659.883401166218;11721.238119522204;11863.940680296544;11903.82144267854;11959.521619135485;12285.078619103782;12370;12448.875511244772;12698;12812.487500499876;8001.679932802623;8081.111077781557;8107.391945603986;8299.170082991652;8529.82940341202;10110;11789.469473873867;11952.64142075739;12077;12174.695632609255 20:25:46 INFO - PROCESS | 29378 | |3;mootools.html;1479.7484427647303;1501.4744839306245;1661.916904154792;1788.1148831328478;1825.7535232743585;7419.777406677795;8450.746477605673;8677.177792663548;9169;9192.494412807302;8937.910620893788;9090.272848158846;9094.408863423889;9101.226395756368;9134.771630709236;2395.556821987929;2445.3519817248443;2445.461998360358;2449.9755002450015;2450.6079027355627;2335.2994101769486;2364.7871691547757;2414.770596793302;2422.8546287222734;2427.538767634144;2447.6940382452194;2462.0890270599903;2470.258922323305;2470.7158676752133;2475.653408522808;2346.9061237550477;2352.1414683640432;2357.6581395697613;2363.822713296501;2378.726446458662;2256.7291924968945;2271.432141964509;2275.8179345652306;2277.920272790461;2295.598270302707;9048.185663290336;9146.405483643543;9148.588313525906;9190.172884440366;9191.218746406563;5439.809606663748;5557.944420555824;5568.248286481314;5571.693556854371;5599.272094627713;3418.4017796885446;3545.627709090534;3593.8742144025096;3659.5242618459697;3675.9081022974374;1167.410457718855;1172.2029020266216;1189.5182451107316;1199.0827017331749;1206.662134602304;12487.562935297221;12683.23900565969;12684.985201183976;12695.428705708266;12756.80864787029;4386.232409328419;4539.114872599877;4648.953510464919;4657.278121891045;4665.836695715701;9876.802463950824;9912.603495860229;9919.900800991898;9941.80116397668;9945.20438364929;5376.247325374451;5381.596380271417;5385.353757549119;5408.945910540844;5417.702026388586;4209.74741515504;4926.088673595396;5004.824831130893;5042.142835717937;5064.873378165576;3804.847806087781;3911.6870650347905;3937.370020796659;4014;4054.1688953764406;1111.8665760108677;1138.021301680554;1155.1855941561348;1161.309021132425;1168.363242033094;786.2923368967975;928.6099838068028;932.305432452827;948.7960088580988;995.2137811129127;6113.969430152821;6119.204503414528;6199.721012554446;6409.839754006094;6448.097266382711;954.8663187153804;970.5729479029204;975.7121649113528;989.1443901025705;1066.7493139112303;4084.6936479764136;4312.37470566766;4428.402165707588;4441.311596702516;4522.1181869535785;11139.721506962229;11298.887011129784;11460.484278207501;11517.827232591519;11543.88456115428;11056.336619802838;11127.387993660264;11237.71905702364;11241.49413276388;11364;7840.725574604976;7848.686052557948;7950.1254861965135;7978.6409611567615;7999.880001799977;5631.943680563142;5843.7370318336625;5872.031114865999;5878.853028674146;5973.313068997121;9359.298052645943;9415.576299066695;9603.423794572349;9604.75988100303;9649.46927918943;9826.017398260117;9858.408495490294;9882.752931176778;9901.108900199017;9901.356411833207;6464.676766161767;7351.154617219088;7468.290512401313;7617.428692847948;7733.188015258317;8975.147361000694;8979.32655050887;8997.325200610112;9057.003729589871;9081.273498120003;7626.771196864103;7660.693572257047;7738.7678369649;7948.16544262844;8231;7750.534967901718;7807.765767026998;7829.099653539915;7893.486923349964;7919.881201781863;7319.8536029280185;7443.4789564729945;7451.850962980601;7459;7476.850462990818;5240.606954478353;5256.684598924076;5266.8946621068135;5323.9467605325;5435.076037073628;5061.898762024665;5115.5396014358885;5133.076046311699;5136.589072874086;5351.224072509386 20:25:46 INFO - PROCESS | 29378 | |4;prototype.html;323.30602121273535;341.5593883889782;342.5769175068791;346.2210027438264;346.88032628743076;5430.402655707869;5532.502074813266;5661.830145095643;5688.914666280009;5698.886022279557;5543.805966791163;5580.665160090397;5582.91625625616;5595.440455954413;5615.971920140404;4390.692651514395;4394.956050439503;4408.2807704995075;4410.404595379615;4414.514403415622;4058.8782336529803;4276.294411422127;4320.848770293041;4400.405945197405;4416.470023597173;4232.661387089025;4267.466566679165;4276.315789473685;4281.100968796556;4289.442372491588;4257.340112282601;4260.806974047272;4263.957360426387;4273.358996150571;4303.956960430387;3567.342329964193;3797.9430308545393;3800.0309920969976;3812.5996770338993;3826.005238637946;5363;5369.5167434931045;5401.918971215435;5405.243265942771;5476.945230547683;4947.406311242638;4956.950430495685;4961.578265847407;4965.205567109281;4971.254311853215;5461.672299662033;5712.171735098387;5757;5777.248957635523;5778.27771528559;4119.814608342632;4123.402106694512;4138.110306284163;4146.983988922703;4170.22850772608;6028.487578555828;6071.817845464643;6073.908891366633;6077.997130473511;6099.45104940553;4165.416841642173;4193.39195816611;4227.619514243733;4284.121755040209;4287.399764033038;4232.78836058202;4243.915121697549;4250.596193361625;4253.532111467736;4271.103068355618;4835.347228124158;4852.805887764521;4894.874178938864;4901.5343542364135;4904.901901961941;5521.309836270466;5815.796447124415;5819.388964158787;5843.211166492469;5854.356020837705;1476.188096546895;1479.2603698150924;1480.674251664632;1484.2652886821093;1492.037635724973;893.7229458867772;946.8863736351544;949.7625593601599;964.8793900762405;970.1608108985677;4858.95141048585;4884.462709101996;4886.462489126193;4891.092473935097;4953.67801092935;5166.535011848951;5201.45384734605;5220.634555581073;5224.660397074178;5227.60792940531;4661.300804879227;4915.606751459874;4991.900161996739;5007.574356179765;5024.949750502521;2768.6816016157995;2781.3880946191807;2800.6359173307746;2806.144126041577;2812.1563530940634;5417.483104730682;5501.449855014546;5525.917111243334;5529.281193444826;5551.8889622207325;5068.381740254162;5198;5349.8765259295205;5357.7589008494715;5457.345118585795;5468.453154684579;5471.753771080311;5484.424135465799;5537.640053396516;5560.77756889728;5258.474152584711;5272.525472707474;5280.7556788365555;5340.465953404629;5355.25026496283;4872.076753947603;5182.222666600041;5242.318498595158;5245.659032162897;5265.919961615217;5456.536194423518;5521.122818241817;5548.889022219614;5557.610967232416;5578.776848925998;4033.233685599727;4074.2055299217554;4145.689073319573;4149.958500415078;4157.875263742093;5965.224520812267;5972.522198224045;5975.521958243417;5985.221921150222;5986.760529578943;5715.257016587817;5803.622764520293;5864.035548091267;5867.325257595431;5883.735231914488;5744.540436765133;5745.224394706661;5759.934412133601;5786.218860453785;5800.781835814526;5759.712014399347;5771.192033115283;5778.537716982547;5786.623869448473;5809.448102430262;5615.809834164597;5784.814113106719;5800.346901133325;5828;5839.854003649943;5630.690312032878;5644.036880637698;5652.943470565407;5676.914846277392;5708.4862362387585 20:25:46 INFO - PROCESS | 29378 | |5;yui.html;747.9528659876173;770.8612449759042;773.6982576795051;811.4644334739072;829.6598394658191;16400.83599164008;17225.22486488108;17268.654626907453;17434.215460304284;17523.123843807807;15689.215539223022;15826.604334891634;15848.920755396206;15859.286332115054;15862.286197121128;669.1368135105707;795.9840803183932;803.3011280186231;813.7518056992615;814.9185081491863;822.8313195794877;822.9547374894379;824.3611201318965;826.7602395305354;830.9584520773967;889.3330002498126;890.3233542507676;890.7060669978891;891.2558014058269;892.4065496444856;874.484054407896;880.4013270975734;882.7616543533242;883.2845395229884;883.5184824270756;648.7502311610017;648.9383508566726;648.9415952564292;649.04590252329;649.136648257816;14978.550643480714;15124.773128403083;15153.848461515354;15158.924205379013;15223.162726050063;14869.628259293497;15192.316345764468;15616.375344986187;15731.528054158394;15923;12907;12924.741505169937;12933.935330323382;13071.54249601269;13666.658333541642;3949.526056873165;3955.8458666164966;4015.7791321477307;4019.437278780973;4045.59544045596;85337.14662853353;86299;87510.562447188;89639.55180224057;89828.55085724595;11992.760144797056;12052.578159764365;12271.754564908651;12336.876631233572;12454.377281136089;23366.415839604146;23530.176443824384;23530.352795316754;23564.882175589013;23630.763692362856;8551.74344769658;8859.734207973772;8866.246369058703;9063.184313411824;9446.433214007182;4762.380890484214;4809.0862736080035;4934.55588996992;4942.258661200849;5048.62135339851;3447.9655203448146;3566.8751593694615;3576.46353047045;3579.534660494119;3580.212353282274;616.1251023546574;630.9274433440121;630.9305976342598;639.7025383196743;649.1852724830402;701.6491754122939;712.0671919785098;714.3570786292379;724.9927500725031;726.9418446524265;9468.526573671288;9694.806103877883;9970.152537034288;9987.850182247126;10001.199904007663;697.6546609428366;705.1784670858392;712.7006657203987;721.8339781850204;723.3887365176417;4959.181735013754;4999.450060493343;5033.748312584356;5062.822801202014;5074.492550744896;71868.64065679639;72918;86382.13617863867;128645;133015;32083.839580801945;105362.47318763357;108112.45943770389;109692;110891;74461.6276918612;77208.61395693097;86770;87955.12044879598;90180;9955.701328960144;10059.74850628711;10219.795604087727;10224.948875255575;10384.42885641297;48410.273845891636;48764;49142.26286605632;49154.75422622864;49887.251691225385;45282.773586133175;45725.77137114293;46339;71620.28379716344;74929.62535187289;13302.135361201492;13407.262600557064;13703.314834258446;13824.792628110385;14189.432422702976;14889.404423822925;15737.213139343216;15738.134402607966;16180;16258.430954916521;14930.402783888523;15086;15360.692786144438;15938.920305398398;15981.28084236189;14088.859111408754;14874.181919994071;14880.255987200813;14966.476173333882;15038.473653422077;14245.928770356082;14902.329395177027;15143.545693629208;15276.388944442542;15448.30482628262;11352.772944540899;11537.769244615229;11541.711457213636;11594.71013224676;11712.824307635563;11560.421978900853;12310.138290319592;12424.627261182179;12610;12642.30467324306 20:25:46 INFO - PROCESS | 29378 | __end_tp_report 20:25:46 INFO - PROCESS | 29378 | __start_cc_report 20:25:46 INFO - PROCESS | 29378 | _x_x_mozilla_cycle_collect,340 20:25:46 INFO - PROCESS | 29378 | __end_cc_report 20:25:46 INFO - PROCESS | 29378 | __startTimestamp1470799546199__endTimestamp 20:25:46 INFO - PROCESS | 29378 | 20:25:46 INFO - PROCESS | 29378 | ------- Summary: start ------- 20:25:46 INFO - PROCESS | 29378 | Number of tests: 6 20:25:46 INFO - PROCESS | 29378 | 20:25:46 INFO - PROCESS | 29378 | [#0] dojo.html Cycles:165 Average:5364.54 Median:5554.08 stddev:602.31 (10.8%) stddev-sans-first:577.02 20:25:46 INFO - PROCESS | 29378 | Values: 3085.8 3086.8 3115.8 3125.7 3135.2 5365.9 5377.4 5408.9 5440.7 5470.6 5405.4 5446.1 5469.3 5477.6 5491.5 4816.6 4923.6 4949.4 4985.4 5045.1 4975.5 4996.1 4996.6 5041.5 5042.2 4787.3 4844.1 4907.3 4954.1 4980.7 4854.9 4900.2 4907.5 4945.4 4952.5 4837.5 4865.1 4878.4 4899.3 4923.3 5214.8 5300.4 5352.7 5380.5 5395.4 5685.9 5766.3 5778.6 5790.5 5798.2 5773.1 5777.5 5787.8 5788.3 5824.2 5303.8 5323.8 5368.0 5392.9 5404.1 5827.2 5905.0 5911.5 5944.6 5978.5 5662.3 5672.1 5682.6 5683.1 5693.8 5582.2 5689.0 5732.0 5759.9 5769.6 5663.0 5697.8 5729.8 5768.5 5778.2 5699.1 5723.6 5751.4 5777.2 5782.7 4366.3 4396.3 4446.6 4446.7 4496.7 3916.1 3961.9 4002.5 4014.7 4017.9 5503.7 5519.6 5542.1 5551.4 5554.1 5553.8 5635.9 5825.9 5833.4 5858.1 5472.9 5476.9 5482.2 5574.4 5601.9 4974.8 4983.9 4994.0 5005.8 5034.0 5738.2 6046.5 6059.8 6065.1 6078.3 5703.3 5717.3 5753.1 5799.3 5825.7 5992.3 6000.5 6005.2 6008.9 6014.2 5503.7 5649.7 5679.4 5697.2 5708.2 5667.8 5731.5 5743.2 5747.7 5772.0 5628.8 5630.6 5633.8 5638.5 5723.1 5626.3 5635.1 5640.6 5658.6 5668.6 5420.7 5498.0 5513.8 5539.1 5610.9 5675.3 5687.6 5690.2 5692.2 5743.1 5495.5 5498.5 5551.2 5551.4 5561.6 20:25:46 INFO - PROCESS | 29378 | 20:25:46 INFO - PROCESS | 29378 | [#1] ext.html Cycles:180 Average:64951.60 Median:42968.79 stddev:139277.23 (324.1%) stddev-sans-first:139584.01 20:25:46 INFO - PROCESS | 29378 | Values: 553.4 588.7 591.4 605.5 608.9 32667.3 35910.3 42183.4 43440.0 43443.8 46064.8 46450.0 46502.1 46547.0 46639.5 8955.7 9048.2 9081.3 9119.8 9130.1 8839.5 8923.5 8930.4 8992.1 8996.1 8947.6 9006.7 9081.0 9088.0 9094.2 8976.1 9019.2 9041.8 9073.2 9073.5 8868.8 8991.0 9041.8 9042.1 9045.2 42708.8 42735.0 42912.6 43025.0 43027.8 3565.7 3679.3 4205.8 4378.1 4409.1 33169.7 33501.7 33685.8 33716.3 35391.8 4475.0 4494.5 4502.8 4508.9 4715.4 375258.0 375474.0 382825.0 383051.0 383181.0 58198.4 59371.7 59513.0 59601.7 59713.1 61850.7 62729.4 62970.7 62980.4 63076.0 17317.9 17393.4 17476.6 17556.8 17599.1 13506.5 13572.1 13626.3 13632.5 13635.7 15107.4 16605.5 16649.6 16669.5 16796.8 5946.9 6019.2 6154.0 6162.8 6185.0 962.9 1013.9 1068.7 1102.4 1119.9 33446.5 33767.0 33806.8 33830.0 33853.5 1060.4 1109.9 1215.8 1227.5 1263.8 16768.2 17123.0 17232.7 17285.2 17315.8 570067.0 756827.0 765669.0 766520.0 768115.0 60718.4 61321.4 61381.4 61521.7 61566.4 1363.9 1368.8 1385.4 1393.8 1397.1 32042.8 34002.4 34237.0 34395.0 34714.3 51814.7 52118.0 52204.2 52221.0 52264.0 364203.0 365424.0 365642.0 367492.0 368924.0 28460.3 28610.9 28866.6 29141.6 29367.7 48633.5 48646.5 49438.3 49916.0 50981.0 41797.2 41823.0 43133.4 43280.8 44408.6 41173.0 41611.0 41646.4 42832.0 43057.8 41464.0 42255.2 43367.8 43650.1 43694.3 34241.5 37475.4 37795.5 37987.8 38552.6 28540.0 28607.6 28739.0 28741.3 29041.1 20:25:46 INFO - PROCESS | 29378 | 20:25:46 INFO - PROCESS | 29378 | [#2] jquery.html Cycles:180 Average:30906.39 Median:11413.40 stddev:86936.94 (761.7%) stddev-sans-first:87150.62 20:25:46 INFO - PROCESS | 29378 | Values: 386.9 389.3 407.4 409.1 424.3 13864.6 18366.4 18514.7 19960.9 20028.5 19398.8 19611.5 19646.0 20312.0 20499.4 5760.2 5928.3 5942.6 5948.7 5964.7 5768.0 5959.1 5959.3 5962.3 5965.1 5748.2 5834.2 5881.1 5916.5 5936.0 5842.0 5914.5 5920.2 5941.4 6006.2 5669.8 5686.2 5704.1 5758.4 5774.5 14683.7 18733.3 18786.5 23896.0 24122.9 2274.4 2293.7 2333.8 2363.7 2413.2 10610.2 10857.9 11024.3 11884.9 15254.6 1901.9 1945.8 1965.3 1977.5 1980.7 86187.0 86189.8 87962.0 89756.6 89781.6 11193.9 11200.8 11234.4 11276.3 11426.3 15930.9 16000.0 16036.9 16090.9 16143.2 8310.4 8420.9 8553.2 8594.9 8656.7 8099.6 8128.4 8251.0 8391.1 8478.4 4821.9 4862.3 4888.2 4914.7 4923.3 1989.2 2025.4 2040.3 2067.3 2104.3 891.6 958.3 1028.7 1029.0 1029.7 20305.4 20460.9 20553.8 20616.2 20722.5 950.5 989.8 1002.3 1028.5 1032.4 10757.1 11311.8 11319.8 11335.1 11382.3 402848.0 547112.0 548526.0 553443.0 558052.9 88104.0 103527.0 107083.0 109346.0 113327.0 982.1 1026.3 1055.1 1086.9 1090.6 17584.4 18259.3 18802.9 18806.2 18889.6 45198.0 45448.9 45671.0 45711.0 46491.8 63548.7 64769.7 66188.0 66202.0 67520.3 7734.9 8286.3 8796.9 8817.6 9044.8 12828.6 13707.1 13785.0 13997.9 14163.0 12036.8 12199.3 12280.6 12483.4 12586.4 11659.9 11721.2 11863.9 11903.8 11959.5 12285.1 12370.0 12448.9 12698.0 12812.5 8001.7 8081.1 8107.4 8299.2 8529.8 10110.0 11789.5 11952.6 12077.0 12174.7 20:25:46 INFO - PROCESS | 29378 | 20:25:46 INFO - PROCESS | 29378 | [#3] mootools.html Cycles:180 Average:5872.14 Median:5378.92 stddev:3313.13 (61.6%) stddev-sans-first:3305.98 20:25:46 INFO - PROCESS | 29378 | Values: 1479.7 1501.5 1661.9 1788.1 1825.8 7419.8 8450.7 8677.2 9169.0 9192.5 8937.9 9090.3 9094.4 9101.2 9134.8 2395.6 2445.4 2445.5 2450.0 2450.6 2335.3 2364.8 2414.8 2422.9 2427.5 2447.7 2462.1 2470.3 2470.7 2475.7 2346.9 2352.1 2357.7 2363.8 2378.7 2256.7 2271.4 2275.8 2277.9 2295.6 9048.2 9146.4 9148.6 9190.2 9191.2 5439.8 5557.9 5568.2 5571.7 5599.3 3418.4 3545.6 3593.9 3659.5 3675.9 1167.4 1172.2 1189.5 1199.1 1206.7 12487.6 12683.2 12685.0 12695.4 12756.8 4386.2 4539.1 4649.0 4657.3 4665.8 9876.8 9912.6 9919.9 9941.8 9945.2 5376.2 5381.6 5385.4 5408.9 5417.7 4209.7 4926.1 5004.8 5042.1 5064.9 3804.8 3911.7 3937.4 4014.0 4054.2 1111.9 1138.0 1155.2 1161.3 1168.4 786.3 928.6 932.3 948.8 995.2 6114.0 6119.2 6199.7 6409.8 6448.1 954.9 970.6 975.7 989.1 1066.7 4084.7 4312.4 4428.4 4441.3 4522.1 11139.7 11298.9 11460.5 11517.8 11543.9 11056.3 11127.4 11237.7 11241.5 11364.0 7840.7 7848.7 7950.1 7978.6 7999.9 5631.9 5843.7 5872.0 5878.9 5973.3 9359.3 9415.6 9603.4 9604.8 9649.5 9826.0 9858.4 9882.8 9901.1 9901.4 6464.7 7351.2 7468.3 7617.4 7733.2 8975.1 8979.3 8997.3 9057.0 9081.3 7626.8 7660.7 7738.8 7948.2 8231.0 7750.5 7807.8 7829.1 7893.5 7919.9 7319.9 7443.5 7451.9 7459.0 7476.9 5240.6 5256.7 5266.9 5323.9 5435.1 5061.9 5115.5 5133.1 5136.6 5351.2 20:25:46 INFO - PROCESS | 29378 | 20:25:46 INFO - PROCESS | 29378 | [#4] prototype.html Cycles:180 Average:4704.61 Median:5252.07 stddev:1363.77 (26.0%) stddev-sans-first:1327.36 20:25:46 INFO - PROCESS | 29378 | Values: 323.3 341.6 342.6 346.2 346.9 5430.4 5532.5 5661.8 5688.9 5698.9 5543.8 5580.7 5582.9 5595.4 5616.0 4390.7 4395.0 4408.3 4410.4 4414.5 4058.9 4276.3 4320.8 4400.4 4416.5 4232.7 4267.5 4276.3 4281.1 4289.4 4257.3 4260.8 4264.0 4273.4 4304.0 3567.3 3797.9 3800.0 3812.6 3826.0 5363.0 5369.5 5401.9 5405.2 5476.9 4947.4 4957.0 4961.6 4965.2 4971.3 5461.7 5712.2 5757.0 5777.2 5778.3 4119.8 4123.4 4138.1 4147.0 4170.2 6028.5 6071.8 6073.9 6078.0 6099.5 4165.4 4193.4 4227.6 4284.1 4287.4 4232.8 4243.9 4250.6 4253.5 4271.1 4835.3 4852.8 4894.9 4901.5 4904.9 5521.3 5815.8 5819.4 5843.2 5854.4 1476.2 1479.3 1480.7 1484.3 1492.0 893.7 946.9 949.8 964.9 970.2 4859.0 4884.5 4886.5 4891.1 4953.7 5166.5 5201.5 5220.6 5224.7 5227.6 4661.3 4915.6 4991.9 5007.6 5024.9 2768.7 2781.4 2800.6 2806.1 2812.2 5417.5 5501.4 5525.9 5529.3 5551.9 5068.4 5198.0 5349.9 5357.8 5457.3 5468.5 5471.8 5484.4 5537.6 5560.8 5258.5 5272.5 5280.8 5340.5 5355.3 4872.1 5182.2 5242.3 5245.7 5265.9 5456.5 5521.1 5548.9 5557.6 5578.8 4033.2 4074.2 4145.7 4150.0 4157.9 5965.2 5972.5 5975.5 5985.2 5986.8 5715.3 5803.6 5864.0 5867.3 5883.7 5744.5 5745.2 5759.9 5786.2 5800.8 5759.7 5771.2 5778.5 5786.6 5809.4 5615.8 5784.8 5800.3 5828.0 5839.9 5630.7 5644.0 5652.9 5676.9 5708.5 20:25:46 INFO - PROCESS | 29378 | 20:25:46 INFO - PROCESS | 29378 | [#5] yui.html Cycles:180 Average:20359.61 Median:4032.52 stddev:28605.18 (709.4%) stddev-sans-first:28647.52 20:25:46 INFO - PROCESS | 29378 | Values: 748.0 770.9 773.7 811.5 829.7 16400.8 17225.2 17268.7 17434.2 17523.1 15689.2 15826.6 15848.9 15859.3 15862.3 669.1 796.0 803.3 813.8 814.9 822.8 823.0 824.4 826.8 831.0 889.3 890.3 890.7 891.3 892.4 874.5 880.4 882.8 883.3 883.5 648.8 648.9 648.9 649.0 649.1 14978.6 15124.8 15153.8 15158.9 15223.2 14869.6 15192.3 15616.4 15731.5 15923.0 12907.0 12924.7 12933.9 13071.5 13666.7 3949.5 3955.8 4015.8 4019.4 4045.6 85337.1 86299.0 87510.6 89639.6 89828.6 11992.8 12052.6 12271.8 12336.9 12454.4 23366.4 23530.2 23530.4 23564.9 23630.8 8551.7 8859.7 8866.2 9063.2 9446.4 4762.4 4809.1 4934.6 4942.3 5048.6 3448.0 3566.9 3576.5 3579.5 3580.2 616.1 630.9 630.9 639.7 649.2 701.6 712.1 714.4 725.0 726.9 9468.5 9694.8 9970.2 9987.9 10001.2 697.7 705.2 712.7 721.8 723.4 4959.2 4999.5 5033.7 5062.8 5074.5 71868.6 72918.0 86382.1 128645.0 133015.0 32083.8 105362.5 108112.5 109692.0 110891.0 74461.6 77208.6 86770.0 87955.1 90180.0 9955.7 10059.7 10219.8 10224.9 10384.4 48410.3 48764.0 49142.3 49154.8 49887.3 45282.8 45725.8 46339.0 71620.3 74929.6 13302.1 13407.3 13703.3 13824.8 14189.4 14889.4 15737.2 15738.1 16180.0 16258.4 14930.4 15086.0 15360.7 15938.9 15981.3 14088.9 14874.2 14880.3 14966.5 15038.5 14245.9 14902.3 15143.5 15276.4 15448.3 11352.8 11537.8 11541.7 11594.7 11712.8 11560.4 12310.1 12424.6 12610.0 12642.3 20:25:46 INFO - PROCESS | 29378 | -------- Summary: end -------- 20:25:46 INFO - PROCESS | 29378 | 20:25:46 INFO - TEST-INFO | 29378: exit 0 20:25:46 INFO - TEST-OK | dromaeo_css | took 1113305ms 20:25:46 INFO - TEST-START | kraken 20:25:46 INFO - operating with platform_type : linux_ 20:25:46 INFO - Initialising browser for kraken test... 20:25:46 INFO - TEST-INFO | started process 29630 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgBllPm/profile http://localhost:43014/getInfo.html) 20:25:51 INFO - PROCESS | 29630 | __metrics Screen width/height:1600/1200 20:25:51 INFO - PROCESS | 29630 | colorDepth:24 20:25:51 INFO - PROCESS | 29630 | Browser inner width/height: 1024/697 20:25:51 INFO - PROCESS | 29630 | __metrics 20:25:52 ERROR - PROCESS | 29630 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 20:25:52 INFO - TEST-INFO | 29630: exit 0 20:25:52 INFO - Browser initialized. 20:25:52 INFO - Running cycle 1/1 for kraken test... 20:25:52 INFO - TEST-INFO | started process 29751 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgBllPm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:26:04 INFO - PROCESS | 29751 | RSS: Main: 163082240 20:26:04 INFO - PROCESS | 29751 | 20:26:07 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43014/tests/kraken/driver.html?testName=audio-beat-detection) 20:26:08 INFO - PROCESS | 29751 | RSS: Main: 168251392 20:26:08 INFO - PROCESS | 29751 | 20:26:10 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43014/tests/kraken/driver.html?testName=audio-dft) 20:26:11 INFO - PROCESS | 29751 | RSS: Main: 167165952 20:26:11 INFO - PROCESS | 29751 | 20:26:14 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43014/tests/kraken/driver.html?testName=audio-fft) 20:26:14 INFO - PROCESS | 29751 | RSS: Main: 163426304 20:26:14 INFO - PROCESS | 29751 | 20:26:17 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43014/tests/kraken/driver.html?testName=audio-oscillator) 20:26:17 INFO - PROCESS | 29751 | RSS: Main: 164270080 20:26:17 INFO - PROCESS | 29751 | 20:26:19 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43014/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:26:20 INFO - PROCESS | 29751 | RSS: Main: 164868096 20:26:20 INFO - PROCESS | 29751 | 20:26:23 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43014/tests/kraken/driver.html?testName=imaging-darkroom) 20:26:24 INFO - PROCESS | 29751 | RSS: Main: 164859904 20:26:24 INFO - PROCESS | 29751 | 20:26:27 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43014/tests/kraken/driver.html?testName=imaging-desaturate) 20:26:28 INFO - PROCESS | 29751 | RSS: Main: 162611200 20:26:28 INFO - PROCESS | 29751 | 20:26:31 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43014/tests/kraken/driver.html?testName=json-parse-financial) 20:26:31 INFO - PROCESS | 29751 | RSS: Main: 164139008 20:26:31 INFO - PROCESS | 29751 | 20:26:33 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43014/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:26:34 INFO - PROCESS | 29751 | RSS: Main: 163852288 20:26:34 INFO - PROCESS | 29751 | 20:26:35 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43014/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:26:36 INFO - PROCESS | 29751 | RSS: Main: 164425728 20:26:36 INFO - PROCESS | 29751 | 20:26:38 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43014/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:26:39 INFO - PROCESS | 29751 | RSS: Main: 165146624 20:26:39 INFO - PROCESS | 29751 | 20:26:41 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:26:42 INFO - PROCESS | 29751 | RSS: Main: 164958208 20:26:42 INFO - PROCESS | 29751 | 20:26:45 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:26:45 INFO - PROCESS | 29751 | RSS: Main: 165429248 20:26:45 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | Cycle 1(1): loaded http://localhost:43014/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43014/tests/kraken/driver.html?testName=ai-astar) 20:26:47 INFO - PROCESS | 29751 | RSS: Main: 165957632 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | __start_tp_report 20:26:47 INFO - PROCESS | 29751 | _x_x_mozilla_page_load 20:26:47 INFO - PROCESS | 29751 | _x_x_mozilla_page_load_details 20:26:47 INFO - PROCESS | 29751 | |i|pagename|runs| 20:26:47 INFO - PROCESS | 29751 | |0;ai-astar;103;113;109;111;113;113;113;113;114;115 20:26:47 INFO - PROCESS | 29751 | |1;audio-beat-detection;148;124;149;178;120;150;155;122;176;122 20:26:47 INFO - PROCESS | 29751 | |2;audio-dft;162;164;161;162;164;172;166;161;162;162 20:26:47 INFO - PROCESS | 29751 | |3;audio-fft;76;74;76;192;76;77;75;76;189;75 20:26:47 INFO - PROCESS | 29751 | |4;audio-oscillator;85;85;154;84;85;85;139;86;86;147 20:26:47 INFO - PROCESS | 29751 | |5;imaging-gaussian-blur;118;117;117;124;117;118;118;119;119;119 20:26:47 INFO - PROCESS | 29751 | |6;imaging-darkroom;147;147;148;148;147;147;147;147;147;147 20:26:47 INFO - PROCESS | 29751 | |7;imaging-desaturate;96;95;96;95;96;96;95;100;95;96 20:26:47 INFO - PROCESS | 29751 | |8;json-parse-financial;51;53;53;51;52;52;52;51;53;53 20:26:47 INFO - PROCESS | 29751 | |9;json-stringify-tinderbox;61;63;61;61;64;62;62;61;62;62 20:26:47 INFO - PROCESS | 29751 | |10;stanford-crypto-aes;77;76;82;80;77;77;78;77;81;77 20:26:47 INFO - PROCESS | 29751 | |11;stanford-crypto-ccm;123;126;132;125;129;131;129;142;140;123 20:26:47 INFO - PROCESS | 29751 | |12;stanford-crypto-pbkdf2;166;164;164;163;167;171;163;162;162;158 20:26:47 INFO - PROCESS | 29751 | |13;stanford-crypto-sha256-iterative;67;66;67;71;63;63;64;63;64;62 20:26:47 INFO - PROCESS | 29751 | __end_tp_report 20:26:47 INFO - PROCESS | 29751 | __start_cc_report 20:26:47 INFO - PROCESS | 29751 | _x_x_mozilla_cycle_collect,856 20:26:47 INFO - PROCESS | 29751 | __end_cc_report 20:26:47 INFO - PROCESS | 29751 | __startTimestamp1470799607848__endTimestamp 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | ------- Summary: start ------- 20:26:47 INFO - PROCESS | 29751 | Number of tests: 14 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#0] ai-astar Cycles:10 Average:111.70 Median:113.00 stddev:3.47 (3.1%) stddev-sans-first:1.73 20:26:47 INFO - PROCESS | 29751 | Values: 103.0 113.0 109.0 111.0 113.0 113.0 113.0 113.0 114.0 115.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#1] audio-beat-detection Cycles:10 Average:144.40 Median:149.50 stddev:21.91 (14.7%) stddev-sans-first:23.20 20:26:47 INFO - PROCESS | 29751 | Values: 148.0 124.0 149.0 178.0 120.0 150.0 155.0 122.0 176.0 122.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#2] audio-dft Cycles:10 Average:163.60 Median:163.00 stddev:3.34 (2.0%) stddev-sans-first:3.49 20:26:47 INFO - PROCESS | 29751 | Values: 162.0 164.0 161.0 162.0 164.0 172.0 166.0 161.0 162.0 162.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#3] audio-fft Cycles:10 Average:98.60 Median:76.00 stddev:48.45 (63.7%) stddev-sans-first:50.69 20:26:47 INFO - PROCESS | 29751 | Values: 76.0 74.0 76.0 192.0 76.0 77.0 75.0 76.0 189.0 75.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:85.00 stddev:29.93 (35.2%) stddev-sans-first:30.98 20:26:47 INFO - PROCESS | 29751 | Values: 85.0 85.0 154.0 84.0 85.0 85.0 139.0 86.0 86.0 147.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#5] imaging-gaussian-blur Cycles:10 Average:118.60 Median:118.50 stddev:2.07 (1.7%) stddev-sans-first:2.18 20:26:47 INFO - PROCESS | 29751 | Values: 118.0 117.0 117.0 124.0 117.0 118.0 118.0 119.0 119.0 119.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 20:26:47 INFO - PROCESS | 29751 | Values: 147.0 147.0 148.0 148.0 147.0 147.0 147.0 147.0 147.0 147.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.49 (1.6%) stddev-sans-first:1.58 20:26:47 INFO - PROCESS | 29751 | Values: 96.0 95.0 96.0 95.0 96.0 96.0 95.0 100.0 95.0 96.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#8] json-parse-financial Cycles:10 Average:52.10 Median:52.50 stddev:0.88 (1.7%) stddev-sans-first:0.83 20:26:47 INFO - PROCESS | 29751 | Values: 51.0 53.0 53.0 51.0 52.0 52.0 52.0 51.0 53.0 53.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#9] json-stringify-tinderbox Cycles:10 Average:61.90 Median:62.00 stddev:0.99 (1.6%) stddev-sans-first:1.00 20:26:47 INFO - PROCESS | 29751 | Values: 61.0 63.0 61.0 61.0 64.0 62.0 62.0 61.0 62.0 62.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#10] stanford-crypto-aes Cycles:10 Average:78.20 Median:77.50 stddev:2.04 (2.6%) stddev-sans-first:2.12 20:26:47 INFO - PROCESS | 29751 | Values: 77.0 76.0 82.0 80.0 77.0 77.0 78.0 77.0 81.0 77.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#11] stanford-crypto-ccm Cycles:10 Average:130.00 Median:130.00 stddev:6.58 (5.1%) stddev-sans-first:6.48 20:26:47 INFO - PROCESS | 29751 | Values: 123.0 126.0 132.0 125.0 129.0 131.0 129.0 142.0 140.0 123.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.00 Median:164.00 stddev:3.46 (2.1%) stddev-sans-first:3.60 20:26:47 INFO - PROCESS | 29751 | Values: 166.0 164.0 164.0 163.0 167.0 171.0 163.0 162.0 162.0 158.0 20:26:47 INFO - PROCESS | 29751 | 20:26:47 INFO - PROCESS | 29751 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:2.75 (4.2%) stddev-sans-first:2.82 20:26:47 INFO - PROCESS | 29751 | Values: 67.0 66.0 67.0 71.0 63.0 63.0 64.0 63.0 64.0 62.0 20:26:47 INFO - PROCESS | 29751 | -------- Summary: end -------- 20:26:47 INFO - PROCESS | 29751 | 20:26:48 INFO - TEST-INFO | 29751: exit 0 20:26:48 INFO - TEST-OK | kraken | took 61916ms 20:26:48 INFO - SUITE-END | took 1175s 20:26:49 INFO - Completed test suite (00:19:35) 20:26:49 INFO - javascript benchmark 20:26:49 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7396.373031199111, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3085.8302793346365, 3086.8456577171137, 3115.7818952673306, 3125.7186853183225, 3135.169180167256, 5365.919511207335, 5377.354717433914, 5408.864778380543, 5440.727963601819, 5470.5623550116, 5405.405405405402, 5446.074167391543, 5469.316335458067, 5477.616566840323, 5491.450854914507, 4816.63875209359, 4923.606111511089, 4949.381327334083, 4985.351904252442, 5045.117104506715, 4975.4527002029745, 4996.050750357421, 4996.600271978233, 5041.546260836524, 5042.218456139304, 4787.305840653121, 4844.079624871263, 4907.2639104134305, 4954.133026720309, 4980.651354405193, 4854.927176092361, 4900.191468407708, 4907.484714105039, 4945.431275403339, 4952.504749525055, 4837.4920633333695, 4865.148598995197, 4878.390201224847, 4899.338589290436, 4923.335349727777, 5214.791408343662, 5300.363956325227, 5352.652077614943, 5380.542653874425, 5395.406505284415, 5685.943140568583, 5766.279215098113, 5778.59549831512, 5790.478856902857, 5798.246227990377, 5773.134029895507, 5777.451142141532, 5787.768489260425, 5788.305403351583, 5824.24284842972, 5303.840884773463, 5323.787048518094, 5368.0, 5392.91910621341, 5404.054290499186, 5827.184194212814, 5905.0, 5911.527077833763, 5944.554158438134, 5978.521718262528, 5662.320521537442, 5672.12082127271, 5682.6306290091015, 5683.062294721325, 5693.772249110072, 5582.218489411485, 5688.9715551422805, 5731.996900542472, 5759.884802303931, 5769.624974376652, 5663.037283661705, 5697.829065128053, 5729.7708091676695, 5768.480836724715, 5778.162166485836, 5699.145128230799, 5723.570732195102, 5751.367349591542, 5777.220075289866, 5782.710864456844, 4366.345048242725, 4396.296592545177, 4446.599806017474, 4446.666500012448, 4496.7301961882395, 3916.060145565101, 3961.8613348532663, 4002.479677641888, 4014.698897582693, 4017.879463616096, 5503.697296648643, 5519.558435325164, 5542.057850165482, 5551.361593416808, 5554.0835762099605, 5553.8333849984565, 5635.887282254332, 5825.941740582624, 5833.416658334133, 5858.062709966385, 5472.863178420492, 5476.945230547723, 5482.150266708666, 5574.386817450078, 5601.859953501195, 4974.801007959641, 4983.9252411213865, 4993.975030124826, 5005.849824505271, 5034.043531728959, 5738.196652468574, 6046.486048685823, 6059.818205453844, 6065.120557519223, 6078.270607527125, 5703.315602127771, 5717.256756621613, 5753.050746626927, 5799.3040835100055, 5825.650460972355, 5992.250968628921, 6000.459958603747, 6005.249343832021, 6008.939910600838, 6014.158017877413, 5503.724813759376, 5649.717514124195, 5679.375268720355, 5697.173909783141, 5708.229389032427, 5667.829965101054, 5731.455511726379, 5743.195952566561, 5747.655140691572, 5772.018756811268, 5628.802991895264, 5630.634008789416, 5633.8309850704545, 5638.520725738194, 5723.084306510938, 5626.324841019104, 5635.098384258499, 5640.633358831663, 5658.603897727119, 5668.603197776116, 5420.701861397661, 5497.972510137423, 5513.779448822002, 5539.058360078716, 5610.9158362623775, 5675.31896172462, 5687.60186786921, 5690.203371527907, 5692.231548740867, 5743.052396354555, 5495.53287970527, 5498.505134537911, 5551.195076713934, 5551.389347171888, 5561.610687251854], "value": 5324.157481177131, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.39588265669, 588.7438964050635, 591.373144466865, 605.5004621187519, 608.9421504957029, 32667.346653066925, 35910.2817943641, 42183.367249491246, 43440.0, 43443.78278108613, 46064.76967615157, 46450.0, 46502.069958600805, 46547.0, 46639.53360466403, 8955.686550970717, 9048.185663290302, 9081.318901082412, 9119.817603647924, 9130.08699130085, 8839.46963182208, 8923.509206993613, 8930.419522731001, 8992.145746154105, 8996.145366190201, 8947.64209431622, 9006.729798106067, 9081.046490118542, 9087.95456022719, 9094.226990705765, 8976.057513961037, 9019.23336516397, 9041.81916361669, 9073.183413492818, 9073.546322683873, 8868.822623547558, 8990.955045224797, 9041.819163616756, 9042.050584688579, 9045.231155351803, 42708.78645606752, 42735.0, 42912.57087429117, 43025.0, 43027.78486107581, 3565.732570057256, 3679.2825399047197, 4205.831766729327, 4378.1462614790125, 4409.096135292258, 33169.6683033169, 33501.6649833501, 33685.83157084199, 33716.32567348639, 35391.82304088489, 4474.977625111854, 4494.48299965052, 4502.819887204508, 4508.909821803545, 4715.41057367829, 375258.0, 375474.0, 382825.0, 383051.0, 383181.0, 58198.41801582015, 59371.70314148488, 59513.0, 59601.70199148977, 59713.10430343548, 61850.69074654598, 62729.372706272356, 62970.685146573975, 62980.37019629837, 63076.0, 17317.913410432866, 17393.391231307098, 17476.563085922953, 17556.824431755773, 17599.120043997747, 13506.527271545448, 13572.117812342167, 13626.250556219306, 13632.454701811816, 13635.727285454434, 15107.39570417171, 16605.50183494497, 16649.583760405843, 16669.49991500257, 16796.832031679525, 5946.851328716817, 6019.247594050744, 6153.969230153821, 6162.845928851725, 6185.0, 962.9133377996014, 1013.8732658417698, 1068.6580294305902, 1102.448775612194, 1119.9384033878214, 33446.498302525484, 33767.0, 33806.830965845016, 33829.955304022755, 33853.49219761706, 1060.3955745225148, 1109.91120710343, 1215.8388738754468, 1227.4967263421954, 1263.8357013588175, 16768.161591920354, 17123.0, 17232.741508877378, 17285.222165002604, 17315.826841731672, 570067.0, 756827.0, 765669.0, 766520.0, 768115.0, 60718.392816072155, 61321.38678613246, 61381.38618613846, 61521.692391537756, 61566.384336156065, 1363.8704323089291, 1368.7673095573775, 1385.3765805387616, 1393.7700279453777, 1397.0849093843751, 32042.839785801854, 34002.39649574615, 34237.0, 34395.0, 34714.30571388508, 51814.740926295126, 52118.0, 52204.21693674522, 52221.0, 52264.0, 364203.0, 365424.0, 365642.0, 367492.0, 368924.0, 28460.288492787848, 28610.85694571514, 28866.567001495416, 29141.628755686816, 29367.706322937353, 48633.5136648629, 48646.5135348642, 49438.258426124354, 49916.0, 50981.0, 41797.1640567193, 41823.0, 43133.3529997044, 43280.78359608182, 44408.55591444044, 41173.0, 41611.0, 41646.37530436985, 42832.0, 43057.784711076245, 41464.0, 42255.1548969025, 43367.78316108399, 43650.12699746051, 43694.34458483189, 34241.486377703855, 37475.43786843145, 37795.54328968608, 37987.810060949516, 38552.614473854905, 28540.0, 28607.570886436304, 28739.0, 28741.28146796263, 29041.128766137048], "value": 20588.025102545314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.9264839680462, 389.28177512489464, 407.36451136227487, 409.1183499558452, 424.310495444902, 13864.584062478116, 18366.35717749879, 18514.72227916579, 19960.90019549902, 20028.499287517818, 19398.806011939876, 19611.509712257164, 19646.0, 20312.0, 20499.385018449433, 5760.164776107473, 5928.318243402021, 5942.5840191186635, 5948.702564871739, 5964.731587078571, 5768.0, 5959.1359252908305, 5959.3146788119275, 5962.284525856903, 5965.135055416962, 5748.223989761392, 5834.154047663107, 5881.05903055509, 5916.467517923407, 5936.020556608154, 5841.999999999979, 5914.5268378530045, 5920.171176035358, 5941.4355636214705, 6006.189164462785, 5669.801556945528, 5686.232358631614, 5704.1443783432405, 5758.3665796762325, 5774.5091667208335, 14683.706325873423, 18733.250669973186, 18786.530336741554, 23896.0, 24122.87938560296, 2274.363178310076, 2293.6788849561076, 2333.7782910623464, 2363.6572696959015, 2413.227767114524, 10610.151187905027, 10857.945710271477, 11024.283421577571, 11884.881151188463, 15254.618634534114, 1901.8668693191482, 1945.7956914524054, 1965.3121407507401, 1977.4759688682511, 1980.7326010988477, 86187.0, 86189.84525386852, 87962.0, 89756.55121724415, 89781.55109224477, 11193.888061119447, 11200.831987520194, 11234.438278086063, 11276.252180911972, 11426.314421134759, 15930.920345398199, 16000.0, 16036.919815400848, 16090.919545402197, 16143.192840357935, 8310.418270721113, 8420.873686894702, 8553.230209281195, 8594.87107693385, 8656.6537338507, 8099.554524501209, 8128.39037072222, 8250.958745206235, 8391.07698153215, 8478.406511544255, 4821.9035619287415, 4862.270659401118, 4888.242322440027, 4914.65597408178, 4923.310736496894, 1989.1844343818964, 2025.3620109665408, 2040.326692191603, 2067.338451695473, 2104.3266154830612, 891.6210610490516, 958.3148049144755, 1028.7428142964259, 1028.9691309260734, 1029.7425643589104, 20305.390838274874, 20460.897695511725, 20553.794462055488, 20616.175352985712, 20722.48193795167, 950.5342382232657, 989.7525618595351, 1002.3234316836252, 1028.5268776362807, 1032.3805716569998, 10757.139428845674, 11311.773764524663, 11319.773604527863, 11335.14986376025, 11382.260153090023, 402848.0, 547112.0, 548526.0, 553443.0, 558052.9362944555, 88104.0, 103527.0, 107083.0, 109346.0, 113327.0, 982.1357205658975, 1026.3328836256494, 1055.1031623120286, 1086.8532748078908, 1090.574675876409, 17584.38454654081, 18259.269629214683, 18802.905985469984, 18806.247750089842, 18889.622207556047, 45198.0, 45448.90959813633, 45671.0, 45711.0, 46491.76754116208, 63548.68225659027, 64769.67615161894, 66188.0, 66202.0, 67520.3247967514, 7734.92265077342, 8286.295664868312, 8796.91203087961, 8817.559122044, 9044.773880652772, 12828.55100071493, 13707.109037912902, 13785.0, 13997.930010349883, 14163.017177594938, 12036.819447708467, 12199.329036903055, 12280.631581052583, 12483.375831208585, 12586.433610487733, 11659.883401166218, 11721.238119522204, 11863.940680296544, 11903.82144267854, 11959.521619135485, 12285.078619103782, 12370.0, 12448.875511244772, 12698.0, 12812.487500499876, 8001.679932802623, 8081.111077781557, 8107.391945603986, 8299.170082991652, 8529.82940341202, 10110.0, 11789.469473873867, 11952.64142075739, 12077.0, 12174.695632609255], "value": 9537.085528419151, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.7484427647303, 1501.4744839306245, 1661.916904154792, 1788.1148831328478, 1825.7535232743585, 7419.777406677795, 8450.746477605673, 8677.177792663548, 9169.0, 9192.494412807302, 8937.910620893788, 9090.272848158846, 9094.408863423889, 9101.226395756368, 9134.771630709236, 2395.556821987929, 2445.3519817248443, 2445.461998360358, 2449.9755002450015, 2450.6079027355627, 2335.2994101769486, 2364.7871691547757, 2414.770596793302, 2422.8546287222734, 2427.538767634144, 2447.6940382452194, 2462.0890270599903, 2470.258922323305, 2470.7158676752133, 2475.653408522808, 2346.9061237550477, 2352.1414683640432, 2357.6581395697613, 2363.822713296501, 2378.726446458662, 2256.7291924968945, 2271.432141964509, 2275.8179345652306, 2277.920272790461, 2295.598270302707, 9048.185663290336, 9146.405483643543, 9148.588313525906, 9190.172884440366, 9191.218746406563, 5439.809606663748, 5557.944420555824, 5568.248286481314, 5571.693556854371, 5599.272094627713, 3418.4017796885446, 3545.627709090534, 3593.8742144025096, 3659.5242618459697, 3675.9081022974374, 1167.410457718855, 1172.2029020266216, 1189.5182451107316, 1199.0827017331749, 1206.662134602304, 12487.562935297221, 12683.23900565969, 12684.985201183976, 12695.428705708266, 12756.80864787029, 4386.232409328419, 4539.114872599877, 4648.953510464919, 4657.278121891045, 4665.836695715701, 9876.802463950824, 9912.603495860229, 9919.900800991898, 9941.80116397668, 9945.20438364929, 5376.247325374451, 5381.596380271417, 5385.353757549119, 5408.945910540844, 5417.702026388586, 4209.74741515504, 4926.088673595396, 5004.824831130893, 5042.142835717937, 5064.873378165576, 3804.847806087781, 3911.6870650347905, 3937.370020796659, 4014.0, 4054.1688953764406, 1111.8665760108677, 1138.021301680554, 1155.1855941561348, 1161.309021132425, 1168.363242033094, 786.2923368967975, 928.6099838068028, 932.305432452827, 948.7960088580988, 995.2137811129127, 6113.969430152821, 6119.204503414528, 6199.721012554446, 6409.839754006094, 6448.097266382711, 954.8663187153804, 970.5729479029204, 975.7121649113528, 989.1443901025705, 1066.7493139112303, 4084.6936479764136, 4312.37470566766, 4428.402165707588, 4441.311596702516, 4522.1181869535785, 11139.721506962229, 11298.887011129784, 11460.484278207501, 11517.827232591519, 11543.88456115428, 11056.336619802838, 11127.387993660264, 11237.71905702364, 11241.49413276388, 11364.0, 7840.725574604976, 7848.686052557948, 7950.1254861965135, 7978.6409611567615, 7999.880001799977, 5631.943680563142, 5843.7370318336625, 5872.031114865999, 5878.853028674146, 5973.313068997121, 9359.298052645943, 9415.576299066695, 9603.423794572349, 9604.75988100303, 9649.46927918943, 9826.017398260117, 9858.408495490294, 9882.752931176778, 9901.108900199017, 9901.356411833207, 6464.676766161767, 7351.154617219088, 7468.290512401313, 7617.428692847948, 7733.188015258317, 8975.147361000694, 8979.32655050887, 8997.325200610112, 9057.003729589871, 9081.273498120003, 7626.771196864103, 7660.693572257047, 7738.7678369649, 7948.16544262844, 8231.0, 7750.534967901718, 7807.765767026998, 7829.099653539915, 7893.486923349964, 7919.881201781863, 7319.8536029280185, 7443.4789564729945, 7451.850962980601, 7459.0, 7476.850462990818, 5240.606954478353, 5256.684598924076, 5266.8946621068135, 5323.9467605325, 5435.076037073628, 5061.898762024665, 5115.5396014358885, 5133.076046311699, 5136.589072874086, 5351.224072509386], "value": 4707.701042151361, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.30602121273535, 341.5593883889782, 342.5769175068791, 346.2210027438264, 346.88032628743076, 5430.402655707869, 5532.502074813266, 5661.830145095643, 5688.914666280009, 5698.886022279557, 5543.805966791163, 5580.665160090397, 5582.91625625616, 5595.440455954413, 5615.971920140404, 4390.692651514395, 4394.956050439503, 4408.2807704995075, 4410.404595379615, 4414.514403415622, 4058.8782336529803, 4276.294411422127, 4320.848770293041, 4400.405945197405, 4416.470023597173, 4232.661387089025, 4267.466566679165, 4276.315789473685, 4281.100968796556, 4289.442372491588, 4257.340112282601, 4260.806974047272, 4263.957360426387, 4273.358996150571, 4303.956960430387, 3567.342329964193, 3797.9430308545393, 3800.0309920969976, 3812.5996770338993, 3826.005238637946, 5363.0, 5369.5167434931045, 5401.918971215435, 5405.243265942771, 5476.945230547683, 4947.406311242638, 4956.950430495685, 4961.578265847407, 4965.205567109281, 4971.254311853215, 5461.672299662033, 5712.171735098387, 5757.0, 5777.248957635523, 5778.27771528559, 4119.814608342632, 4123.402106694512, 4138.110306284163, 4146.983988922703, 4170.22850772608, 6028.487578555828, 6071.817845464643, 6073.908891366633, 6077.997130473511, 6099.45104940553, 4165.416841642173, 4193.39195816611, 4227.619514243733, 4284.121755040209, 4287.399764033038, 4232.78836058202, 4243.915121697549, 4250.596193361625, 4253.532111467736, 4271.103068355618, 4835.347228124158, 4852.805887764521, 4894.874178938864, 4901.5343542364135, 4904.901901961941, 5521.309836270466, 5815.796447124415, 5819.388964158787, 5843.211166492469, 5854.356020837705, 1476.188096546895, 1479.2603698150924, 1480.674251664632, 1484.2652886821093, 1492.037635724973, 893.7229458867772, 946.8863736351544, 949.7625593601599, 964.8793900762405, 970.1608108985677, 4858.95141048585, 4884.462709101996, 4886.462489126193, 4891.092473935097, 4953.67801092935, 5166.535011848951, 5201.45384734605, 5220.634555581073, 5224.660397074178, 5227.60792940531, 4661.300804879227, 4915.606751459874, 4991.900161996739, 5007.574356179765, 5024.949750502521, 2768.6816016157995, 2781.3880946191807, 2800.6359173307746, 2806.144126041577, 2812.1563530940634, 5417.483104730682, 5501.449855014546, 5525.917111243334, 5529.281193444826, 5551.8889622207325, 5068.381740254162, 5198.0, 5349.8765259295205, 5357.7589008494715, 5457.345118585795, 5468.453154684579, 5471.753771080311, 5484.424135465799, 5537.640053396516, 5560.77756889728, 5258.474152584711, 5272.525472707474, 5280.7556788365555, 5340.465953404629, 5355.25026496283, 4872.076753947603, 5182.222666600041, 5242.318498595158, 5245.659032162897, 5265.919961615217, 5456.536194423518, 5521.122818241817, 5548.889022219614, 5557.610967232416, 5578.776848925998, 4033.233685599727, 4074.2055299217554, 4145.689073319573, 4149.958500415078, 4157.875263742093, 5965.224520812267, 5972.522198224045, 5975.521958243417, 5985.221921150222, 5986.760529578943, 5715.257016587817, 5803.622764520293, 5864.035548091267, 5867.325257595431, 5883.735231914488, 5744.540436765133, 5745.224394706661, 5759.934412133601, 5786.218860453785, 5800.781835814526, 5759.712014399347, 5771.192033115283, 5778.537716982547, 5786.623869448473, 5809.448102430262, 5615.809834164597, 5784.814113106719, 5800.346901133325, 5828.0, 5839.854003649943, 5630.690312032878, 5644.036880637698, 5652.943470565407, 5676.914846277392, 5708.4862362387585], "value": 4270.968749347358, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.9528659876173, 770.8612449759042, 773.6982576795051, 811.4644334739072, 829.6598394658191, 16400.83599164008, 17225.22486488108, 17268.654626907453, 17434.215460304284, 17523.123843807807, 15689.215539223022, 15826.604334891634, 15848.920755396206, 15859.286332115054, 15862.286197121128, 669.1368135105707, 795.9840803183932, 803.3011280186231, 813.7518056992615, 814.9185081491863, 822.8313195794877, 822.9547374894379, 824.3611201318965, 826.7602395305354, 830.9584520773967, 889.3330002498126, 890.3233542507676, 890.7060669978891, 891.2558014058269, 892.4065496444856, 874.484054407896, 880.4013270975734, 882.7616543533242, 883.2845395229884, 883.5184824270756, 648.7502311610017, 648.9383508566726, 648.9415952564292, 649.04590252329, 649.136648257816, 14978.550643480714, 15124.773128403083, 15153.848461515354, 15158.924205379013, 15223.162726050063, 14869.628259293497, 15192.316345764468, 15616.375344986187, 15731.528054158394, 15923.0, 12907.0, 12924.741505169937, 12933.935330323382, 13071.54249601269, 13666.658333541642, 3949.526056873165, 3955.8458666164966, 4015.7791321477307, 4019.437278780973, 4045.59544045596, 85337.14662853353, 86299.0, 87510.562447188, 89639.55180224057, 89828.55085724595, 11992.760144797056, 12052.578159764365, 12271.754564908651, 12336.876631233572, 12454.377281136089, 23366.415839604146, 23530.176443824384, 23530.352795316754, 23564.882175589013, 23630.763692362856, 8551.74344769658, 8859.734207973772, 8866.246369058703, 9063.184313411824, 9446.433214007182, 4762.380890484214, 4809.0862736080035, 4934.55588996992, 4942.258661200849, 5048.62135339851, 3447.9655203448146, 3566.8751593694615, 3576.46353047045, 3579.534660494119, 3580.212353282274, 616.1251023546574, 630.9274433440121, 630.9305976342598, 639.7025383196743, 649.1852724830402, 701.6491754122939, 712.0671919785098, 714.3570786292379, 724.9927500725031, 726.9418446524265, 9468.526573671288, 9694.806103877883, 9970.152537034288, 9987.850182247126, 10001.199904007663, 697.6546609428366, 705.1784670858392, 712.7006657203987, 721.8339781850204, 723.3887365176417, 4959.181735013754, 4999.450060493343, 5033.748312584356, 5062.822801202014, 5074.492550744896, 71868.64065679639, 72918.0, 86382.13617863867, 128645.0, 133015.0, 32083.839580801945, 105362.47318763357, 108112.45943770389, 109692.0, 110891.0, 74461.6276918612, 77208.61395693097, 86770.0, 87955.12044879598, 90180.0, 9955.701328960144, 10059.74850628711, 10219.795604087727, 10224.948875255575, 10384.42885641297, 48410.273845891636, 48764.0, 49142.26286605632, 49154.75422622864, 49887.251691225385, 45282.773586133175, 45725.77137114293, 46339.0, 71620.28379716344, 74929.62535187289, 13302.135361201492, 13407.262600557064, 13703.314834258446, 13824.792628110385, 14189.432422702976, 14889.404423822925, 15737.213139343216, 15738.134402607966, 16180.0, 16258.430954916521, 14930.402783888523, 15086.0, 15360.692786144438, 15938.920305398398, 15981.28084236189, 14088.859111408754, 14874.181919994071, 14880.255987200813, 14966.476173333882, 15038.473653422077, 14245.928770356082, 14902.329395177027, 15143.545693629208, 15276.388944442542, 15448.30482628262, 11352.772944540899, 11537.769244615229, 11541.711457213636, 11594.71013224676, 11712.824307635563, 11560.421978900853, 12310.138290319592, 12424.627261182179, 12610.0, 12642.30467324306], "value": 7788.444401885886, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1534.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 109.0, 111.0, 113.0, 113.0, 113.0, 113.0, 114.0, 115.0], "value": 111.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 124.0, 149.0, 178.0, 120.0, 150.0, 155.0, 122.0, 176.0, 122.0], "value": 144.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 161.0, 162.0, 164.0, 172.0, 166.0, 161.0, 162.0, 162.0], "value": 163.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 74.0, 76.0, 192.0, 76.0, 77.0, 75.0, 76.0, 189.0, 75.0], "value": 98.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 154.0, 84.0, 85.0, 85.0, 139.0, 86.0, 86.0, 147.0], "value": 103.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 117.0, 124.0, 117.0, 118.0, 118.0, 119.0, 119.0, 119.0], "value": 118.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 147.0, 147.0, 147.0, 147.0, 147.0, 147.0], "value": 147.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 95.0, 96.0, 95.0, 96.0, 96.0, 95.0, 100.0, 95.0, 96.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [51.0, 53.0, 53.0, 51.0, 52.0, 52.0, 52.0, 51.0, 53.0, 53.0], "value": 52.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 63.0, 61.0, 61.0, 64.0, 62.0, 62.0, 61.0, 62.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 82.0, 80.0, 77.0, 77.0, 78.0, 77.0, 81.0, 77.0], "value": 78.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [123.0, 126.0, 132.0, 125.0, 129.0, 131.0, 129.0, 142.0, 140.0, 123.0], "value": 130.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 164.0, 164.0, 163.0, 167.0, 171.0, 163.0, 162.0, 162.0, 158.0], "value": 164.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 71.0, 63.0, 63.0, 64.0, 63.0, 64.0, 62.0], "value": 65.0, "unit": "score"}]}]} 20:26:49 INFO - Return code: 0 20:26:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 20:26:49 ERROR - # TBPL SUCCESS # 20:26:49 INFO - Running post-action listener: _resource_record_post_action 20:26:49 INFO - [mozharness: 2016-08-10 03:26:49.177450Z] Finished run-tests step (success) 20:26:49 INFO - Running post-run listener: _resource_record_post_run 20:26:49 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 8192; Write bytes: 559595520; Read time: 24; Write time: 608456 20:26:49 INFO - TinderboxPrint: CPU usage
13.4% 20:26:49 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 24 20:26:49 INFO - TinderboxPrint: I/O write bytes / time
559,595,520 / 608,456 20:26:49 INFO - TinderboxPrint: CPU idle
8,232.0 (86.5%) 20:26:49 INFO - TinderboxPrint: CPU user
1,220.9 (12.8%) 20:26:49 INFO - TinderboxPrint: Swap in / out
0 / 0 20:26:49 INFO - install - Wall time: 17s; CPU: 15.0%; Read bytes: 0; Write bytes: 266276864; Read time: 0; Write time: 348108 20:26:49 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 4096; Write bytes: 292909056; Read time: 16; Write time: 260264 20:26:49 INFO - Running post-run listener: _upload_blobber_files 20:26:49 INFO - Blob upload gear active. 20:26:49 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 20:26:49 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 20:26:49 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'] 20:26:49 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 20:26:50 INFO - (blobuploader) - INFO - Open directory for files ... 20:26:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 20:26:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:51 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 20:26:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:51 INFO - (blobuploader) - INFO - Done attempting. 20:26:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 20:26:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 20:26:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:52 INFO - (blobuploader) - INFO - Done attempting. 20:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 20:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 20:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 20:26:57 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 20:26:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 20:26:57 INFO - (blobuploader) - INFO - Done attempting. 20:26:57 INFO - (blobuploader) - INFO - Iteration through files over. 20:26:57 INFO - Return code: 0 20:26:57 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 20:26:57 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 20:26:57 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2090cef12f0d176953692fbdcbfff1acd53cc5776e77945e36732759f1beddb18ee31708dfbc7a6c15ea4f519f4fa4b2fe843a87b0baebb2634def780081b9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ddfc7639bad4f96ddbd203b021710c7896ab298ae4c02d1865515676b2f85b590b8adf93c3e035b3818a7aa07b47bc0fbc2a65d21e232b623648e629833523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/446cddf2499ded956a9061bf98dfbc764bccefd405821fd28c07a2f3cc3a6a77a527f2e611f3e7c511cd86c0b91d75626b13bf3bfb6f58d7516d5ab6a05aab9c"} 20:26:57 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 20:26:57 INFO - Writing to file /builds/slave/test/properties/blobber_files 20:26:57 INFO - Contents: 20:26:57 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/b2090cef12f0d176953692fbdcbfff1acd53cc5776e77945e36732759f1beddb18ee31708dfbc7a6c15ea4f519f4fa4b2fe843a87b0baebb2634def780081b9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ddfc7639bad4f96ddbd203b021710c7896ab298ae4c02d1865515676b2f85b590b8adf93c3e035b3818a7aa07b47bc0fbc2a65d21e232b623648e629833523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/446cddf2499ded956a9061bf98dfbc764bccefd405821fd28c07a2f3cc3a6a77a527f2e611f3e7c511cd86c0b91d75626b13bf3bfb6f58d7516d5ab6a05aab9c"} 20:26:57 INFO - Running post-run listener: copy_logs_to_upload_dir 20:26:57 INFO - Copying logs to upload dir... 20:26:57 INFO - mkdir: /builds/slave/test/build/upload/logs 20:26:57 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1232.362345 ========= master_lag: 0.70 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 33 secs) (at 2016-08-09 20:26:58.551248) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 20:26:58.555627) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249 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/b2090cef12f0d176953692fbdcbfff1acd53cc5776e77945e36732759f1beddb18ee31708dfbc7a6c15ea4f519f4fa4b2fe843a87b0baebb2634def780081b9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ddfc7639bad4f96ddbd203b021710c7896ab298ae4c02d1865515676b2f85b590b8adf93c3e035b3818a7aa07b47bc0fbc2a65d21e232b623648e629833523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/446cddf2499ded956a9061bf98dfbc764bccefd405821fd28c07a2f3cc3a6a77a527f2e611f3e7c511cd86c0b91d75626b13bf3bfb6f58d7516d5ab6a05aab9c"} build_url:https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011217 build_url: 'https://queue.taskcluster.net/v1/task/cIafPEMIQxCfzVcKa4TVnQ/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/b2090cef12f0d176953692fbdcbfff1acd53cc5776e77945e36732759f1beddb18ee31708dfbc7a6c15ea4f519f4fa4b2fe843a87b0baebb2634def780081b9e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/43ddfc7639bad4f96ddbd203b021710c7896ab298ae4c02d1865515676b2f85b590b8adf93c3e035b3818a7aa07b47bc0fbc2a65d21e232b623648e629833523", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/446cddf2499ded956a9061bf98dfbc764bccefd405821fd28c07a2f3cc3a6a77a527f2e611f3e7c511cd86c0b91d75626b13bf3bfb6f58d7516d5ab6a05aab9c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-09 20:26:58.583627) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 20:26:58.583945) ========= 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=652eb03db935cfc1c15ebda0000001ad-1470797657.256500-1213667249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004460 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-09 20:26:58.632956) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 20:26:58.636302) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-09 20:26:58.636595) ========= ========= Total master_lag: 0.82 =========