builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-011 starttime: 1475122849.48 results: success (0) buildid: 20160928183006 builduid: d476dbbd49824f57984e3b3e4db36f99 revision: 182fd3e63603ca64d166a08c86a3347af1ff7385 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:49.479381) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:49.479827) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:49.480101) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:49.496197) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:49.496557) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-28 21:20:49-- 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% 29.6M=0s 2016-09-28 21:20:49 (29.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.122852 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:49.633454) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:49.633772) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017141 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:49.683512) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:49.683951) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 182fd3e63603ca64d166a08c86a3347af1ff7385 --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 182fd3e63603ca64d166a08c86a3347af1ff7385 --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-28 21:20:50,022 truncating revision to first 12 chars 2016-09-28 21:20:50,022 Setting DEBUG logging. 2016-09-28 21:20:50,022 attempt 1/10 2016-09-28 21:20:50,022 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/182fd3e63603?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-28 21:20:50,339 unpacking tar archive at: fx-team-182fd3e63603/testing/mozharness/ program finished with exit code 0 elapsedTime=0.631524 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:50.330527) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:50.330956) ========= script_repo_revision: 182fd3e63603ca64d166a08c86a3347af1ff7385 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:50.331358) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:50.331639) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-28 21:20:50.343656) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-28 21:20:50.343992) ========= /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=5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 21:20:50 INFO - MultiFileLogger online at 20160928 21:20:50 in /builds/slave/test 21:20:50 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 21:20:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:20:50 INFO - {'append_to_log': False, 21:20:50 INFO - 'base_work_dir': '/builds/slave/test', 21:20:50 INFO - 'blob_upload_branch': 'Fx-Team', 21:20:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:20:50 INFO - 'branch': 'Fx-Team', 21:20:50 INFO - 'buildbot_json_path': 'buildprops.json', 21:20:50 INFO - 'config_files': ('talos/linux_config.py',), 21:20:50 INFO - 'default_actions': ('clobber', 21:20:50 INFO - 'read-buildbot-config', 21:20:50 INFO - 'download-and-extract', 21:20:50 INFO - 'populate-webroot', 21:20:50 INFO - 'create-virtualenv', 21:20:50 INFO - 'install', 21:20:50 INFO - 'run-tests'), 21:20:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:20:50 INFO - 'download_minidump_stackwalk': True, 21:20:50 INFO - 'download_symbols': 'ondemand', 21:20:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:20:50 INFO - 'tooltool.py': '/tools/tooltool.py', 21:20:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:20:50 INFO - '/tools/misc-python/virtualenv.py')}, 21:20:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:20:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:20:50 INFO - 'installer_path': 'installer.exe', 21:20:50 INFO - 'log_level': 'info', 21:20:50 INFO - 'log_name': 'talos', 21:20:50 INFO - 'log_to_console': True, 21:20:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 21:20:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 21:20:50 INFO - 'opt_config_files': (), 21:20:50 INFO - 'pip_index': False, 21:20:50 INFO - 'sps_profile': False, 21:20:50 INFO - 'sps_profile_interval': 0, 21:20:50 INFO - 'suite': 'dromaeojs-e10s', 21:20:50 INFO - 'system_bits': '32', 21:20:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:20:50 INFO - 'title': 'talos-linux64-ix-011', 21:20:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:20:50 INFO - 'use_talos_json': True, 21:20:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:20:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:20:50 INFO - 'work_dir': 'build'} 21:20:50 INFO - [mozharness: 2016-09-29 04:20:50.772760Z] Running clobber step. 21:20:50 INFO - Running pre-action listener: _resource_record_pre_action 21:20:50 INFO - Running main action method: clobber 21:20:50 INFO - rmtree: /builds/slave/test/build 21:20:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:20:51 INFO - Running post-action listener: _resource_record_post_action 21:20:51 INFO - [mozharness: 2016-09-29 04:20:51.234556Z] Finished clobber step (success) 21:20:51 INFO - [mozharness: 2016-09-29 04:20:51.234656Z] Running read-buildbot-config step. 21:20:51 INFO - Running pre-action listener: _resource_record_pre_action 21:20:51 INFO - Running main action method: read_buildbot_config 21:20:51 INFO - Using buildbot properties: 21:20:51 INFO - { 21:20:51 INFO - "project": "", 21:20:51 INFO - "product": "firefox", 21:20:51 INFO - "script_repo_revision": "production", 21:20:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 21:20:51 INFO - "repository": "", 21:20:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 21:20:51 INFO - "buildid": "20160928183006", 21:20:51 INFO - "pgo_build": "True", 21:20:51 INFO - "basedir": "/builds/slave/test", 21:20:51 INFO - "buildnumber": 1210, 21:20:51 INFO - "slavename": "talos-linux64-ix-011", 21:20:51 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 21:20:51 INFO - "platform": "ubuntu64_hw", 21:20:51 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 21:20:51 INFO - "branch": "fx-team", 21:20:51 INFO - "repo_path": "integration/fx-team", 21:20:51 INFO - "revision": "182fd3e63603ca64d166a08c86a3347af1ff7385", 21:20:51 INFO - "stage_platform": "linux64-pgo", 21:20:51 INFO - "builduid": "d476dbbd49824f57984e3b3e4db36f99", 21:20:51 INFO - "slavebuilddir": "test" 21:20:51 INFO - } 21:20:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 21:20:51 INFO - Running post-action listener: _resource_record_post_action 21:20:51 INFO - [mozharness: 2016-09-29 04:20:51.237092Z] Finished read-buildbot-config step (success) 21:20:51 INFO - [mozharness: 2016-09-29 04:20:51.237181Z] Running download-and-extract step. 21:20:51 INFO - Running pre-action listener: _resource_record_pre_action 21:20:51 INFO - Running main action method: download_and_extract 21:20:51 INFO - mkdir: /builds/slave/test/build/tests 21:20: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')]} 21:20:51 INFO - trying https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:20:51 INFO - Downloading https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:20:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 21:20:51 INFO - Downloaded 1361 bytes. 21:20:51 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 21:20:51 INFO - Using the following test package requirements: 21:20:51 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:20:51 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:20:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 21:20:51 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:20:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 21:20:51 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:20:51 INFO - u'jsshell-linux-x86_64.zip'], 21:20:51 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:20:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 21:20:51 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 21:20:51 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:20:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 21:20:51 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:20:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 21:20:51 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:20:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 21:20:51 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 21:20:51 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 21:20:51 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 21:20:51 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:20:51 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:20:51 INFO - Fetch https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:20:52 INFO - Expected file size: 21987076 21:20:52 INFO - Content-Encoding None 21:20:52 INFO - Content-Type application/zip 21:20:52 INFO - Http code 200 21:20:56 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 21:20:56 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 21:20:56 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 21:20:56 INFO - Fetch https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 21:20:57 INFO - Expected file size: 21987076 21:20:57 INFO - Content-Encoding None 21:20:57 INFO - Content-Type application/zip 21:20:57 INFO - Http code 200 21:21:02 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 21:21:02 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 21:21:02 INFO - Fetch https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 21:21:02 INFO - Expected file size: 14414067 21:21:02 INFO - Content-Encoding None 21:21:02 INFO - Content-Type application/zip 21:21:02 INFO - Http code 200 21:21:03 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')]} 21:21:03 INFO - trying https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:21:03 INFO - Downloading https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:21:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 21:21:04 INFO - Downloaded 59727918 bytes. 21:21:04 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:21:04 INFO - mkdir: /builds/slave/test/properties 21:21:04 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:21:04 INFO - Writing to file /builds/slave/test/properties/build_url 21:21:04 INFO - Contents: 21:21:04 INFO - build_url:https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 21:21:05 INFO - Running post-action listener: _resource_record_post_action 21:21:05 INFO - Running post-action listener: set_extra_try_arguments 21:21:05 INFO - [mozharness: 2016-09-29 04:21:05.631742Z] Finished download-and-extract step (success) 21:21:05 INFO - [mozharness: 2016-09-29 04:21:05.631971Z] Running populate-webroot step. 21:21:05 INFO - Running pre-action listener: _resource_record_pre_action 21:21:05 INFO - Running main action method: populate_webroot 21:21:05 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:21:05 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:21:05 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:21:05 INFO - '--tppagecycles', 21:21:05 INFO - '7'], 21:21:05 INFO - 'tests': ['tsvgm']}}, 21:21:05 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 21:21:05 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:21:05 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 21:21:05 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 21:21:05 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:21:05 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 21:21:05 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:05 INFO - 'talos_options': ['--disable-e10s'], 21:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:21:05 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:05 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:21:05 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:05 INFO - 'talos_options': ['--disable-e10s'], 21:21:05 INFO - 'tests': ['damp', 'tps']}, 21:21:05 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:05 INFO - 'tests': ['damp', 'tps']}, 21:21:05 INFO - 'g3': {'talos_options': ['--disable-e10s'], 21:21:05 INFO - 'tests': ['dromaeo_dom']}, 21:21:05 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:21:05 INFO - 'g4': {'talos_options': ['--disable-e10s'], 21:21:05 INFO - 'tests': ['basic_compositor_video']}, 21:21:05 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 21:21:05 INFO - 'other': {'talos_options': ['--disable-e10s'], 21:21:05 INFO - 'tests': ['a11yr', 21:21:05 INFO - 'ts_paint', 21:21:05 INFO - 'tpaint', 21:21:05 INFO - 'sessionrestore', 21:21:05 INFO - 'sessionrestore_no_auto_restore', 21:21:05 INFO - 'tabpaint']}, 21:21:05 INFO - 'other-e10s': {'tests': ['a11yr', 21:21:05 INFO - 'ts_paint', 21:21:05 INFO - 'tpaint', 21:21:05 INFO - 'sessionrestore', 21:21:05 INFO - 'sessionrestore_no_auto_restore', 21:21:05 INFO - 'tabpaint']}, 21:21:05 INFO - 'other-e10s_l64': {'tests': ['a11yr', 21:21:05 INFO - 'ts_paint', 21:21:05 INFO - 'tpaint', 21:21:05 INFO - 'sessionrestore', 21:21:05 INFO - 'sessionrestore_no_auto_restore', 21:21:05 INFO - 'tabpaint']}, 21:21:05 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 21:21:05 INFO - 'ts_paint', 21:21:05 INFO - 'tpaint', 21:21:05 INFO - 'sessionrestore', 21:21:05 INFO - 'sessionrestore_no_auto_restore', 21:21:05 INFO - 'tabpaint']}, 21:21:05 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 21:21:05 INFO - 'tests': ['a11yr', 21:21:05 INFO - 'ts_paint', 21:21:05 INFO - 'tpaint', 21:21:05 INFO - 'sessionrestore', 21:21:05 INFO - 'sessionrestore_no_auto_restore', 21:21:05 INFO - 'tabpaint']}, 21:21:05 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 21:21:05 INFO - 'tests': ['a11yr', 21:21:05 INFO - 'ts_paint', 21:21:05 INFO - 'tpaint', 21:21:05 INFO - 'sessionrestore', 21:21:05 INFO - 'sessionrestore_no_auto_restore', 21:21:05 INFO - 'tabpaint']}, 21:21:05 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 21:21:05 INFO - 'tests': ['tsvgx', 21:21:05 INFO - 'tsvgr_opacity', 21:21:05 INFO - 'tart', 21:21:05 INFO - 'tscrollx', 21:21:05 INFO - 'cart']}, 21:21:05 INFO - 'svgr-e10s': {'tests': ['tsvgx', 21:21:05 INFO - 'tsvgr_opacity', 21:21:05 INFO - 'tart', 21:21:05 INFO - 'tscrollx', 21:21:05 INFO - 'cart']}, 21:21:05 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:05 INFO - 'talos_options': ['--disable-e10s'], 21:21:05 INFO - 'tests': ['tp5o']}, 21:21:05 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:05 INFO - 'tests': ['tp5o']}, 21:21:05 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:05 INFO - 'talos_options': ['--disable-e10s', 21:21:05 INFO - '--xperf_path', 21:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:21:05 INFO - 'tests': ['tp5n']}, 21:21:05 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:21:05 INFO - 'talos_options': ['--xperf_path', 21:21:05 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:21:05 INFO - 'tests': ['tp5n']}}, 21:21:05 INFO - 'talos.zip': {'path': '', 21:21:05 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:21:05 INFO - Running post-action listener: _resource_record_post_action 21:21:05 INFO - [mozharness: 2016-09-29 04:21:05.648485Z] Finished populate-webroot step (success) 21:21:05 INFO - [mozharness: 2016-09-29 04:21:05.648572Z] Running create-virtualenv step. 21:21:05 INFO - Running pre-action listener: _resource_record_pre_action 21:21:05 INFO - Running main action method: create_virtualenv 21:21:05 INFO - Creating virtualenv /builds/slave/test/build/venv 21:21:05 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 21:21:05 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:21:05 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:21:05 INFO - Using real prefix '/usr' 21:21:05 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:21:06 INFO - Installing distribute.............................................................................................................................................................................................done. 21:21:08 INFO - Installing pip.................done. 21:21:08 INFO - Return code: 0 21:21:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 21:21:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 21:21:08 INFO - Reading from file tmpfile_stdout 21:21:08 INFO - Output received: 21:21:08 INFO - pip 1.5.5 from /builds/slave/test/build/venv/local/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 21:21:08 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:08 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 0x7febe687cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cb930>, '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 0x23cc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', '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 21:21:08 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 21:21:08 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 21:21:08 INFO - Using env: {'DISPLAY': ':0', 21:21:08 INFO - 'HOME': '/home/cltbld', 21:21:08 INFO - 'LANG': 'en_US.UTF-8', 21:21:08 INFO - 'LANGUAGE': 'en_US:en', 21:21:08 INFO - 'LOGNAME': 'cltbld', 21:21:08 INFO - 'MAIL': '/var/mail/cltbld', 21:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:08 INFO - 'MOZ_NO_REMOTE': '1', 21:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:08 INFO - 'NO_EM_RESTART': '1', 21:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:08 INFO - 'PWD': '/builds/slave/test', 21:21:08 INFO - 'SHELL': '/bin/bash', 21:21:08 INFO - 'SHLVL': '1', 21:21:08 INFO - 'TERM': 'linux', 21:21:08 INFO - 'TMOUT': '86400', 21:21:08 INFO - 'USER': 'cltbld', 21:21:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', 21:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:08 INFO - '_': '/tools/buildbot/bin/python'} 21:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:08 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 21:21:08 INFO - Cleaning up... 21:21:08 INFO - Return code: 0 21:21:08 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 21:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:08 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 0x7febe687cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cb930>, '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 0x23cc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', '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 21:21:08 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 21:21:08 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 21:21:08 INFO - Using env: {'DISPLAY': ':0', 21:21:08 INFO - 'HOME': '/home/cltbld', 21:21:08 INFO - 'LANG': 'en_US.UTF-8', 21:21:08 INFO - 'LANGUAGE': 'en_US:en', 21:21:08 INFO - 'LOGNAME': 'cltbld', 21:21:08 INFO - 'MAIL': '/var/mail/cltbld', 21:21:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:08 INFO - 'MOZ_NO_REMOTE': '1', 21:21:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:08 INFO - 'NO_EM_RESTART': '1', 21:21:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:08 INFO - 'PWD': '/builds/slave/test', 21:21:08 INFO - 'SHELL': '/bin/bash', 21:21:08 INFO - 'SHLVL': '1', 21:21:08 INFO - 'TERM': 'linux', 21:21:08 INFO - 'TMOUT': '86400', 21:21:08 INFO - 'USER': 'cltbld', 21:21:08 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', 21:21:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:08 INFO - '_': '/tools/buildbot/bin/python'} 21:21:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:08 INFO - Downloading/unpacking psutil>=3.1.1 21:21:08 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 21:21:08 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 21:21:08 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 21:21:08 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 21:21:08 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 21:21:08 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 21:21:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:21:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:21:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:21:10 INFO - Installing collected packages: psutil 21:21:10 INFO - Running setup.py install for psutil 21:21:10 INFO - building 'psutil._psutil_linux' extension 21:21:10 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 21:21:11 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 21:21:11 INFO - building 'psutil._psutil_posix' extension 21:21:11 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 21:21:11 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 21:21:11 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:21:11 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:21:11 INFO - Successfully installed psutil 21:21:11 INFO - Cleaning up... 21:21:11 INFO - Return code: 0 21:21:11 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 21:21:11 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')]} 21:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:11 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')]} 21:21:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:11 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 0x7febe687cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cb930>, '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 0x23cc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', '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 21:21:11 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 21:21:11 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 21:21:11 INFO - Using env: {'DISPLAY': ':0', 21:21:11 INFO - 'HOME': '/home/cltbld', 21:21:11 INFO - 'LANG': 'en_US.UTF-8', 21:21:11 INFO - 'LANGUAGE': 'en_US:en', 21:21:11 INFO - 'LOGNAME': 'cltbld', 21:21:11 INFO - 'MAIL': '/var/mail/cltbld', 21:21:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:11 INFO - 'MOZ_NO_REMOTE': '1', 21:21:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:11 INFO - 'NO_EM_RESTART': '1', 21:21:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:11 INFO - 'PWD': '/builds/slave/test', 21:21:11 INFO - 'SHELL': '/bin/bash', 21:21:11 INFO - 'SHLVL': '1', 21:21:11 INFO - 'TERM': 'linux', 21:21:11 INFO - 'TMOUT': '86400', 21:21:11 INFO - 'USER': 'cltbld', 21:21:11 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', 21:21:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:11 INFO - '_': '/tools/buildbot/bin/python'} 21:21:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:11 INFO - Downloading/unpacking mozsystemmonitor==0.3 21:21:11 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 21:21:11 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 21:21:11 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 21:21:11 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 21:21:11 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 21:21:11 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 21:21:13 INFO - Downloading mozsystemmonitor-0.3.tar.gz 21:21:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:21:13 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 21:21:13 INFO - Installing collected packages: mozsystemmonitor 21:21:13 INFO - Running setup.py install for mozsystemmonitor 21:21:13 INFO - Successfully installed mozsystemmonitor 21:21:13 INFO - Cleaning up... 21:21:13 INFO - Return code: 0 21:21:13 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 21:21: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')]} 21:21:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21: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')]} 21:21:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:13 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 0x7febe687cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cb930>, '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 0x23cc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', '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 21:21:13 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 21:21:13 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 21:21:13 INFO - Using env: {'DISPLAY': ':0', 21:21:13 INFO - 'HOME': '/home/cltbld', 21:21:13 INFO - 'LANG': 'en_US.UTF-8', 21:21:13 INFO - 'LANGUAGE': 'en_US:en', 21:21:13 INFO - 'LOGNAME': 'cltbld', 21:21:13 INFO - 'MAIL': '/var/mail/cltbld', 21:21:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:13 INFO - 'MOZ_NO_REMOTE': '1', 21:21:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:13 INFO - 'NO_EM_RESTART': '1', 21:21:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:13 INFO - 'PWD': '/builds/slave/test', 21:21:13 INFO - 'SHELL': '/bin/bash', 21:21:13 INFO - 'SHLVL': '1', 21:21:13 INFO - 'TERM': 'linux', 21:21:13 INFO - 'TMOUT': '86400', 21:21:13 INFO - 'USER': 'cltbld', 21:21:13 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', 21:21:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:13 INFO - '_': '/tools/buildbot/bin/python'} 21:21:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:13 INFO - Downloading/unpacking jsonschema==2.5.1 21:21:13 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 21:21:13 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 21:21:13 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 21:21:13 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 21:21:13 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 21:21:13 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 21:21:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:21:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 21:21:15 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 21:21:15 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 21:21:15 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 21:21:15 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 21:21:15 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 21:21:15 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 21:21:16 INFO - Downloading functools32-3.2.3-2.tar.gz 21:21:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:21:16 INFO - warning: no files found matching '*.txt' 21:21:16 INFO - no previously-included directories found matching 'build' 21:21:16 INFO - no previously-included directories found matching 'dist' 21:21:16 INFO - no previously-included directories found matching '.git*' 21:21:16 INFO - Installing collected packages: jsonschema, functools32 21:21:16 INFO - Running setup.py install for functools32 21:21:16 INFO - warning: no files found matching '*.txt' 21:21:16 INFO - no previously-included directories found matching 'build' 21:21:16 INFO - no previously-included directories found matching 'dist' 21:21:16 INFO - no previously-included directories found matching '.git*' 21:21:16 INFO - Successfully installed jsonschema functools32 21:21:16 INFO - Cleaning up... 21:21:16 INFO - Return code: 0 21:21:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 21:21:16 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')]} 21:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:16 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')]} 21:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:16 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 0x7febe687cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cb930>, '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 0x23cc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', '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 21:21:16 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 21:21:16 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 21:21:16 INFO - Using env: {'DISPLAY': ':0', 21:21:16 INFO - 'HOME': '/home/cltbld', 21:21:16 INFO - 'LANG': 'en_US.UTF-8', 21:21:16 INFO - 'LANGUAGE': 'en_US:en', 21:21:16 INFO - 'LOGNAME': 'cltbld', 21:21:16 INFO - 'MAIL': '/var/mail/cltbld', 21:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:16 INFO - 'MOZ_NO_REMOTE': '1', 21:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:16 INFO - 'NO_EM_RESTART': '1', 21:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:16 INFO - 'PWD': '/builds/slave/test', 21:21:16 INFO - 'SHELL': '/bin/bash', 21:21:16 INFO - 'SHLVL': '1', 21:21:16 INFO - 'TERM': 'linux', 21:21:16 INFO - 'TMOUT': '86400', 21:21:16 INFO - 'USER': 'cltbld', 21:21:16 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', 21:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:16 INFO - '_': '/tools/buildbot/bin/python'} 21:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 21:21:16 INFO - Cleaning up... 21:21:16 INFO - Return code: 0 21:21:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:21:16 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')]} 21:21:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:16 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')]} 21:21:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:16 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 0x7febe687cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cb930>, '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 0x23cc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', '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 21:21:16 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 21:21:16 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 21:21:16 INFO - Using env: {'DISPLAY': ':0', 21:21:16 INFO - 'HOME': '/home/cltbld', 21:21:16 INFO - 'LANG': 'en_US.UTF-8', 21:21:16 INFO - 'LANGUAGE': 'en_US:en', 21:21:16 INFO - 'LOGNAME': 'cltbld', 21:21:16 INFO - 'MAIL': '/var/mail/cltbld', 21:21:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:16 INFO - 'MOZ_NO_REMOTE': '1', 21:21:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:16 INFO - 'NO_EM_RESTART': '1', 21:21:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:16 INFO - 'PWD': '/builds/slave/test', 21:21:16 INFO - 'SHELL': '/bin/bash', 21:21:16 INFO - 'SHLVL': '1', 21:21:16 INFO - 'TERM': 'linux', 21:21:16 INFO - 'TMOUT': '86400', 21:21:16 INFO - 'USER': 'cltbld', 21:21:16 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', 21:21:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:16 INFO - '_': '/tools/buildbot/bin/python'} 21:21:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:16 INFO - Downloading/unpacking blobuploader==1.2.4 21:21:16 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 21:21:16 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 21:21:16 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 21:21:16 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 21:21:16 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 21:21:16 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 21:21:18 INFO - Downloading blobuploader-1.2.4.tar.gz 21:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:21:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:21:18 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 21:21:18 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 21:21:18 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 21:21:18 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 21:21:18 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 21:21:18 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 21:21:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:21:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:21:19 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 21:21:19 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 21:21:19 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 21:21:19 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 21:21:19 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 21:21:19 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 21:21:19 INFO - Downloading docopt-0.6.1.tar.gz 21:21:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:21:19 INFO - Installing collected packages: blobuploader, requests, docopt 21:21:19 INFO - Running setup.py install for blobuploader 21:21:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:21:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:21:19 INFO - Running setup.py install for requests 21:21:19 INFO - Running setup.py install for docopt 21:21:19 INFO - Successfully installed blobuploader requests docopt 21:21:19 INFO - Cleaning up... 21:21:20 INFO - Return code: 0 21:21:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 21:21:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:20 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 0x7febe687cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cb930>, '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 0x23cc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', '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 21:21:20 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 21:21:20 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 21:21:20 INFO - Using env: {'DISPLAY': ':0', 21:21:20 INFO - 'HOME': '/home/cltbld', 21:21:20 INFO - 'LANG': 'en_US.UTF-8', 21:21:20 INFO - 'LANGUAGE': 'en_US:en', 21:21:20 INFO - 'LOGNAME': 'cltbld', 21:21:20 INFO - 'MAIL': '/var/mail/cltbld', 21:21:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:20 INFO - 'MOZ_NO_REMOTE': '1', 21:21:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:20 INFO - 'NO_EM_RESTART': '1', 21:21:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:20 INFO - 'PWD': '/builds/slave/test', 21:21:20 INFO - 'SHELL': '/bin/bash', 21:21:20 INFO - 'SHLVL': '1', 21:21:20 INFO - 'TERM': 'linux', 21:21:20 INFO - 'TMOUT': '86400', 21:21:20 INFO - 'USER': 'cltbld', 21:21:20 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', 21:21:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:20 INFO - '_': '/tools/buildbot/bin/python'} 21:21:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:21:20 INFO - Running setup.py (path:/tmp/pip-UoHfW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:21:20 INFO - Running setup.py (path:/tmp/pip-duzcvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:21:20 INFO - Running setup.py (path:/tmp/pip-pl2mMP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:21:20 INFO - Running setup.py (path:/tmp/pip-F6r3P1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:21:20 INFO - Running setup.py (path:/tmp/pip-vNwspg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:21:20 INFO - Running setup.py (path:/tmp/pip-m0niNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:21:20 INFO - Running setup.py (path:/tmp/pip-HZXYq8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:21:20 INFO - Running setup.py (path:/tmp/pip-6kb_IF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:21:20 INFO - Running setup.py (path:/tmp/pip-vApQt2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:21:20 INFO - Running setup.py (path:/tmp/pip-sF8kcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:21:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:21:20 INFO - Running setup.py (path:/tmp/pip-IKl5B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:21:21 INFO - Running setup.py (path:/tmp/pip-bz6bfJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:21:21 INFO - Running setup.py (path:/tmp/pip-UuD18E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:21:21 INFO - Running setup.py (path:/tmp/pip-832RaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:21 INFO - Running setup.py (path:/tmp/pip-EIjpgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:21:21 INFO - Running setup.py (path:/tmp/pip-w0L2ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:21:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:21:21 INFO - Running setup.py (path:/tmp/pip-cra7hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:21:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:21:21 INFO - Running setup.py install for manifestparser 21:21:21 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:21:21 INFO - Running setup.py install for mozcrash 21:21:21 INFO - Running setup.py install for mozdebug 21:21:21 INFO - Running setup.py install for mozdevice 21:21:21 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:21:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:21:21 INFO - Running setup.py install for mozfile 21:21:21 INFO - Running setup.py install for mozhttpd 21:21:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Running setup.py install for mozinfo 21:21:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Running setup.py install for mozInstall 21:21:22 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Running setup.py install for mozleak 21:21:22 INFO - Running setup.py install for mozlog 21:21:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Running setup.py install for moznetwork 21:21:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Running setup.py install for mozprocess 21:21:22 INFO - Running setup.py install for mozprofile 21:21:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Running setup.py install for mozrunner 21:21:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:21:22 INFO - Running setup.py install for mozscreenshot 21:21:23 INFO - Running setup.py install for moztest 21:21:23 INFO - Running setup.py install for mozversion 21:21:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:21:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:21:23 INFO - Cleaning up... 21:21:23 INFO - Return code: 0 21:21:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21:23 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')]} 21:21:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:23 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')]} 21:21:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:23 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 0x7febe687cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cb930>, '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 0x23cc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', '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 21:21:23 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 21:21:23 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 21:21:23 INFO - Using env: {'DISPLAY': ':0', 21:21:23 INFO - 'HOME': '/home/cltbld', 21:21:23 INFO - 'LANG': 'en_US.UTF-8', 21:21:23 INFO - 'LANGUAGE': 'en_US:en', 21:21:23 INFO - 'LOGNAME': 'cltbld', 21:21:23 INFO - 'MAIL': '/var/mail/cltbld', 21:21:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:23 INFO - 'MOZ_NO_REMOTE': '1', 21:21:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:23 INFO - 'NO_EM_RESTART': '1', 21:21:23 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:23 INFO - 'PWD': '/builds/slave/test', 21:21:23 INFO - 'SHELL': '/bin/bash', 21:21:23 INFO - 'SHLVL': '1', 21:21:23 INFO - 'TERM': 'linux', 21:21:23 INFO - 'TMOUT': '86400', 21:21:23 INFO - 'USER': 'cltbld', 21:21:23 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', 21:21:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:23 INFO - '_': '/tools/buildbot/bin/python'} 21:21:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:21:23 INFO - Running setup.py (path:/tmp/pip-Auizjy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:21:23 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)) 21:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:21:23 INFO - Running setup.py (path:/tmp/pip-YIomd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:21:23 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)) 21:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:21:23 INFO - Running setup.py (path:/tmp/pip-w817Qg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:21:23 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)) 21:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:21:23 INFO - Running setup.py (path:/tmp/pip-Gscv_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:21:23 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)) 21:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:21:23 INFO - Running setup.py (path:/tmp/pip-B68fkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:21:23 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)) 21:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:21:23 INFO - Running setup.py (path:/tmp/pip-kMA1fA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:21:23 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)) 21:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:21:23 INFO - Running setup.py (path:/tmp/pip-s_ZmZ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:21:23 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)) 21:21:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:21:23 INFO - Running setup.py (path:/tmp/pip-K5I_8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:21:24 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)) 21:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:21:24 INFO - Running setup.py (path:/tmp/pip-6j6MMe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:21:24 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)) 21:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:21:24 INFO - Running setup.py (path:/tmp/pip-fjwZMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:21:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:21:24 INFO - Running setup.py (path:/tmp/pip-kOqCpS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:21:24 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)) 21:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:21:24 INFO - Running setup.py (path:/tmp/pip-ukUERU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:21:24 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)) 21:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:21:24 INFO - Running setup.py (path:/tmp/pip-2BUl6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:21:24 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)) 21:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:21:24 INFO - Running setup.py (path:/tmp/pip-bHQBWH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:21:24 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)) 21:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:24 INFO - Running setup.py (path:/tmp/pip-CicGgh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:21:24 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)) 21:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:21:24 INFO - Running setup.py (path:/tmp/pip-n_YeKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:21:24 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)) 21:21:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:21:24 INFO - Running setup.py (path:/tmp/pip-7HU8n4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:21:24 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)) 21:21:24 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)) 21:21:24 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)) 21:21:24 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)) 21:21:24 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)) 21:21:24 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)) 21:21:24 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:24 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:24 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:21:24 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:21:24 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:21:26 INFO - Downloading blessings-1.6.tar.gz 21:21:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:21:26 INFO - Installing collected packages: blessings 21:21:26 INFO - Running setup.py install for blessings 21:21:26 INFO - Successfully installed blessings 21:21:26 INFO - Cleaning up... 21:21:26 INFO - Return code: 0 21:21:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:21:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:21:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:21:27 INFO - Reading from file tmpfile_stdout 21:21:27 INFO - Current package versions: 21:21:27 INFO - argparse == 1.2.1 21:21:27 INFO - blessings == 1.6 21:21:27 INFO - blobuploader == 1.2.4 21:21:27 INFO - docopt == 0.6.1 21:21:27 INFO - functools32 == 3.2.3-2 21:21:27 INFO - jsonschema == 2.5.1 21:21:27 INFO - manifestparser == 1.1 21:21:27 INFO - mozInstall == 1.12 21:21:27 INFO - mozcrash == 0.17 21:21:27 INFO - mozdebug == 0.1 21:21:27 INFO - mozdevice == 0.48 21:21:27 INFO - mozfile == 1.2 21:21:27 INFO - mozhttpd == 0.7 21:21:27 INFO - mozinfo == 0.9 21:21:27 INFO - mozleak == 0.1 21:21:27 INFO - mozlog == 3.4 21:21:27 INFO - moznetwork == 0.27 21:21:27 INFO - mozprocess == 0.23 21:21:27 INFO - mozprofile == 0.28 21:21:27 INFO - mozrunner == 6.12 21:21:27 INFO - mozscreenshot == 0.1 21:21:27 INFO - mozsystemmonitor == 0.3 21:21:27 INFO - moztest == 0.7 21:21:27 INFO - mozversion == 1.4 21:21:27 INFO - psutil == 3.1.1 21:21:27 INFO - requests == 1.2.3 21:21:27 INFO - wsgiref == 0.1.2 21:21:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:21: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')]} 21:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21: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')]} 21:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:27 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 0x7febe687cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cb930>, '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 0x23cc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', '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 21:21:27 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 21:21:27 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 21:21:27 INFO - Using env: {'DISPLAY': ':0', 21:21:27 INFO - 'HOME': '/home/cltbld', 21:21:27 INFO - 'LANG': 'en_US.UTF-8', 21:21:27 INFO - 'LANGUAGE': 'en_US:en', 21:21:27 INFO - 'LOGNAME': 'cltbld', 21:21:27 INFO - 'MAIL': '/var/mail/cltbld', 21:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:27 INFO - 'MOZ_NO_REMOTE': '1', 21:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:27 INFO - 'NO_EM_RESTART': '1', 21:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:27 INFO - 'PWD': '/builds/slave/test', 21:21:27 INFO - 'SHELL': '/bin/bash', 21:21:27 INFO - 'SHLVL': '1', 21:21:27 INFO - 'TERM': 'linux', 21:21:27 INFO - 'TMOUT': '86400', 21:21:27 INFO - 'USER': 'cltbld', 21:21:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', 21:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:27 INFO - '_': '/tools/buildbot/bin/python'} 21:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:27 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)) 21:21:27 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)) 21:21:27 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)) 21:21:27 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)) 21:21:27 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)) 21:21:27 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)) 21:21:27 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)) 21:21:27 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)) 21:21:27 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)) 21:21:27 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)) 21:21:27 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)) 21:21:27 INFO - Cleaning up... 21:21:27 INFO - Return code: 0 21:21:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:21: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')]} 21:21:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:21:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21: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')]} 21:21:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:21:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:21:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7febe687cf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x23ce790>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23cb930>, '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 0x23cc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cccc0>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', '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 21:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 21:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 21:21:27 INFO - Using env: {'DISPLAY': ':0', 21:21:27 INFO - 'HOME': '/home/cltbld', 21:21:27 INFO - 'LANG': 'en_US.UTF-8', 21:21:27 INFO - 'LANGUAGE': 'en_US:en', 21:21:27 INFO - 'LOGNAME': 'cltbld', 21:21:27 INFO - 'MAIL': '/var/mail/cltbld', 21:21:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:27 INFO - 'MOZ_NO_REMOTE': '1', 21:21:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:27 INFO - 'NO_EM_RESTART': '1', 21:21:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:27 INFO - 'PWD': '/builds/slave/test', 21:21:27 INFO - 'SHELL': '/bin/bash', 21:21:27 INFO - 'SHLVL': '1', 21:21:27 INFO - 'TERM': 'linux', 21:21:27 INFO - 'TMOUT': '86400', 21:21:27 INFO - 'USER': 'cltbld', 21:21:27 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', 21:21:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:27 INFO - '_': '/tools/buildbot/bin/python'} 21:21:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:21:27 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 21:21:27 INFO - Cleaning up... 21:21:27 INFO - Return code: 0 21:21:27 INFO - Running post-action listener: _resource_record_post_action 21:21:27 INFO - Running post-action listener: _start_resource_monitoring 21:21:27 INFO - Starting resource monitoring. 21:21:27 INFO - [mozharness: 2016-09-29 04:21:27.551847Z] Finished create-virtualenv step (success) 21:21:27 INFO - [mozharness: 2016-09-29 04:21:27.552354Z] Running install step. 21:21:27 INFO - Running pre-action listener: _resource_record_pre_action 21:21:27 INFO - Running main action method: install 21:21:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:21:27 INFO - Reading from file tmpfile_stdout 21:21:27 INFO - Detecting whether we're running mozinstall >=1.0... 21:21:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:21:27 INFO - Reading from file tmpfile_stdout 21:21:27 INFO - Output received: 21:21:27 INFO - Usage: mozinstall [options] installer 21:21:27 INFO - Options: 21:21:27 INFO - -h, --help show this help message and exit 21:21:27 INFO - -d DEST, --destination=DEST 21:21:27 INFO - Directory to install application into. [default: 21:21:27 INFO - "/builds/slave/test"] 21:21:27 INFO - --app=APP Application being installed. [default: firefox] 21:21:27 INFO - mkdir: /builds/slave/test/build/application 21:21:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 21:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 21:21:44 INFO - Reading from file tmpfile_stdout 21:21:44 INFO - Output received: 21:21:44 INFO - /builds/slave/test/build/application/firefox/firefox 21:21:44 INFO - Running post-action listener: _resource_record_post_action 21:21:44 INFO - [mozharness: 2016-09-29 04:21:44.885787Z] Finished install step (success) 21:21:44 INFO - [mozharness: 2016-09-29 04:21:44.886032Z] Running run-tests step. 21:21:44 INFO - Running pre-action listener: _resource_record_pre_action 21:21:44 INFO - Running main action method: run_tests 21:21:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:21:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:21:44 INFO - Python 2.7.3 21:21:44 INFO - Return code: 0 21:21:44 INFO - grabbing minidump binary from tooltool 21:21: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')]} 21:21:44 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 0x23cb930>, '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 0x23cc830>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23cccc0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:21:44 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 21:21:44 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 21:21:44 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 21:21:44 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:21:44 INFO - Return code: 0 21:21:44 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 21:21:44 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:21:44 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:21:44 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 21:21:44 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:21:44 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/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 21:21:44 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/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-011 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 21:21:44 INFO - Using env: {'DISPLAY': ':0', 21:21:44 INFO - 'HOME': '/home/cltbld', 21:21:44 INFO - 'LANG': 'en_US.UTF-8', 21:21:44 INFO - 'LANGUAGE': 'en_US:en', 21:21:44 INFO - 'LOGNAME': 'cltbld', 21:21:44 INFO - 'MAIL': '/var/mail/cltbld', 21:21:44 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:21:44 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 21:21:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:21:44 INFO - 'MOZ_NO_REMOTE': '1', 21:21:44 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:21:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 21:21:44 INFO - 'NO_EM_RESTART': '1', 21:21:44 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 21:21:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:21:44 INFO - 'PWD': '/builds/slave/test', 21:21:44 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:21:44 INFO - 'SHELL': '/bin/bash', 21:21:44 INFO - 'SHLVL': '1', 21:21:44 INFO - 'TERM': 'linux', 21:21:44 INFO - 'TMOUT': '86400', 21:21:44 INFO - 'USER': 'cltbld', 21:21:44 INFO - 'XDG_SESSION_COOKIE': '5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945', 21:21:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:21:44 INFO - '_': '/tools/buildbot/bin/python'} 21:21:44 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/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-011', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 21:21:45 INFO - mozversion application_buildid: 20160928183006 21:21:45 INFO - mozversion application_changeset: 182fd3e63603ca64d166a08c86a3347af1ff7385 21:21:45 INFO - mozversion application_display_name: Nightly 21:21:45 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:21:45 INFO - mozversion application_name: Firefox 21:21:45 INFO - mozversion application_remotingname: firefox 21:21:45 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 21:21:45 INFO - mozversion application_vendor: Mozilla 21:21:45 INFO - mozversion application_version: 52.0a1 21:21:45 INFO - mozversion platform_buildid: 20160928183006 21:21:45 INFO - mozversion platform_changeset: 182fd3e63603ca64d166a08c86a3347af1ff7385 21:21:45 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 21:21:45 INFO - mozversion platform_version: 52.0a1 21:21:45 INFO - using testdate: 1475122905 21:21:45 INFO - actual date: 1475122905 21:21:45 INFO - starting webserver on 'localhost:41733' 21:21:45 INFO - SUITE-START | Running 2 tests 21:21:45 INFO - TEST-START | dromaeo_css 21:21:45 INFO - operating with platform_type : linux_ 21:21:45 INFO - Initialising browser for dromaeo_css test... 21:21:45 INFO - TEST-INFO | started process 21455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7jkSmP/profile http://localhost:41733/getInfo.html) 21:21:50 INFO - PROCESS | 21455 | __metrics Screen width/height:1600/1200 21:21:50 INFO - PROCESS | 21455 | colorDepth:24 21:21:50 INFO - PROCESS | 21455 | Browser inner width/height: 1024/697 21:21:50 INFO - PROCESS | 21455 | __metrics 21:21:51 ERROR - PROCESS | 21455 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 21:21:52 INFO - TEST-INFO | 21455: exit 0 21:21:52 INFO - Browser initialized. 21:21:52 INFO - Running cycle 1/1 for dromaeo_css test... 21:21:52 INFO - TEST-INFO | started process 21578 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7jkSmP/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:22:04 INFO - PROCESS | 21578 | RSS: Main: 185745408 21:22:04 INFO - PROCESS | 21578 | 21:22:54 INFO - PROCESS | 21578 | 1475122974339 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] 21:25:04 INFO - PROCESS | 21578 | Cycle 1(1): loaded http://localhost:41733/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41733/tests/dromaeo/cssquery-ext.html) 21:25:05 INFO - PROCESS | 21578 | RSS: Main: 199819264 21:25:05 INFO - PROCESS | 21578 | 21:28:07 INFO - PROCESS | 21578 | Cycle 1(1): loaded http://localhost:41733/tests/dromaeo/cssquery-ext.html (next: http://localhost:41733/tests/dromaeo/cssquery-jquery.html) 21:28:08 INFO - PROCESS | 21578 | RSS: Main: 197955584 21:28:08 INFO - PROCESS | 21578 | 21:31:10 INFO - PROCESS | 21578 | Cycle 1(1): loaded http://localhost:41733/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41733/tests/dromaeo/cssquery-mootools.html) 21:31:10 INFO - PROCESS | 21578 | RSS: Main: 199057408 21:31:10 INFO - PROCESS | 21578 | 21:34:12 INFO - PROCESS | 21578 | Cycle 1(1): loaded http://localhost:41733/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41733/tests/dromaeo/cssquery-prototype.html) 21:34:13 INFO - PROCESS | 21578 | RSS: Main: 195686400 21:34:13 INFO - PROCESS | 21578 | 21:37:15 INFO - PROCESS | 21578 | Cycle 1(1): loaded http://localhost:41733/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41733/tests/dromaeo/cssquery-yui.html) 21:37:16 INFO - PROCESS | 21578 | RSS: Main: 199131136 21:37:16 INFO - PROCESS | 21578 | 21:40:18 INFO - PROCESS | 21578 | Cycle 1(1): loaded http://localhost:41733/tests/dromaeo/cssquery-yui.html (next: http://localhost:41733/tests/dromaeo/cssquery-dojo.html) 21:40:19 INFO - PROCESS | 21578 | RSS: Main: 199720960 21:40:19 INFO - PROCESS | 21578 | 21:40:19 INFO - PROCESS | 21578 | __start_tp_report 21:40:19 INFO - PROCESS | 21578 | _x_x_mozilla_page_load 21:40:19 INFO - PROCESS | 21578 | _x_x_mozilla_page_load_details 21:40:19 INFO - PROCESS | 21578 | |i|pagename|runs| 21:40:19 INFO - PROCESS | 21578 | |0;dojo.html;3043.117495926181;3076.723094921457;3085.6142982127235;3098.0705788263517;3114.2214446388402;5277.445868183843;5409.513143817056;5457.017736807378;5471.753771080301;5509.283793106891;5335.626506144571;5403.135498320269;5420.051490989081;5487.094629386156;5547.7226138693;4878;4966.553010229079;5025.1708468102715;5031.4465408805;5086.97456512717;5048.394192696882;5096.388433387999;5100.923486147711;5107;5109.310243117187;4880.438749543812;4901;4925.3597032385915;4973.950260497385;5049.4698056704065;4992.625553083533;5034.773435195389;5081.415637201732;5081.618878584121;5089.3638295213095;4971.204607262856;4974.850754477371;4990.575801056914;4992.650514463989;4997.850064498035;5360.973195134038;5439.3200849893765;5466.890662186734;5482.945170548283;5497.670139791625;5776.220210271602;5825.650460972355;5870.090136028923;5892;5981.7308221129715;5928.6739229342365;5943.167956486095;5943.64338139713;5946.97026514869;5948.256467941507;5536.667799931976;5548.500634942875;5549.500544950974;5550.417206193372;5555.111182210827;5815.476607105381;5823.505002074787;5895.056790913433;5960.523158147338;5967.403259673998;5696.202531645573;5740.397258287903;5746.798862039892;5753.223314852441;5757.683327417032;5788.507976822018;5833.79581714638;5838.474537291664;5840.970795146082;5845.357010728816;5837.387074357216;5845.795397161079;5847.912281315784;5850.210221620112;5905.320888097838;5841.269841269841;5854.151148083504;5858.53131749459;5861.267341582302;5862;4456.9331460028125;4496.392986946786;4497.865064048084;4510.233260345749;4533.569310915458;4009.7393669411395;4023.5372932113182;4043.595640435933;4044.373122166069;4072.9592704073175;5546.417626149197;5573.916391254134;5580.748866301026;5593.524550413179;5596.4123767003875;5747.5114615257335;5809.128630705428;5879.235699359141;5913.940860591425;5925.762969481172;5514.834554963358;5600.523955463831;5602.271704678447;5658.321001479849;5667.319921609434;5124.871878203075;5133.307003554547;5134.48655134491;5136.306598609214;5196.58427325813;5913.408659134052;5976.820695379146;6132.662703551258;6133.049377346519;6133.938660613426;5861.120831875252;5914.378990206139;5929.407059294036;5934.703264836828;5998.220231369894;6061.121137434959;6068.817935461943;6097.054956481752;6108.175396321618;6113.908291375722;5637.605287932389;5751.568632352507;5754.971225143848;5784.4504772046585;5802.65184088956;5899.026660600953;5899.233099697012;5915.674637894957;5942.881142377042;5972.940270597413;5736.053551164178;5742.224799651994;5746.597738158289;5751.309842818889;5758.107493338539;5556.194351819045;5642;5695.487406133468;5733.426657334233;5752.33848107473;5575.77696892136;5724.484796368347;5738.1679656450415;5784.595078344475;5789.710514474344;5724.169995350734;5725.885482290414;5762.7694892203845;5773.134029895381;5773.134029895549;5537.169424586345;5552.7778888843995;5586.301712285965;5622.297212848394;5629.155626656035 21:40:19 INFO - PROCESS | 21578 | |1;ext.html;549.3078993755379;569.3509399284815;577.6014549960524;585.1690599348924;593.4688453833819;42286;43380.34929476061;43543.78228108859;47010;47038;44667.77666111665;45127.99999999992;45159.77420112903;45176;45237;8973.641054357835;9096.272298216127;9113.088691130866;9131.406458580172;9138.451692898447;8884.689035883745;8950.820983580325;8957.37298389113;8957.50733709649;8993.685221017266;8959.64161433545;9013.32400069994;9040.819183616324;9069.95465022674;9070.183683468487;8881.333899957464;8975.192232699055;8990.05604411534;9029.638814447415;9058.773530661687;8900.821983560358;8918.19736223743;8922.643094276285;8939;8956.910430895672;41666.58333416688;41832.790836045926;41910.371344429856;41996.58003419957;42008;3364.66353364664;3454.8790792322397;3518.437050071976;3598.182917626608;3839.6928245740555;31046.223844403845;31507.684923150704;31508.842455787802;31560.842195789104;31894.681053189404;4269.210196113729;4294.849680261176;4425.7565833879125;4578.473475550321;4591.9081618367445;249219;252046;252871;253073;253097;31688.36623267568;56329.86062508788;56547;56699.433005669416;56705.71647141821;37505.24989500194;37553.24893502115;37614.81192594074;37737.24525509474;37854.62145378566;15745.68508629821;15806.762898556532;15874.52376428709;15877.285522151531;15877.841221587867;12275.447604857804;12340.259584424963;12343.567975120828;12360.505579776887;12374.81437778434;8514.787130321667;8537.487750734852;8586.441881277697;8604.139586041345;8612.09572994839;3344.247544302561;3358.865645374158;3371.915702107467;3376.1053320869987;3439.3121375724954;938.3478482454765;1012.3217444312328;1015.441507171053;1087.1954753482523;1106.159635571397;29386.971455999366;30503;30683.8465807674;30778.230544236572;31236.68763312383;1035.223582313265;1076.741582020325;1107.1530279336314;1115.7991561519004;1137.4710759496875;15668.216589170495;16238;16241.51275461738;16375;16649.750253746202;581403;589530;592957;912177;914002;55432.16851747227;55600;55657;55716;55787.16319255214;1266.5820279307807;1288.5232463988384;1331.0083987429427;1337.505123104438;1340.162398500937;29264;29456.683841170303;30013.849930750206;30570.679772303207;30623.693763062085;48617.491938911255;49182.75408622934;49239.01521969469;49357;49384.50615493799;303531;304588;305205;305595;307085;27886.3028424291;27938.441231175668;28078.85960570184;28334.858325709065;28508.42983140367;43711.34432983444;44722;44784;45727.77136114298;46236.53763462322;37705.43441848319;37863.64568074707;37922.2415551693;38108.428373573865;38160.618393815705;37194;37456.19779351795;37580;38730;40091.79954100211;37730.62269377381;37862.24275514529;37959.240815184094;37974.810125949196;38167.236655266184;32743.836280818443;33867.322653547286;34665.48001779925;35769.82115089408;35813.74651887172;27066.996185995966;27119;27267.727322726518;27272.454550909268;27469.450610988068 21:40:19 INFO - PROCESS | 21578 | |2;jquery.html;392.7682667226336;398.5078428141247;404.64391335624657;405.37572138906086;422.7167797575624;18463.723044154347;19165.04174791262;19335.709964350546;19561.315353962615;20091.799082009213;18129.555384476975;18759.43721688348;18836.811631883676;19035.143418546166;19206.231750729956;5211.348581427322;5322.281491998569;5703.600747947646;5815.970920145393;5826.951148793216;5785.623934444268;5856.882862342751;5859.7070146492715;5869.618474799125;5873.618214816023;5187.818426355078;5249.055170069386;5278.604104692145;5280.1815718563685;5726.1697053927155;5291.074062039147;5324.722066704002;5332.120200166987;5335.706536140511;5338.492843179892;5003.849884503471;5163.535281824654;5165.096108181053;5181.196914478224;5184.8963020739375;14035.50875719345;14133.929330353283;14790;23173.652395214085;23511.529769404686;2357.941051473727;2520.4329025969196;2662.6272321874953;2743.7530622243894;2891.898783542566;9889;10579.94710026445;11149.052330551913;11245.60640377591;15156.621084472867;1893.2237782509244;1907.5040489472838;1936.4243814338104;1938.6607343714793;1971.1031480676259;84505.57747211224;85367;86369.56815215947;87451;88259.11740882572;11055.391953442477;11120.443977801078;11340.489677964511;11421.257618254787;11711.238769479956;16213.513594592181;16243.51269461918;16383.017018978899;16391.42630007944;16456.424025159064;7753.689852405953;8033.517988920684;8094.797630059295;8313.792155196168;8319.376046796393;7502.699892004259;7590.316871481483;7653.196414376522;7790.883136752953;7806.219378062262;4776.068666610047;4814.494478079751;4814.9518504814505;4836.854894353175;5022.723750193774;1949.8635095543175;1977.7923318051685;2007.9397618071482;2070.896455177265;2085.7497100348055;909.3134683314056;918.7840857398506;977.4868194198103;980.6022133308121;995.8556009378744;17892.642147157243;19524.70712939307;19636.607267854564;19670.114844832016;20117;945.9621615135318;974.4348277998744;987.4667679453015;989.5151375825793;997.4962643864947;10558.52486638103;10826.945865270623;11061.391623460788;11113.666590002313;11187.944060279646;427724;429116;436299;438100;440407;87530;87895;88574;89239.4146497555;90712;949.3544389814854;955.1833182628752;972.9951350243203;979.3732011512637;991.9702408927744;15768;16546.83453165501;16840.410585629445;17065.232064557375;17283;41631.7918410406;42054;42248.36627450529;42304.78847605742;42369.915610126984;50457;55895.16157257726;56346.7182664084;56877.71561142168;57287.71356143193;6454.451371633276;7188.28117188277;8382.203690649378;8607.311415086904;8744.519051451976;11079.612213572485;13063;13133.868661313647;13410.865891340962;13587.79618305746;10608;10740.30188037775;10877.67366978992;10903.454827258764;10908.727281818017;10409.42748148859;10712.89287107119;10717.196210284104;11217.214794964275;11839.171258011856;11316.321020738782;11341.26281791681;11587.130965177477;11623.012043976356;11809.881901180877;8496.70261540843;8535.573221338784;8563.95718021406;8609.225169734755;8654.22112009922;10502.317349372266;10949.178811589321;11153;11340.716482088013;11522.711932201762 21:40:19 INFO - PROCESS | 21578 | |3;mootools.html;1479.349086401983;1513.8410466900975;1647.5716313758426;1744.5638590352412;1756.999999999999;8650.134986501347;9010.098990101003;9326.860097098548;9371.531423428836;9387.859182112265;9353.62585496581;9428.622855085805;9493.430394176354;9516.429014259149;9533;2322.222055611368;2361.799247063993;2363.444590521226;2370.277065495023;2375.9168429104984;2317.640765681322;2327.5461285049423;2329.056732023533;2345.5074434368717;2362.6928499295154;2326.8603883766946;2352.482453860148;2353.3410645019335;2354.693889794333;2354.8704821234824;2194.211017740418;2220.1785339424437;2224.310463756233;2231.843770936027;2248.347979086063;2210.3258506155616;2212.1704360864674;2219.03471989685;2221.9888900555557;2230.542738738555;9150.450972941579;9183.954080229623;9194.08059194082;9227.630894764268;9232.492212928286;5138.638260860875;5172.818951336685;5178.4562620924635;5190.584753219733;5192.3249977503065;3153.5427363032463;3180.904572862818;3296.868125274986;3338.2488939988307;3340.7494437917253;1070.6948519671855;1073.3881687438163;1083.7344850511597;1102.7408558988632;1104.7403860092872;12496.937515312366;12538.561150359785;12542.122051456401;12572;12621.116521843474;4349.064951035542;4409.867703968886;4564.334018083376;4570.405847239837;4619.145458090264;9816.901830981742;9823.214142868554;9867.654632087842;9903.25725570585;9955.402675839472;5222.190560463135;5236.502532259429;5238.764255608507;5242.239875218072;5243.056249875059;4306.763128027926;4470.374147619336;4687.367205427292;4790.209615413488;4896;3738.420544815558;3894.7857867817543;3909.6090390960676;3954.3277642800217;3960.108975480494;1155.6359746679768;1157.8610566732045;1160.9129315301386;1165.6036947437742;1175.2243519277235;692.9029935808991;808.1231863428246;811.2860682599274;824.2293455619016;829.2702421868837;5634.549236061105;5666.886662266814;5688.8862222755315;5831.591788574844;5888.381719919433;454.7430701653555;456.6255670350281;458.3491442152152;460.10279954089657;470.2828187014761;3731.0792019497444;3801.790901500389;3887;3891.0661441253897;3910.9804450977563;10912.127029837595;11400.429978501043;11421.543138274543;11439.714007149722;11443.084553235722;11015;11140.442977851075;11309.264897781783;11330.376829274304;11334.829977550344;8307.750767476986;8313.376496762767;8400.117987611335;8474.152584741476;8480.643097104434;5623.8875222496135;5654.406287339934;5718.79984200551;5813.157092221689;5873;10001.54993025301;10364.948175259377;10381.325213861075;10381.896181038395;10460.529276182742;10425.53085111187;10440.37357758537;10553.788924221626;10580.682579522627;10599.470026498799;7732.458727888994;7865.056193256846;7980.640871160927;8048.114707382067;8160;8300.584970751559;8475.237228649452;8480.363972701949;8482.321414286718;8493.108223636676;7324.157721862054;7411.184769675439;7523;7573.129090154483;7601.505902116345;7153.928460715326;7481.326680598772;7522.172561018393;7535.849283014419;7729.768106956575;7039.084918960502;7179.8564028720175;7206.927930720625;7213.386862116569;7227.674754636159;5121.974390128025;5165.92251116226;5170.612204084633;5373.570114390917;5377.8117765878005;4987.10232158215;4997.625178111729;5015;5065.341505604248;5123.257127716386 21:40:19 INFO - PROCESS | 21578 | |4;prototype.html;322.725683169306;334.5968108429343;337.21933723430254;342.18901204146175;344.9913752156194;5484.835454936353;5609.915851262234;5616.691081990499;5617.803376881805;5625.662460252388;5452.59105567082;5492.697901615419;5514.972425137868;5532.474414930575;5551.141162301418;3829.6744776694013;4110.527289361724;4189.853355132571;4201.495820501544;4223.197592457439;4247.490301163864;4250.407251576536;4264.530901600821;4275.187714334282;4276.722013069156;4239.978800105995;4253.978730106345;4257.510386305584;4301.311790113583;4301.870943871673;4026.9194616107516;4290.506591741942;4292.699511034229;4302.569743025703;4321.027768752037;3717.739758216926;3726.912928759903;3736.1220113273357;3771.622837716234;3784.9053773655605;5439.972800135974;5441.1838224266285;5462.562994960394;5471.206675032098;5495;4794.592459640935;4908.361912951329;4926.901461970776;4931.619146638946;4944.851654450372;5677.517411020068;5724.82641058582;5739.253896993364;5763.971180144114;5775.044094795079;4038.3134867072667;4059.5128584569748;4073.837046518165;4092.3656833190903;4093.1199792044554;5672.06410942194;5782.855428614318;5894.145348924425;5997.970010149965;6039.335673075958;4116.835326586963;4137.46212992309;4146.66826653873;4165.271077561415;4166.145940082276;4203.369494575838;4210.5578914214175;4218.282891908383;4218.78906054696;4222.894427639334;4626.467956185014;4851.641540368702;4851.781669824866;4866.245731911559;4907.7300748458465;5717.571182161271;5761.798337058183;5785.363610002896;5806.506446952057;5859.355470898197;1466.6846627975037;1467.5670677150267;1481.4962912609549;1481.9259037048105;1482.5255918106102;915.0756753837812;937.4937533731845;943.8489841625307;946.929969134887;962.8638206915906;4914.262860570943;4924.9507504924495;4926;4929.9154186079;4976.2286845539;5213.087709650796;5213.947860521422;5221.373435187802;5234.319538459976;5291.391489978625;4609.677322587454;4923.310736496894;4944.184209605447;4963.783872951078;4964.60283177345;2777.7916656250864;2778.3885346498982;2786.7909906757072;2789.2747885549497;2789.972100279012;5338.371796601996;5358.38309141328;5361.8123365682795;5393.352797664227;5425.728713564306;5270.947290527122;5276.551493123127;5650.01124803166;6030.728617212236;6090.269167699905;6087.634741915499;6138.232720909887;6170.691465426711;6171.47542458896;6178.969105154445;5676.716164191691;5988.760449581968;6000.309964354155;6005.948958932257;6028.186194863637;5828;5847.298324200953;5863.853403664943;5877.119321816977;5883.705814709333;5895.818547137586;5928.087462274878;6062.787802426894;6069.666168360783;6170.865520101633;4234.237837189212;4270.466191726035;4290.699651024398;4324.11900823143;4324.56754324565;5754.4533269339345;5927.170196172626;5940.257467816523;5945.583809133319;5959.4207535004125;5737.627054241461;5739.339975902824;5747.252857128547;5762;5785;5753.424657534213;5773.191753154478;5774.2782152230975;5777.62445441045;5823.650580965155;5565.193047008081;5713.885722285614;5733.799317023884;5763.94236057634;5815.447532484407;5772.94227057724;5781.94218057814;5792.594518383673;5803.694168811983;5811.128330750252;5658.292713410824;5680.375158732619;5685.346185188756;5687.956943035456;5692.52375216782 21:40:19 INFO - PROCESS | 21578 | |5;yui.html;708.9184743754469;725.2874250303865;799.2007992007993;816.6937398475571;818.2758258940836;14778.778318325234;15966.201689915515;15967.840321596781;15977.121258330788;16069;14556.199409032499;14648.633784155374;14954.62613434662;14990.175540345277;15662.686746265068;786.7561056072607;792.6948124971899;795.9920400795976;797.0515087046397;798.6086817459446;791.4380789639363;815.0301141641428;822.56404105824;824.3693574415577;824.4146655874337;857.6355049104137;858.2018722587991;860.0496451421184;860.3031544449017;862.659249596409;852.3607294529103;852.7697521669114;853.0147679430268;853.4836423963537;855.2986551028129;626.9843253918689;628.6542401679059;628.9998901746245;630.8769789890928;632.993670063298;14833.258337083103;14890.106593604418;14907.70184596302;14932.850671493256;14939.1036537807;14127.364268607937;14885.776713349309;15097.54707358781;15200.391984320613;15218.923905380512;11896.286222826659;11901.404929753478;12256.387180640932;12303.69240768988;12487.625371238877;3622.9275414491826;3626.4197728363597;3648.908777280589;3666.834992425347;3724.608916063801;76393;76618.61690691511;76849;76892.23107768907;77944.22055779483;11335.943320283512;11349.205555611028;11550.249233799776;11775.411229438494;12001.91934742192;21619.35141945744;21852.781472185074;21918.561628767337;21954.560908781736;21986.780132198473;8204.425690201748;8212.425130240827;8316.501009939422;8540.572971351408;8544.74365769028;4504.25679762842;4587.495375508692;4591.563801438858;4607.861764147081;4645.047765208192;3334.683205095512;3443.741719371057;3462.5844898612327;3464.7055000325254;3471.7396195285455;594.1948659566226;604.5314880967286;638.8562573420943;669.5848573884223;671.509797847574;603.2218438214654;637.7895294552786;650.5413683353224;653.6796969484918;721.6896734404152;8866.351542711272;8905.708672242488;9052.27581793455;9194.678186263449;9341.252699784001;548.5830768615881;634.5811764235582;655.1973832055694;656.5076192855358;669.2738378858895;4562.977185114053;4621.514740952151;4667.393238878924;4695.647826413033;4725.929111063337;116356.41821790837;117029.41485292518;118859.40570297094;121347;122160;81351.59324203459;82148.58925705333;83597;107921;108919;56880.71559642175;79246.6037669808;82341;82381.58809205916;84261;8657.437266577905;9116.042815504541;9372.76568085776;9462.763430914281;9586.904130958601;48879.75560122177;49015;49819.750901245265;50476;51632.22551661653;67752.3224767746;73937;75696.62151689206;75815;77017.61491192508;12805.487780488676;12821.294828784507;12881.742365152832;12977.664020476404;13178.670533236362;14398.928005359907;14742.557723268319;14763.261836908327;15092.320845562195;15919.920400397923;13876.930615346859;13970.790438143233;14028.22844743549;14115.717685646025;14402.567922962327;13970.161790292615;14177.432902683777;14425.300216304999;14661.633459163606;14706.970512064052;13133.540326088541;13214;13697.452101916211;14071.296435178405;14373.496927607484;10625.468726563795;11065.944670276596;11373.488193031168;11517.94241028823;11806.232594881305;9434.433933963985;10514.947425262824;10852.511636976513;11498.435484999676;12096.516139354328 21:40:19 INFO - PROCESS | 21578 | __end_tp_report 21:40:19 INFO - PROCESS | 21578 | __start_cc_report 21:40:19 INFO - PROCESS | 21578 | _x_x_mozilla_cycle_collect,299 21:40:19 INFO - PROCESS | 21578 | __end_cc_report 21:40:19 INFO - PROCESS | 21578 | __startTimestamp1475124019126__endTimestamp 21:40:19 INFO - PROCESS | 21578 | 21:40:19 INFO - PROCESS | 21578 | ------- Summary: start ------- 21:40:19 INFO - PROCESS | 21578 | Number of tests: 6 21:40:19 INFO - PROCESS | 21578 | 21:40:19 INFO - PROCESS | 21578 | [#0] dojo.html Cycles:165 Average:5453.40 Median:5658.32 stddev:621.06 (11.0%) stddev-sans-first:593.48 21:40:19 INFO - PROCESS | 21578 | Values: 3043.1 3076.7 3085.6 3098.1 3114.2 5277.4 5409.5 5457.0 5471.8 5509.3 5335.6 5403.1 5420.1 5487.1 5547.7 4878.0 4966.6 5025.2 5031.4 5087.0 5048.4 5096.4 5100.9 5107.0 5109.3 4880.4 4901.0 4925.4 4974.0 5049.5 4992.6 5034.8 5081.4 5081.6 5089.4 4971.2 4974.9 4990.6 4992.7 4997.9 5361.0 5439.3 5466.9 5482.9 5497.7 5776.2 5825.7 5870.1 5892.0 5981.7 5928.7 5943.2 5943.6 5947.0 5948.3 5536.7 5548.5 5549.5 5550.4 5555.1 5815.5 5823.5 5895.1 5960.5 5967.4 5696.2 5740.4 5746.8 5753.2 5757.7 5788.5 5833.8 5838.5 5841.0 5845.4 5837.4 5845.8 5847.9 5850.2 5905.3 5841.3 5854.2 5858.5 5861.3 5862.0 4456.9 4496.4 4497.9 4510.2 4533.6 4009.7 4023.5 4043.6 4044.4 4073.0 5546.4 5573.9 5580.7 5593.5 5596.4 5747.5 5809.1 5879.2 5913.9 5925.8 5514.8 5600.5 5602.3 5658.3 5667.3 5124.9 5133.3 5134.5 5136.3 5196.6 5913.4 5976.8 6132.7 6133.0 6133.9 5861.1 5914.4 5929.4 5934.7 5998.2 6061.1 6068.8 6097.1 6108.2 6113.9 5637.6 5751.6 5755.0 5784.5 5802.7 5899.0 5899.2 5915.7 5942.9 5972.9 5736.1 5742.2 5746.6 5751.3 5758.1 5556.2 5642.0 5695.5 5733.4 5752.3 5575.8 5724.5 5738.2 5784.6 5789.7 5724.2 5725.9 5762.8 5773.1 5773.1 5537.2 5552.8 5586.3 5622.3 5629.2 21:40:19 INFO - PROCESS | 21578 | 21:40:19 INFO - PROCESS | 21578 | [#1] ext.html Cycles:180 Average:57093.78 Median:37892.94 stddev:130411.55 (344.2%) stddev-sans-first:130708.29 21:40:19 INFO - PROCESS | 21578 | Values: 549.3 569.4 577.6 585.2 593.5 42286.0 43380.3 43543.8 47010.0 47038.0 44667.8 45128.0 45159.8 45176.0 45237.0 8973.6 9096.3 9113.1 9131.4 9138.5 8884.7 8950.8 8957.4 8957.5 8993.7 8959.6 9013.3 9040.8 9070.0 9070.2 8881.3 8975.2 8990.1 9029.6 9058.8 8900.8 8918.2 8922.6 8939.0 8956.9 41666.6 41832.8 41910.4 41996.6 42008.0 3364.7 3454.9 3518.4 3598.2 3839.7 31046.2 31507.7 31508.8 31560.8 31894.7 4269.2 4294.8 4425.8 4578.5 4591.9 249219.0 252046.0 252871.0 253073.0 253097.0 31688.4 56329.9 56547.0 56699.4 56705.7 37505.2 37553.2 37614.8 37737.2 37854.6 15745.7 15806.8 15874.5 15877.3 15877.8 12275.4 12340.3 12343.6 12360.5 12374.8 8514.8 8537.5 8586.4 8604.1 8612.1 3344.2 3358.9 3371.9 3376.1 3439.3 938.3 1012.3 1015.4 1087.2 1106.2 29387.0 30503.0 30683.8 30778.2 31236.7 1035.2 1076.7 1107.2 1115.8 1137.5 15668.2 16238.0 16241.5 16375.0 16649.8 581403.0 589530.0 592957.0 912177.0 914002.0 55432.2 55600.0 55657.0 55716.0 55787.2 1266.6 1288.5 1331.0 1337.5 1340.2 29264.0 29456.7 30013.8 30570.7 30623.7 48617.5 49182.8 49239.0 49357.0 49384.5 303531.0 304588.0 305205.0 305595.0 307085.0 27886.3 27938.4 28078.9 28334.9 28508.4 43711.3 44722.0 44784.0 45727.8 46236.5 37705.4 37863.6 37922.2 38108.4 38160.6 37194.0 37456.2 37580.0 38730.0 40091.8 37730.6 37862.2 37959.2 37974.8 38167.2 32743.8 33867.3 34665.5 35769.8 35813.7 27067.0 27119.0 27267.7 27272.5 27469.5 21:40:19 INFO - PROCESS | 21578 | 21:40:19 INFO - PROCESS | 21578 | [#2] jquery.html Cycles:180 Average:27244.72 Median:21335.54 stddev:72008.14 (337.5%) stddev-sans-first:72181.91 21:40:19 INFO - PROCESS | 21578 | Values: 392.8 398.5 404.6 405.4 422.7 18463.7 19165.0 19335.7 19561.3 20091.8 18129.6 18759.4 18836.8 19035.1 19206.2 5211.3 5322.3 5703.6 5816.0 5827.0 5785.6 5856.9 5859.7 5869.6 5873.6 5187.8 5249.1 5278.6 5280.2 5726.2 5291.1 5324.7 5332.1 5335.7 5338.5 5003.8 5163.5 5165.1 5181.2 5184.9 14035.5 14133.9 14790.0 23173.7 23511.5 2357.9 2520.4 2662.6 2743.8 2891.9 9889.0 10579.9 11149.1 11245.6 15156.6 1893.2 1907.5 1936.4 1938.7 1971.1 84505.6 85367.0 86369.6 87451.0 88259.1 11055.4 11120.4 11340.5 11421.3 11711.2 16213.5 16243.5 16383.0 16391.4 16456.4 7753.7 8033.5 8094.8 8313.8 8319.4 7502.7 7590.3 7653.2 7790.9 7806.2 4776.1 4814.5 4815.0 4836.9 5022.7 1949.9 1977.8 2007.9 2070.9 2085.7 909.3 918.8 977.5 980.6 995.9 17892.6 19524.7 19636.6 19670.1 20117.0 946.0 974.4 987.5 989.5 997.5 10558.5 10826.9 11061.4 11113.7 11187.9 427724.0 429116.0 436299.0 438100.0 440407.0 87530.0 87895.0 88574.0 89239.4 90712.0 949.4 955.2 973.0 979.4 992.0 15768.0 16546.8 16840.4 17065.2 17283.0 41631.8 42054.0 42248.4 42304.8 42369.9 50457.0 55895.2 56346.7 56877.7 57287.7 6454.5 7188.3 8382.2 8607.3 8744.5 11079.6 13063.0 13133.9 13410.9 13587.8 10608.0 10740.3 10877.7 10903.5 10908.7 10409.4 10712.9 10717.2 11217.2 11839.2 11316.3 11341.3 11587.1 11623.0 11809.9 8496.7 8535.6 8564.0 8609.2 8654.2 10502.3 10949.2 11153.0 11340.7 11522.7 21:40:19 INFO - PROCESS | 21578 | 21:40:19 INFO - PROCESS | 21578 | [#3] mootools.html Cycles:180 Average:5819.12 Median:4653.26 stddev:3433.38 (73.8%) stddev-sans-first:3427.53 21:40:19 INFO - PROCESS | 21578 | Values: 1479.3 1513.8 1647.6 1744.6 1757.0 8650.1 9010.1 9326.9 9371.5 9387.9 9353.6 9428.6 9493.4 9516.4 9533.0 2322.2 2361.8 2363.4 2370.3 2375.9 2317.6 2327.5 2329.1 2345.5 2362.7 2326.9 2352.5 2353.3 2354.7 2354.9 2194.2 2220.2 2224.3 2231.8 2248.3 2210.3 2212.2 2219.0 2222.0 2230.5 9150.5 9184.0 9194.1 9227.6 9232.5 5138.6 5172.8 5178.5 5190.6 5192.3 3153.5 3180.9 3296.9 3338.2 3340.7 1070.7 1073.4 1083.7 1102.7 1104.7 12496.9 12538.6 12542.1 12572.0 12621.1 4349.1 4409.9 4564.3 4570.4 4619.1 9816.9 9823.2 9867.7 9903.3 9955.4 5222.2 5236.5 5238.8 5242.2 5243.1 4306.8 4470.4 4687.4 4790.2 4896.0 3738.4 3894.8 3909.6 3954.3 3960.1 1155.6 1157.9 1160.9 1165.6 1175.2 692.9 808.1 811.3 824.2 829.3 5634.5 5666.9 5688.9 5831.6 5888.4 454.7 456.6 458.3 460.1 470.3 3731.1 3801.8 3887.0 3891.1 3911.0 10912.1 11400.4 11421.5 11439.7 11443.1 11015.0 11140.4 11309.3 11330.4 11334.8 8307.8 8313.4 8400.1 8474.2 8480.6 5623.9 5654.4 5718.8 5813.2 5873.0 10001.5 10364.9 10381.3 10381.9 10460.5 10425.5 10440.4 10553.8 10580.7 10599.5 7732.5 7865.1 7980.6 8048.1 8160.0 8300.6 8475.2 8480.4 8482.3 8493.1 7324.2 7411.2 7523.0 7573.1 7601.5 7153.9 7481.3 7522.2 7535.8 7729.8 7039.1 7179.9 7206.9 7213.4 7227.7 5122.0 5165.9 5170.6 5373.6 5377.8 4987.1 4997.6 5015.0 5065.3 5123.3 21:40:19 INFO - PROCESS | 21578 | 21:40:19 INFO - PROCESS | 21578 | [#4] prototype.html Cycles:180 Average:4757.72 Median:5409.54 stddev:1412.89 (26.1%) stddev-sans-first:1377.08 21:40:19 INFO - PROCESS | 21578 | Values: 322.7 334.6 337.2 342.2 345.0 5484.8 5609.9 5616.7 5617.8 5625.7 5452.6 5492.7 5515.0 5532.5 5551.1 3829.7 4110.5 4189.9 4201.5 4223.2 4247.5 4250.4 4264.5 4275.2 4276.7 4240.0 4254.0 4257.5 4301.3 4301.9 4026.9 4290.5 4292.7 4302.6 4321.0 3717.7 3726.9 3736.1 3771.6 3784.9 5440.0 5441.2 5462.6 5471.2 5495.0 4794.6 4908.4 4926.9 4931.6 4944.9 5677.5 5724.8 5739.3 5764.0 5775.0 4038.3 4059.5 4073.8 4092.4 4093.1 5672.1 5782.9 5894.1 5998.0 6039.3 4116.8 4137.5 4146.7 4165.3 4166.1 4203.4 4210.6 4218.3 4218.8 4222.9 4626.5 4851.6 4851.8 4866.2 4907.7 5717.6 5761.8 5785.4 5806.5 5859.4 1466.7 1467.6 1481.5 1481.9 1482.5 915.1 937.5 943.8 946.9 962.9 4914.3 4925.0 4926.0 4929.9 4976.2 5213.1 5213.9 5221.4 5234.3 5291.4 4609.7 4923.3 4944.2 4963.8 4964.6 2777.8 2778.4 2786.8 2789.3 2790.0 5338.4 5358.4 5361.8 5393.4 5425.7 5270.9 5276.6 5650.0 6030.7 6090.3 6087.6 6138.2 6170.7 6171.5 6179.0 5676.7 5988.8 6000.3 6005.9 6028.2 5828.0 5847.3 5863.9 5877.1 5883.7 5895.8 5928.1 6062.8 6069.7 6170.9 4234.2 4270.5 4290.7 4324.1 4324.6 5754.5 5927.2 5940.3 5945.6 5959.4 5737.6 5739.3 5747.3 5762.0 5785.0 5753.4 5773.2 5774.3 5777.6 5823.7 5565.2 5713.9 5733.8 5763.9 5815.4 5772.9 5781.9 5792.6 5803.7 5811.1 5658.3 5680.4 5685.3 5688.0 5692.5 21:40:19 INFO - PROCESS | 21578 | 21:40:19 INFO - PROCESS | 21578 | [#5] yui.html Cycles:180 Average:20499.00 Median:4614.69 stddev:29433.68 (637.8%) stddev-sans-first:29478.74 21:40:19 INFO - PROCESS | 21578 | Values: 708.9 725.3 799.2 816.7 818.3 14778.8 15966.2 15967.8 15977.1 16069.0 14556.2 14648.6 14954.6 14990.2 15662.7 786.8 792.7 796.0 797.1 798.6 791.4 815.0 822.6 824.4 824.4 857.6 858.2 860.0 860.3 862.7 852.4 852.8 853.0 853.5 855.3 627.0 628.7 629.0 630.9 633.0 14833.3 14890.1 14907.7 14932.9 14939.1 14127.4 14885.8 15097.5 15200.4 15218.9 11896.3 11901.4 12256.4 12303.7 12487.6 3622.9 3626.4 3648.9 3666.8 3724.6 76393.0 76618.6 76849.0 76892.2 77944.2 11335.9 11349.2 11550.2 11775.4 12001.9 21619.4 21852.8 21918.6 21954.6 21986.8 8204.4 8212.4 8316.5 8540.6 8544.7 4504.3 4587.5 4591.6 4607.9 4645.0 3334.7 3443.7 3462.6 3464.7 3471.7 594.2 604.5 638.9 669.6 671.5 603.2 637.8 650.5 653.7 721.7 8866.4 8905.7 9052.3 9194.7 9341.3 548.6 634.6 655.2 656.5 669.3 4563.0 4621.5 4667.4 4695.6 4725.9 116356.4 117029.4 118859.4 121347.0 122160.0 81351.6 82148.6 83597.0 107921.0 108919.0 56880.7 79246.6 82341.0 82381.6 84261.0 8657.4 9116.0 9372.8 9462.8 9586.9 48879.8 49015.0 49819.8 50476.0 51632.2 67752.3 73937.0 75696.6 75815.0 77017.6 12805.5 12821.3 12881.7 12977.7 13178.7 14398.9 14742.6 14763.3 15092.3 15919.9 13876.9 13970.8 14028.2 14115.7 14402.6 13970.2 14177.4 14425.3 14661.6 14707.0 13133.5 13214.0 13697.5 14071.3 14373.5 10625.5 11065.9 11373.5 11517.9 11806.2 9434.4 10514.9 10852.5 11498.4 12096.5 21:40:19 INFO - PROCESS | 21578 | -------- Summary: end -------- 21:40:19 INFO - PROCESS | 21578 | 21:40:20 INFO - TEST-INFO | 21578: exit 0 21:40:20 INFO - TEST-OK | dromaeo_css | took 1115069ms 21:40:20 INFO - TEST-START | kraken 21:40:20 INFO - operating with platform_type : linux_ 21:40:20 INFO - Initialising browser for kraken test... 21:40:20 INFO - TEST-INFO | started process 21932 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzOMMvM/profile http://localhost:41733/getInfo.html) 21:40:25 INFO - PROCESS | 21932 | __metrics Screen width/height:1600/1200 21:40:25 INFO - PROCESS | 21932 | colorDepth:24 21:40:25 INFO - PROCESS | 21932 | Browser inner width/height: 1024/697 21:40:25 INFO - PROCESS | 21932 | __metrics 21:40:26 ERROR - PROCESS | 21932 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3076: TypeError: this.tabs is undefined 21:40:27 INFO - TEST-INFO | 21932: exit 0 21:40:27 INFO - Browser initialized. 21:40:27 INFO - Running cycle 1/1 for kraken test... 21:40:27 INFO - TEST-INFO | started process 22056 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpzOMMvM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:40:40 INFO - PROCESS | 22056 | RSS: Main: 185389056 21:40:40 INFO - PROCESS | 22056 | 21:40:42 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41733/tests/kraken/driver.html?testName=audio-beat-detection) 21:40:43 INFO - PROCESS | 22056 | RSS: Main: 199094272 21:40:43 INFO - PROCESS | 22056 | 21:40:46 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41733/tests/kraken/driver.html?testName=audio-dft) 21:40:46 INFO - PROCESS | 22056 | RSS: Main: 197210112 21:40:46 INFO - PROCESS | 22056 | 21:40:49 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41733/tests/kraken/driver.html?testName=audio-fft) 21:40:50 INFO - PROCESS | 22056 | RSS: Main: 192667648 21:40:50 INFO - PROCESS | 22056 | 21:40:52 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41733/tests/kraken/driver.html?testName=audio-oscillator) 21:40:53 INFO - PROCESS | 22056 | RSS: Main: 193159168 21:40:53 INFO - PROCESS | 22056 | 21:40:55 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41733/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:40:55 INFO - PROCESS | 22056 | RSS: Main: 193691648 21:40:55 INFO - PROCESS | 22056 | 21:40:58 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41733/tests/kraken/driver.html?testName=imaging-darkroom) 21:40:59 INFO - PROCESS | 22056 | RSS: Main: 193622016 21:40:59 INFO - PROCESS | 22056 | 21:41:02 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41733/tests/kraken/driver.html?testName=imaging-desaturate) 21:41:03 INFO - PROCESS | 22056 | RSS: Main: 193855488 21:41:03 INFO - PROCESS | 22056 | 21:41:06 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41733/tests/kraken/driver.html?testName=json-parse-financial) 21:41:07 INFO - PROCESS | 22056 | RSS: Main: 194269184 21:41:07 INFO - PROCESS | 22056 | 21:41:08 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41733/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:41:09 INFO - PROCESS | 22056 | RSS: Main: 193941504 21:41:09 INFO - PROCESS | 22056 | 21:41:10 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41733/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:41:11 INFO - PROCESS | 22056 | RSS: Main: 194142208 21:41:11 INFO - PROCESS | 22056 | 21:41:13 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41733/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:41:14 INFO - PROCESS | 22056 | RSS: Main: 194400256 21:41:14 INFO - PROCESS | 22056 | 21:41:16 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:41:17 INFO - PROCESS | 22056 | RSS: Main: 193978368 21:41:17 INFO - PROCESS | 22056 | 21:41:20 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:41:21 INFO - PROCESS | 22056 | RSS: Main: 194506752 21:41:21 INFO - PROCESS | 22056 | 21:41:22 INFO - PROCESS | 22056 | Cycle 1(1): loaded http://localhost:41733/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41733/tests/kraken/driver.html?testName=ai-astar) 21:41:23 INFO - PROCESS | 22056 | RSS: Main: 196165632 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | __start_tp_report 21:41:23 INFO - PROCESS | 22056 | _x_x_mozilla_page_load 21:41:23 INFO - PROCESS | 22056 | _x_x_mozilla_page_load_details 21:41:23 INFO - PROCESS | 22056 | |i|pagename|runs| 21:41:23 INFO - PROCESS | 22056 | |0;ai-astar;104;113;115;115;114;113;113;113;113;111 21:41:23 INFO - PROCESS | 22056 | |1;audio-beat-detection;153;120;124;172;125;126;124;121;159;123 21:41:23 INFO - PROCESS | 22056 | |2;audio-dft;163;163;165;164;178;162;163;163;164;163 21:41:23 INFO - PROCESS | 22056 | |3;audio-fft;76;78;77;110;76;76;76;77;102;80 21:41:23 INFO - PROCESS | 22056 | |4;audio-oscillator;83;82;114;82;83;82;103;83;83;117 21:41:23 INFO - PROCESS | 22056 | |5;imaging-gaussian-blur;117;118;118;117;117;117;118;117;117;119 21:41:23 INFO - PROCESS | 22056 | |6;imaging-darkroom;150;147;146;147;147;147;149;147;147;146 21:41:23 INFO - PROCESS | 22056 | |7;imaging-desaturate;96;96;97;96;95;96;96;95;96;96 21:41:23 INFO - PROCESS | 22056 | |8;json-parse-financial;54;53;54;54;56;54;53;54;53;55 21:41:23 INFO - PROCESS | 22056 | |9;json-stringify-tinderbox;59;61;60;60;60;59;61;60;61;61 21:41:23 INFO - PROCESS | 22056 | |10;stanford-crypto-aes;81;80;79;79;79;80;79;79;78;81 21:41:23 INFO - PROCESS | 22056 | |11;stanford-crypto-ccm;130;126;125;133;137;127;134;124;155;135 21:41:23 INFO - PROCESS | 22056 | |12;stanford-crypto-pbkdf2;167;170;174;169;169;170;172;170;169;168 21:41:23 INFO - PROCESS | 22056 | |13;stanford-crypto-sha256-iterative;66;66;65;65;73;65;67;66;66;66 21:41:23 INFO - PROCESS | 22056 | __end_tp_report 21:41:23 INFO - PROCESS | 22056 | __start_cc_report 21:41:23 INFO - PROCESS | 22056 | _x_x_mozilla_cycle_collect,744 21:41:23 INFO - PROCESS | 22056 | __end_cc_report 21:41:23 INFO - PROCESS | 22056 | __startTimestamp1475124083009__endTimestamp 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | ------- Summary: start ------- 21:41:23 INFO - PROCESS | 22056 | Number of tests: 14 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#0] ai-astar Cycles:10 Average:112.40 Median:113.00 stddev:3.17 (2.8%) stddev-sans-first:1.22 21:41:23 INFO - PROCESS | 22056 | Values: 104.0 113.0 115.0 115.0 114.0 113.0 113.0 113.0 113.0 111.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#1] audio-beat-detection Cycles:10 Average:134.70 Median:125.50 stddev:19.02 (15.2%) stddev-sans-first:18.99 21:41:23 INFO - PROCESS | 22056 | Values: 153.0 120.0 124.0 172.0 125.0 126.0 124.0 121.0 159.0 123.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#2] audio-dft Cycles:10 Average:164.80 Median:163.50 stddev:4.71 (2.9%) stddev-sans-first:4.95 21:41:23 INFO - PROCESS | 22056 | Values: 163.0 163.0 165.0 164.0 178.0 162.0 163.0 163.0 164.0 163.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#3] audio-fft Cycles:10 Average:82.80 Median:76.50 stddev:12.43 (16.3%) stddev-sans-first:12.94 21:41:23 INFO - PROCESS | 22056 | Values: 76.0 78.0 77.0 110.0 76.0 76.0 76.0 77.0 102.0 80.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#4] audio-oscillator Cycles:10 Average:91.20 Median:82.50 stddev:14.33 (17.4%) stddev-sans-first:14.89 21:41:23 INFO - PROCESS | 22056 | Values: 83.0 82.0 114.0 82.0 83.0 82.0 103.0 83.0 83.0 117.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.50 stddev:0.71 (0.6%) stddev-sans-first:0.73 21:41:23 INFO - PROCESS | 22056 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 118.0 117.0 117.0 119.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.00 stddev:1.25 (0.9%) stddev-sans-first:0.87 21:41:23 INFO - PROCESS | 22056 | Values: 150.0 147.0 146.0 147.0 147.0 147.0 149.0 147.0 147.0 146.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:96.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 21:41:23 INFO - PROCESS | 22056 | Values: 96.0 96.0 97.0 96.0 95.0 96.0 96.0 95.0 96.0 96.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.00 stddev:0.94 (1.7%) stddev-sans-first:1.00 21:41:23 INFO - PROCESS | 22056 | Values: 54.0 53.0 54.0 54.0 56.0 54.0 53.0 54.0 53.0 55.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.50 stddev:0.79 (1.3%) stddev-sans-first:0.71 21:41:23 INFO - PROCESS | 22056 | Values: 59.0 61.0 60.0 60.0 60.0 59.0 61.0 60.0 61.0 61.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#10] stanford-crypto-aes Cycles:10 Average:79.50 Median:79.50 stddev:0.97 (1.2%) stddev-sans-first:0.87 21:41:23 INFO - PROCESS | 22056 | Values: 81.0 80.0 79.0 79.0 79.0 80.0 79.0 79.0 78.0 81.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#11] stanford-crypto-ccm Cycles:10 Average:132.60 Median:133.50 stddev:9.08 (6.8%) stddev-sans-first:9.58 21:41:23 INFO - PROCESS | 22056 | Values: 130.0 126.0 125.0 133.0 137.0 127.0 134.0 124.0 155.0 135.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.80 Median:170.00 stddev:1.99 (1.2%) stddev-sans-first:1.83 21:41:23 INFO - PROCESS | 22056 | Values: 167.0 170.0 174.0 169.0 169.0 170.0 172.0 170.0 169.0 168.0 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.50 Median:66.00 stddev:2.37 (3.6%) stddev-sans-first:2.51 21:41:23 INFO - PROCESS | 22056 | Values: 66.0 66.0 65.0 65.0 73.0 65.0 67.0 66.0 66.0 66.0 21:41:23 INFO - PROCESS | 22056 | -------- Summary: end -------- 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | ###!!! [Parent][MessageChannel] Error: (msgtype=0x2000B,name=PAPZ::Msg_Destroy) Channel error: cannot send/recv 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | 21:41:23 INFO - PROCESS | 22056 | ###!!! [Parent][OnMaybeDequeueOne] Error: Channel error: cannot send/recv 21:41:23 INFO - PROCESS | 22056 | 21:41:24 INFO - TEST-INFO | 22056: exit 0 21:41:24 INFO - TEST-OK | kraken | took 64019ms 21:41:24 INFO - SUITE-END | took 1179s 21:41:24 INFO - Completed test suite (00:19:39) 21:41:24 INFO - javascript benchmark 21:41:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7127.212053566233, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3043.117495926181, 3076.723094921457, 3085.6142982127235, 3098.0705788263517, 3114.2214446388402, 5277.445868183843, 5409.513143817056, 5457.017736807378, 5471.753771080301, 5509.283793106891, 5335.626506144571, 5403.135498320269, 5420.051490989081, 5487.094629386156, 5547.7226138693, 4878.0, 4966.553010229079, 5025.1708468102715, 5031.4465408805, 5086.97456512717, 5048.394192696882, 5096.388433387999, 5100.923486147711, 5107.0, 5109.310243117187, 4880.438749543812, 4901.0, 4925.3597032385915, 4973.950260497385, 5049.4698056704065, 4992.625553083533, 5034.773435195389, 5081.415637201732, 5081.618878584121, 5089.3638295213095, 4971.204607262856, 4974.850754477371, 4990.575801056914, 4992.650514463989, 4997.850064498035, 5360.973195134038, 5439.3200849893765, 5466.890662186734, 5482.945170548283, 5497.670139791625, 5776.220210271602, 5825.650460972355, 5870.090136028923, 5892.0, 5981.7308221129715, 5928.6739229342365, 5943.167956486095, 5943.64338139713, 5946.97026514869, 5948.256467941507, 5536.667799931976, 5548.500634942875, 5549.500544950974, 5550.417206193372, 5555.111182210827, 5815.476607105381, 5823.505002074787, 5895.056790913433, 5960.523158147338, 5967.403259673998, 5696.202531645573, 5740.397258287903, 5746.798862039892, 5753.223314852441, 5757.683327417032, 5788.507976822018, 5833.79581714638, 5838.474537291664, 5840.970795146082, 5845.357010728816, 5837.387074357216, 5845.795397161079, 5847.912281315784, 5850.210221620112, 5905.320888097838, 5841.269841269841, 5854.151148083504, 5858.53131749459, 5861.267341582302, 5862.0, 4456.9331460028125, 4496.392986946786, 4497.865064048084, 4510.233260345749, 4533.569310915458, 4009.7393669411395, 4023.5372932113182, 4043.595640435933, 4044.373122166069, 4072.9592704073175, 5546.417626149197, 5573.916391254134, 5580.748866301026, 5593.524550413179, 5596.4123767003875, 5747.5114615257335, 5809.128630705428, 5879.235699359141, 5913.940860591425, 5925.762969481172, 5514.834554963358, 5600.523955463831, 5602.271704678447, 5658.321001479849, 5667.319921609434, 5124.871878203075, 5133.307003554547, 5134.48655134491, 5136.306598609214, 5196.58427325813, 5913.408659134052, 5976.820695379146, 6132.662703551258, 6133.049377346519, 6133.938660613426, 5861.120831875252, 5914.378990206139, 5929.407059294036, 5934.703264836828, 5998.220231369894, 6061.121137434959, 6068.817935461943, 6097.054956481752, 6108.175396321618, 6113.908291375722, 5637.605287932389, 5751.568632352507, 5754.971225143848, 5784.4504772046585, 5802.65184088956, 5899.026660600953, 5899.233099697012, 5915.674637894957, 5942.881142377042, 5972.940270597413, 5736.053551164178, 5742.224799651994, 5746.597738158289, 5751.309842818889, 5758.107493338539, 5556.194351819045, 5642.0, 5695.487406133468, 5733.426657334233, 5752.33848107473, 5575.77696892136, 5724.484796368347, 5738.1679656450415, 5784.595078344475, 5789.710514474344, 5724.169995350734, 5725.885482290414, 5762.7694892203845, 5773.134029895381, 5773.134029895549, 5537.169424586345, 5552.7778888843995, 5586.301712285965, 5622.297212848394, 5629.155626656035], "value": 5410.553635457434, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [549.3078993755379, 569.3509399284815, 577.6014549960524, 585.1690599348924, 593.4688453833819, 42286.0, 43380.34929476061, 43543.78228108859, 47010.0, 47038.0, 44667.77666111665, 45127.99999999992, 45159.77420112903, 45176.0, 45237.0, 8973.641054357835, 9096.272298216127, 9113.088691130866, 9131.406458580172, 9138.451692898447, 8884.689035883745, 8950.820983580325, 8957.37298389113, 8957.50733709649, 8993.685221017266, 8959.64161433545, 9013.32400069994, 9040.819183616324, 9069.95465022674, 9070.183683468487, 8881.333899957464, 8975.192232699055, 8990.05604411534, 9029.638814447415, 9058.773530661687, 8900.821983560358, 8918.19736223743, 8922.643094276285, 8939.0, 8956.910430895672, 41666.58333416688, 41832.790836045926, 41910.371344429856, 41996.58003419957, 42008.0, 3364.66353364664, 3454.8790792322397, 3518.437050071976, 3598.182917626608, 3839.6928245740555, 31046.223844403845, 31507.684923150704, 31508.842455787802, 31560.842195789104, 31894.681053189404, 4269.210196113729, 4294.849680261176, 4425.7565833879125, 4578.473475550321, 4591.9081618367445, 249219.0, 252046.0, 252871.0, 253073.0, 253097.0, 31688.36623267568, 56329.86062508788, 56547.0, 56699.433005669416, 56705.71647141821, 37505.24989500194, 37553.24893502115, 37614.81192594074, 37737.24525509474, 37854.62145378566, 15745.68508629821, 15806.762898556532, 15874.52376428709, 15877.285522151531, 15877.841221587867, 12275.447604857804, 12340.259584424963, 12343.567975120828, 12360.505579776887, 12374.81437778434, 8514.787130321667, 8537.487750734852, 8586.441881277697, 8604.139586041345, 8612.09572994839, 3344.247544302561, 3358.865645374158, 3371.915702107467, 3376.1053320869987, 3439.3121375724954, 938.3478482454765, 1012.3217444312328, 1015.441507171053, 1087.1954753482523, 1106.159635571397, 29386.971455999366, 30503.0, 30683.8465807674, 30778.230544236572, 31236.68763312383, 1035.223582313265, 1076.741582020325, 1107.1530279336314, 1115.7991561519004, 1137.4710759496875, 15668.216589170495, 16238.0, 16241.51275461738, 16375.0, 16649.750253746202, 581403.0, 589530.0, 592957.0, 912177.0, 914002.0, 55432.16851747227, 55600.0, 55657.0, 55716.0, 55787.16319255214, 1266.5820279307807, 1288.5232463988384, 1331.0083987429427, 1337.505123104438, 1340.162398500937, 29264.0, 29456.683841170303, 30013.849930750206, 30570.679772303207, 30623.693763062085, 48617.491938911255, 49182.75408622934, 49239.01521969469, 49357.0, 49384.50615493799, 303531.0, 304588.0, 305205.0, 305595.0, 307085.0, 27886.3028424291, 27938.441231175668, 28078.85960570184, 28334.858325709065, 28508.42983140367, 43711.34432983444, 44722.0, 44784.0, 45727.77136114298, 46236.53763462322, 37705.43441848319, 37863.64568074707, 37922.2415551693, 38108.428373573865, 38160.618393815705, 37194.0, 37456.19779351795, 37580.0, 38730.0, 40091.79954100211, 37730.62269377381, 37862.24275514529, 37959.240815184094, 37974.810125949196, 38167.236655266184, 32743.836280818443, 33867.322653547286, 34665.48001779925, 35769.82115089408, 35813.74651887172, 27066.996185995966, 27119.0, 27267.727322726518, 27272.454550909268, 27469.450610988068], "value": 18400.989639409454, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [392.7682667226336, 398.5078428141247, 404.64391335624657, 405.37572138906086, 422.7167797575624, 18463.723044154347, 19165.04174791262, 19335.709964350546, 19561.315353962615, 20091.799082009213, 18129.555384476975, 18759.43721688348, 18836.811631883676, 19035.143418546166, 19206.231750729956, 5211.348581427322, 5322.281491998569, 5703.600747947646, 5815.970920145393, 5826.951148793216, 5785.623934444268, 5856.882862342751, 5859.7070146492715, 5869.618474799125, 5873.618214816023, 5187.818426355078, 5249.055170069386, 5278.604104692145, 5280.1815718563685, 5726.1697053927155, 5291.074062039147, 5324.722066704002, 5332.120200166987, 5335.706536140511, 5338.492843179892, 5003.849884503471, 5163.535281824654, 5165.096108181053, 5181.196914478224, 5184.8963020739375, 14035.50875719345, 14133.929330353283, 14790.0, 23173.652395214085, 23511.529769404686, 2357.941051473727, 2520.4329025969196, 2662.6272321874953, 2743.7530622243894, 2891.898783542566, 9889.0, 10579.94710026445, 11149.052330551913, 11245.60640377591, 15156.621084472867, 1893.2237782509244, 1907.5040489472838, 1936.4243814338104, 1938.6607343714793, 1971.1031480676259, 84505.57747211224, 85367.0, 86369.56815215947, 87451.0, 88259.11740882572, 11055.391953442477, 11120.443977801078, 11340.489677964511, 11421.257618254787, 11711.238769479956, 16213.513594592181, 16243.51269461918, 16383.017018978899, 16391.42630007944, 16456.424025159064, 7753.689852405953, 8033.517988920684, 8094.797630059295, 8313.792155196168, 8319.376046796393, 7502.699892004259, 7590.316871481483, 7653.196414376522, 7790.883136752953, 7806.219378062262, 4776.068666610047, 4814.494478079751, 4814.9518504814505, 4836.854894353175, 5022.723750193774, 1949.8635095543175, 1977.7923318051685, 2007.9397618071482, 2070.896455177265, 2085.7497100348055, 909.3134683314056, 918.7840857398506, 977.4868194198103, 980.6022133308121, 995.8556009378744, 17892.642147157243, 19524.70712939307, 19636.607267854564, 19670.114844832016, 20117.0, 945.9621615135318, 974.4348277998744, 987.4667679453015, 989.5151375825793, 997.4962643864947, 10558.52486638103, 10826.945865270623, 11061.391623460788, 11113.666590002313, 11187.944060279646, 427724.0, 429116.0, 436299.0, 438100.0, 440407.0, 87530.0, 87895.0, 88574.0, 89239.4146497555, 90712.0, 949.3544389814854, 955.1833182628752, 972.9951350243203, 979.3732011512637, 991.9702408927744, 15768.0, 16546.83453165501, 16840.410585629445, 17065.232064557375, 17283.0, 41631.7918410406, 42054.0, 42248.36627450529, 42304.78847605742, 42369.915610126984, 50457.0, 55895.16157257726, 56346.7182664084, 56877.71561142168, 57287.71356143193, 6454.451371633276, 7188.28117188277, 8382.203690649378, 8607.311415086904, 8744.519051451976, 11079.612213572485, 13063.0, 13133.868661313647, 13410.865891340962, 13587.79618305746, 10608.0, 10740.30188037775, 10877.67366978992, 10903.454827258764, 10908.727281818017, 10409.42748148859, 10712.89287107119, 10717.196210284104, 11217.214794964275, 11839.171258011856, 11316.321020738782, 11341.26281791681, 11587.130965177477, 11623.012043976356, 11809.881901180877, 8496.70261540843, 8535.573221338784, 8563.95718021406, 8609.225169734755, 8654.22112009922, 10502.317349372266, 10949.178811589321, 11153.0, 11340.716482088013, 11522.711932201762], "value": 9051.624453125374, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1479.349086401983, 1513.8410466900975, 1647.5716313758426, 1744.5638590352412, 1756.999999999999, 8650.134986501347, 9010.098990101003, 9326.860097098548, 9371.531423428836, 9387.859182112265, 9353.62585496581, 9428.622855085805, 9493.430394176354, 9516.429014259149, 9533.0, 2322.222055611368, 2361.799247063993, 2363.444590521226, 2370.277065495023, 2375.9168429104984, 2317.640765681322, 2327.5461285049423, 2329.056732023533, 2345.5074434368717, 2362.6928499295154, 2326.8603883766946, 2352.482453860148, 2353.3410645019335, 2354.693889794333, 2354.8704821234824, 2194.211017740418, 2220.1785339424437, 2224.310463756233, 2231.843770936027, 2248.347979086063, 2210.3258506155616, 2212.1704360864674, 2219.03471989685, 2221.9888900555557, 2230.542738738555, 9150.450972941579, 9183.954080229623, 9194.08059194082, 9227.630894764268, 9232.492212928286, 5138.638260860875, 5172.818951336685, 5178.4562620924635, 5190.584753219733, 5192.3249977503065, 3153.5427363032463, 3180.904572862818, 3296.868125274986, 3338.2488939988307, 3340.7494437917253, 1070.6948519671855, 1073.3881687438163, 1083.7344850511597, 1102.7408558988632, 1104.7403860092872, 12496.937515312366, 12538.561150359785, 12542.122051456401, 12572.0, 12621.116521843474, 4349.064951035542, 4409.867703968886, 4564.334018083376, 4570.405847239837, 4619.145458090264, 9816.901830981742, 9823.214142868554, 9867.654632087842, 9903.25725570585, 9955.402675839472, 5222.190560463135, 5236.502532259429, 5238.764255608507, 5242.239875218072, 5243.056249875059, 4306.763128027926, 4470.374147619336, 4687.367205427292, 4790.209615413488, 4896.0, 3738.420544815558, 3894.7857867817543, 3909.6090390960676, 3954.3277642800217, 3960.108975480494, 1155.6359746679768, 1157.8610566732045, 1160.9129315301386, 1165.6036947437742, 1175.2243519277235, 692.9029935808991, 808.1231863428246, 811.2860682599274, 824.2293455619016, 829.2702421868837, 5634.549236061105, 5666.886662266814, 5688.8862222755315, 5831.591788574844, 5888.381719919433, 454.7430701653555, 456.6255670350281, 458.3491442152152, 460.10279954089657, 470.2828187014761, 3731.0792019497444, 3801.790901500389, 3887.0, 3891.0661441253897, 3910.9804450977563, 10912.127029837595, 11400.429978501043, 11421.543138274543, 11439.714007149722, 11443.084553235722, 11015.0, 11140.442977851075, 11309.264897781783, 11330.376829274304, 11334.829977550344, 8307.750767476986, 8313.376496762767, 8400.117987611335, 8474.152584741476, 8480.643097104434, 5623.8875222496135, 5654.406287339934, 5718.79984200551, 5813.157092221689, 5873.0, 10001.54993025301, 10364.948175259377, 10381.325213861075, 10381.896181038395, 10460.529276182742, 10425.53085111187, 10440.37357758537, 10553.788924221626, 10580.682579522627, 10599.470026498799, 7732.458727888994, 7865.056193256846, 7980.640871160927, 8048.114707382067, 8160.0, 8300.584970751559, 8475.237228649452, 8480.363972701949, 8482.321414286718, 8493.108223636676, 7324.157721862054, 7411.184769675439, 7523.0, 7573.129090154483, 7601.505902116345, 7153.928460715326, 7481.326680598772, 7522.172561018393, 7535.849283014419, 7729.768106956575, 7039.084918960502, 7179.8564028720175, 7206.927930720625, 7213.386862116569, 7227.674754636159, 5121.974390128025, 5165.92251116226, 5170.612204084633, 5373.570114390917, 5377.8117765878005, 4987.10232158215, 4997.625178111729, 5015.0, 5065.341505604248, 5123.257127716386], "value": 4510.621069818576, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [322.725683169306, 334.5968108429343, 337.21933723430254, 342.18901204146175, 344.9913752156194, 5484.835454936353, 5609.915851262234, 5616.691081990499, 5617.803376881805, 5625.662460252388, 5452.59105567082, 5492.697901615419, 5514.972425137868, 5532.474414930575, 5551.141162301418, 3829.6744776694013, 4110.527289361724, 4189.853355132571, 4201.495820501544, 4223.197592457439, 4247.490301163864, 4250.407251576536, 4264.530901600821, 4275.187714334282, 4276.722013069156, 4239.978800105995, 4253.978730106345, 4257.510386305584, 4301.311790113583, 4301.870943871673, 4026.9194616107516, 4290.506591741942, 4292.699511034229, 4302.569743025703, 4321.027768752037, 3717.739758216926, 3726.912928759903, 3736.1220113273357, 3771.622837716234, 3784.9053773655605, 5439.972800135974, 5441.1838224266285, 5462.562994960394, 5471.206675032098, 5495.0, 4794.592459640935, 4908.361912951329, 4926.901461970776, 4931.619146638946, 4944.851654450372, 5677.517411020068, 5724.82641058582, 5739.253896993364, 5763.971180144114, 5775.044094795079, 4038.3134867072667, 4059.5128584569748, 4073.837046518165, 4092.3656833190903, 4093.1199792044554, 5672.06410942194, 5782.855428614318, 5894.145348924425, 5997.970010149965, 6039.335673075958, 4116.835326586963, 4137.46212992309, 4146.66826653873, 4165.271077561415, 4166.145940082276, 4203.369494575838, 4210.5578914214175, 4218.282891908383, 4218.78906054696, 4222.894427639334, 4626.467956185014, 4851.641540368702, 4851.781669824866, 4866.245731911559, 4907.7300748458465, 5717.571182161271, 5761.798337058183, 5785.363610002896, 5806.506446952057, 5859.355470898197, 1466.6846627975037, 1467.5670677150267, 1481.4962912609549, 1481.9259037048105, 1482.5255918106102, 915.0756753837812, 937.4937533731845, 943.8489841625307, 946.929969134887, 962.8638206915906, 4914.262860570943, 4924.9507504924495, 4926.0, 4929.9154186079, 4976.2286845539, 5213.087709650796, 5213.947860521422, 5221.373435187802, 5234.319538459976, 5291.391489978625, 4609.677322587454, 4923.310736496894, 4944.184209605447, 4963.783872951078, 4964.60283177345, 2777.7916656250864, 2778.3885346498982, 2786.7909906757072, 2789.2747885549497, 2789.972100279012, 5338.371796601996, 5358.38309141328, 5361.8123365682795, 5393.352797664227, 5425.728713564306, 5270.947290527122, 5276.551493123127, 5650.01124803166, 6030.728617212236, 6090.269167699905, 6087.634741915499, 6138.232720909887, 6170.691465426711, 6171.47542458896, 6178.969105154445, 5676.716164191691, 5988.760449581968, 6000.309964354155, 6005.948958932257, 6028.186194863637, 5828.0, 5847.298324200953, 5863.853403664943, 5877.119321816977, 5883.705814709333, 5895.818547137586, 5928.087462274878, 6062.787802426894, 6069.666168360783, 6170.865520101633, 4234.237837189212, 4270.466191726035, 4290.699651024398, 4324.11900823143, 4324.56754324565, 5754.4533269339345, 5927.170196172626, 5940.257467816523, 5945.583809133319, 5959.4207535004125, 5737.627054241461, 5739.339975902824, 5747.252857128547, 5762.0, 5785.0, 5753.424657534213, 5773.191753154478, 5774.2782152230975, 5777.62445441045, 5823.650580965155, 5565.193047008081, 5713.885722285614, 5733.799317023884, 5763.94236057634, 5815.447532484407, 5772.94227057724, 5781.94218057814, 5792.594518383673, 5803.694168811983, 5811.128330750252, 5658.292713410824, 5680.375158732619, 5685.346185188756, 5687.956943035456, 5692.52375216782], "value": 4306.383531866153, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [708.9184743754469, 725.2874250303865, 799.2007992007993, 816.6937398475571, 818.2758258940836, 14778.778318325234, 15966.201689915515, 15967.840321596781, 15977.121258330788, 16069.0, 14556.199409032499, 14648.633784155374, 14954.62613434662, 14990.175540345277, 15662.686746265068, 786.7561056072607, 792.6948124971899, 795.9920400795976, 797.0515087046397, 798.6086817459446, 791.4380789639363, 815.0301141641428, 822.56404105824, 824.3693574415577, 824.4146655874337, 857.6355049104137, 858.2018722587991, 860.0496451421184, 860.3031544449017, 862.659249596409, 852.3607294529103, 852.7697521669114, 853.0147679430268, 853.4836423963537, 855.2986551028129, 626.9843253918689, 628.6542401679059, 628.9998901746245, 630.8769789890928, 632.993670063298, 14833.258337083103, 14890.106593604418, 14907.70184596302, 14932.850671493256, 14939.1036537807, 14127.364268607937, 14885.776713349309, 15097.54707358781, 15200.391984320613, 15218.923905380512, 11896.286222826659, 11901.404929753478, 12256.387180640932, 12303.69240768988, 12487.625371238877, 3622.9275414491826, 3626.4197728363597, 3648.908777280589, 3666.834992425347, 3724.608916063801, 76393.0, 76618.61690691511, 76849.0, 76892.23107768907, 77944.22055779483, 11335.943320283512, 11349.205555611028, 11550.249233799776, 11775.411229438494, 12001.91934742192, 21619.35141945744, 21852.781472185074, 21918.561628767337, 21954.560908781736, 21986.780132198473, 8204.425690201748, 8212.425130240827, 8316.501009939422, 8540.572971351408, 8544.74365769028, 4504.25679762842, 4587.495375508692, 4591.563801438858, 4607.861764147081, 4645.047765208192, 3334.683205095512, 3443.741719371057, 3462.5844898612327, 3464.7055000325254, 3471.7396195285455, 594.1948659566226, 604.5314880967286, 638.8562573420943, 669.5848573884223, 671.509797847574, 603.2218438214654, 637.7895294552786, 650.5413683353224, 653.6796969484918, 721.6896734404152, 8866.351542711272, 8905.708672242488, 9052.27581793455, 9194.678186263449, 9341.252699784001, 548.5830768615881, 634.5811764235582, 655.1973832055694, 656.5076192855358, 669.2738378858895, 4562.977185114053, 4621.514740952151, 4667.393238878924, 4695.647826413033, 4725.929111063337, 116356.41821790837, 117029.41485292518, 118859.40570297094, 121347.0, 122160.0, 81351.59324203459, 82148.58925705333, 83597.0, 107921.0, 108919.0, 56880.71559642175, 79246.6037669808, 82341.0, 82381.58809205916, 84261.0, 8657.437266577905, 9116.042815504541, 9372.76568085776, 9462.763430914281, 9586.904130958601, 48879.75560122177, 49015.0, 49819.750901245265, 50476.0, 51632.22551661653, 67752.3224767746, 73937.0, 75696.62151689206, 75815.0, 77017.61491192508, 12805.487780488676, 12821.294828784507, 12881.742365152832, 12977.664020476404, 13178.670533236362, 14398.928005359907, 14742.557723268319, 14763.261836908327, 15092.320845562195, 15919.920400397923, 13876.930615346859, 13970.790438143233, 14028.22844743549, 14115.717685646025, 14402.567922962327, 13970.161790292615, 14177.432902683777, 14425.300216304999, 14661.633459163606, 14706.970512064052, 13133.540326088541, 13214.0, 13697.452101916211, 14071.296435178405, 14373.496927607484, 10625.468726563795, 11065.944670276596, 11373.488193031168, 11517.94241028823, 11806.232594881305, 9434.433933963985, 10514.947425262824, 10852.511636976513, 11498.435484999676, 12096.516139354328], "value": 7487.179601867793, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1509.1999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 113.0, 115.0, 115.0, 114.0, 113.0, 113.0, 113.0, 113.0, 111.0], "value": 112.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 120.0, 124.0, 172.0, 125.0, 126.0, 124.0, 121.0, 159.0, 123.0], "value": 134.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 163.0, 165.0, 164.0, 178.0, 162.0, 163.0, 163.0, 164.0, 163.0], "value": 164.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 77.0, 110.0, 76.0, 76.0, 76.0, 77.0, 102.0, 80.0], "value": 82.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 82.0, 114.0, 82.0, 83.0, 82.0, 103.0, 83.0, 83.0, 117.0], "value": 91.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 119.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 147.0, 146.0, 147.0, 147.0, 147.0, 149.0, 147.0, 147.0, 146.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 53.0, 54.0, 54.0, 56.0, 54.0, 53.0, 54.0, 53.0, 55.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [59.0, 61.0, 60.0, 60.0, 60.0, 59.0, 61.0, 60.0, 61.0, 61.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 79.0, 79.0, 80.0, 79.0, 79.0, 78.0, 81.0], "value": 79.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 126.0, 125.0, 133.0, 137.0, 127.0, 134.0, 124.0, 155.0, 135.0], "value": 132.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 170.0, 174.0, 169.0, 169.0, 170.0, 172.0, 170.0, 169.0, 168.0], "value": 169.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 65.0, 65.0, 73.0, 65.0, 67.0, 66.0, 66.0, 66.0], "value": 66.5, "unit": "score"}]}]} 21:41:24 INFO - Return code: 0 21:41:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:41:24 ERROR - # TBPL SUCCESS # 21:41:24 INFO - Running post-action listener: _resource_record_post_action 21:41:24 INFO - [mozharness: 2016-09-29 04:41:24.815197Z] Finished run-tests step (success) 21:41:24 INFO - Running post-run listener: _resource_record_post_run 21:41:24 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 20480; Write bytes: 410959872; Read time: 8; Write time: 483012 21:41:24 INFO - TinderboxPrint: CPU usage
13.4% 21:41:24 INFO - TinderboxPrint: I/O read bytes / time
20,480 / 8 21:41:24 INFO - TinderboxPrint: I/O write bytes / time
410,959,872 / 483,012 21:41:24 INFO - TinderboxPrint: CPU idle
8,266.2 (86.6%) 21:41:24 INFO - TinderboxPrint: CPU user
1,209.8 (12.7%) 21:41:24 INFO - TinderboxPrint: Swap in / out
0 / 0 21:41:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 114491392; Read time: 0; Write time: 88548 21:41:24 INFO - run-tests - Wall time: 1180s; CPU: 13.0%; Read bytes: 16384; Write bytes: 295571456; Read time: 0; Write time: 394436 21:41:25 INFO - Running post-run listener: _upload_blobber_files 21:41:25 INFO - Blob upload gear active. 21:41:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:41:25 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 21:41:25 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'] 21:41:25 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 21:41:25 INFO - (blobuploader) - INFO - Open directory for files ... 21:41:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 21:41:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:41:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:41:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 21:41:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:41:26 INFO - (blobuploader) - INFO - Done attempting. 21:41:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 21:41:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:41:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:41:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 21:41:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:41:27 INFO - (blobuploader) - INFO - Done attempting. 21:41:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:41:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:41:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:41:32 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:41:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:41:32 INFO - (blobuploader) - INFO - Done attempting. 21:41:32 INFO - (blobuploader) - INFO - Iteration through files over. 21:41:32 INFO - Return code: 0 21:41:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:41:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:41:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b13e15bc5b3e91a21e114d23b500e3be155029c9d4339fd07fc31fde70c295cd6b928db1b2114182b04dcf2595668f577fe012e7940b636d2d288c1c2c0832a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf59c7147ab3e2f5f6cd701ea991b6231081e6c7927e804f37ddd76e62d07a82277e3776986a2929a6e82aff467cf2829fe01418452d084dfec2c4532aa8ce08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30c949a60a31320b7383ee80d6a72c0c089ecdc8fe4952255fb3ab0b08e4a4990e1c966d6a4733d6c2a6d7c2b8b4442d74f876708340420cf44940f9ae1b8652"} 21:41:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:41:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:41:32 INFO - Contents: 21:41:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b13e15bc5b3e91a21e114d23b500e3be155029c9d4339fd07fc31fde70c295cd6b928db1b2114182b04dcf2595668f577fe012e7940b636d2d288c1c2c0832a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf59c7147ab3e2f5f6cd701ea991b6231081e6c7927e804f37ddd76e62d07a82277e3776986a2929a6e82aff467cf2829fe01418452d084dfec2c4532aa8ce08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30c949a60a31320b7383ee80d6a72c0c089ecdc8fe4952255fb3ab0b08e4a4990e1c966d6a4733d6c2a6d7c2b8b4442d74f876708340420cf44940f9ae1b8652"} 21:41:32 INFO - Running post-run listener: copy_logs_to_upload_dir 21:41:32 INFO - Copying logs to upload dir... 21:41:32 INFO - mkdir: /builds/slave/test/build/upload/logs 21:41:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.523233 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-09-28 21:41:31.886191) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 21:41:31.892171) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945 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/5b13e15bc5b3e91a21e114d23b500e3be155029c9d4339fd07fc31fde70c295cd6b928db1b2114182b04dcf2595668f577fe012e7940b636d2d288c1c2c0832a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf59c7147ab3e2f5f6cd701ea991b6231081e6c7927e804f37ddd76e62d07a82277e3776986a2929a6e82aff467cf2829fe01418452d084dfec2c4532aa8ce08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30c949a60a31320b7383ee80d6a72c0c089ecdc8fe4952255fb3ab0b08e4a4990e1c966d6a4733d6c2a6d7c2b8b4442d74f876708340420cf44940f9ae1b8652"} build_url:https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011363 build_url: 'https://queue.taskcluster.net/v1/task/GSG2Ar-MQ92XsrtTF95iSw/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/5b13e15bc5b3e91a21e114d23b500e3be155029c9d4339fd07fc31fde70c295cd6b928db1b2114182b04dcf2595668f577fe012e7940b636d2d288c1c2c0832a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/bf59c7147ab3e2f5f6cd701ea991b6231081e6c7927e804f37ddd76e62d07a82277e3776986a2929a6e82aff467cf2829fe01418452d084dfec2c4532aa8ce08", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/30c949a60a31320b7383ee80d6a72c0c089ecdc8fe4952255fb3ab0b08e4a4990e1c966d6a4733d6c2a6d7c2b8b4442d74f876708340420cf44940f9ae1b8652"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-28 21:41:31.918334) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:41:31.918727) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5cf47e208febbcd81da23b2e0000026f-1475122622.44619-1410580945 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004498 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-28 21:41:32.004004) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 21:41:32.004366) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-28 21:41:32.004776) ========= ========= Total master_lag: 0.18 =========