builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-051 starttime: 1474963858.9 results: success (0) buildid: 20160926233117 builduid: b84b9620f44b4c6b82a9168e022eaed6 revision: df63260c1c90ea8ff0a5a314fbcae9365854abb0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:58.896298) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:58.896750) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:58.897071) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:58.957464) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:58.957812) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-09-27 01:10:59-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 50.6M=0s 2016-09-27 01:10:59 (50.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.133590 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:59.113976) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:59.114311) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023327 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:59.167939) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:59.168311) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df63260c1c90ea8ff0a5a314fbcae9365854abb0 --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 df63260c1c90ea8ff0a5a314fbcae9365854abb0 --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=5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-09-27 01:10:59,635 truncating revision to first 12 chars 2016-09-27 01:10:59,635 Setting DEBUG logging. 2016-09-27 01:10:59,635 attempt 1/10 2016-09-27 01:10:59,635 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df63260c1c90?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-09-27 01:10:59,943 unpacking tar archive at: fx-team-df63260c1c90/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675300 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:59.857195) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:59.857515) ========= script_repo_revision: df63260c1c90ea8ff0a5a314fbcae9365854abb0 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:59.857949) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:59.858282) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-09-27 01:10:59.867904) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-27 01:10:59.868231) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:11:00 INFO - MultiFileLogger online at 20160927 01:11:00 in /builds/slave/test 01:11:00 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 01:11:00 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:11:00 INFO - {'append_to_log': False, 01:11:00 INFO - 'base_work_dir': '/builds/slave/test', 01:11:00 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 01:11:00 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:11:00 INFO - 'branch': 'Fx-Team-Non-PGO', 01:11:00 INFO - 'buildbot_json_path': 'buildprops.json', 01:11:00 INFO - 'config_files': ('talos/linux_config.py',), 01:11:00 INFO - 'default_actions': ('clobber', 01:11:00 INFO - 'read-buildbot-config', 01:11:00 INFO - 'download-and-extract', 01:11:00 INFO - 'populate-webroot', 01:11:00 INFO - 'create-virtualenv', 01:11:00 INFO - 'install', 01:11:00 INFO - 'run-tests'), 01:11:00 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:11:00 INFO - 'download_minidump_stackwalk': True, 01:11:00 INFO - 'download_symbols': 'ondemand', 01:11:00 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:11:00 INFO - 'tooltool.py': '/tools/tooltool.py', 01:11:00 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:11:00 INFO - '/tools/misc-python/virtualenv.py')}, 01:11:00 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:11:00 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:11:00 INFO - 'installer_path': 'installer.exe', 01:11:00 INFO - 'log_level': 'info', 01:11:00 INFO - 'log_name': 'talos', 01:11:00 INFO - 'log_to_console': True, 01:11:00 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:11:00 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:11:00 INFO - 'opt_config_files': (), 01:11:00 INFO - 'pip_index': False, 01:11:00 INFO - 'sps_profile': False, 01:11:00 INFO - 'sps_profile_interval': 0, 01:11:00 INFO - 'suite': 'dromaeojs-e10s', 01:11:00 INFO - 'system_bits': '32', 01:11:00 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:11:00 INFO - 'title': 'talos-linux64-ix-051', 01:11:00 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:11:00 INFO - 'use_talos_json': True, 01:11:00 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:11:00 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:11:00 INFO - 'work_dir': 'build'} 01:11:00 INFO - [mozharness: 2016-09-27 08:11:00.433419Z] Running clobber step. 01:11:00 INFO - Running pre-action listener: _resource_record_pre_action 01:11:00 INFO - Running main action method: clobber 01:11:00 INFO - rmtree: /builds/slave/test/build 01:11:00 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:11:00 INFO - Running post-action listener: _resource_record_post_action 01:11:00 INFO - [mozharness: 2016-09-27 08:11:00.892640Z] Finished clobber step (success) 01:11:00 INFO - [mozharness: 2016-09-27 08:11:00.892739Z] Running read-buildbot-config step. 01:11:00 INFO - Running pre-action listener: _resource_record_pre_action 01:11:00 INFO - Running main action method: read_buildbot_config 01:11:00 INFO - Using buildbot properties: 01:11:00 INFO - { 01:11:00 INFO - "project": "", 01:11:00 INFO - "product": "firefox", 01:11:00 INFO - "script_repo_revision": "production", 01:11:00 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 01:11:00 INFO - "repository": "", 01:11:00 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 01:11:00 INFO - "buildid": "20160926233117", 01:11:00 INFO - "pgo_build": "False", 01:11:00 INFO - "basedir": "/builds/slave/test", 01:11:00 INFO - "buildnumber": 1602, 01:11:00 INFO - "slavename": "talos-linux64-ix-051", 01:11:00 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:11:00 INFO - "platform": "ubuntu64_hw", 01:11:00 INFO - "scheduler": "tests-fx-team-linux64-talos-8-3600", 01:11:00 INFO - "branch": "fx-team", 01:11:00 INFO - "repo_path": "integration/fx-team", 01:11:00 INFO - "revision": "df63260c1c90ea8ff0a5a314fbcae9365854abb0", 01:11:00 INFO - "stage_platform": "linux64", 01:11:00 INFO - "builduid": "b84b9620f44b4c6b82a9168e022eaed6", 01:11:00 INFO - "slavebuilddir": "test" 01:11:00 INFO - } 01:11:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2. 01:11:00 INFO - Running post-action listener: _resource_record_post_action 01:11:00 INFO - [mozharness: 2016-09-27 08:11:00.895177Z] Finished read-buildbot-config step (success) 01:11:00 INFO - [mozharness: 2016-09-27 08:11:00.895264Z] Running download-and-extract step. 01:11:00 INFO - Running pre-action listener: _resource_record_pre_action 01:11:00 INFO - Running main action method: download_and_extract 01:11:00 INFO - mkdir: /builds/slave/test/build/tests 01:11:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:11:00 INFO - trying https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:11:00 INFO - Downloading https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/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 01:11:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/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 01:11:01 INFO - Downloaded 1361 bytes. 01:11:01 INFO - Reading from file /builds/slave/test/build/firefox-52.0a1.en-US.linux-x86_64.test_packages.json 01:11:01 INFO - Using the following test package requirements: 01:11:01 INFO - {u'common': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:11:01 INFO - u'cppunittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:11:01 INFO - u'gtest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:11:01 INFO - u'jittest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:11:01 INFO - u'jsshell-linux-x86_64.zip'], 01:11:01 INFO - u'mochitest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:11:01 INFO - u'mozbase': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'], 01:11:01 INFO - u'reftest': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:11:01 INFO - u'talos': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:11:01 INFO - u'web-platform': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:11:01 INFO - u'xpcshell': [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip', 01:11:01 INFO - u'firefox-52.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:11:01 INFO - Downloading packages: [u'firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:11:01 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:11:01 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:11:01 INFO - Fetch https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:11:02 INFO - Expected file size: 20410620 01:11:06 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 01:11:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip 01:11:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:11:06 INFO - Fetch https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.common.tests.zip into memory 01:11:06 INFO - Expected file size: 20410620 01:11:11 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip 01:11:11 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:11:11 INFO - Fetch https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.talos.tests.zip into memory 01:11:12 INFO - Expected file size: 14414057 01:11:12 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')]} 01:11:12 INFO - trying https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:11:12 INFO - Downloading https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/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 01:11:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/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 01:11:13 INFO - Downloaded 55744932 bytes. 01:11:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:11:13 INFO - mkdir: /builds/slave/test/properties 01:11:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:11:13 INFO - Writing to file /builds/slave/test/properties/build_url 01:11:13 INFO - Contents: 01:11:13 INFO - build_url:https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 01:11:14 INFO - Running post-action listener: _resource_record_post_action 01:11:14 INFO - Running post-action listener: set_extra_try_arguments 01:11:14 INFO - [mozharness: 2016-09-27 08:11:14.637078Z] Finished download-and-extract step (success) 01:11:14 INFO - [mozharness: 2016-09-27 08:11:14.637377Z] Running populate-webroot step. 01:11:14 INFO - Running pre-action listener: _resource_record_pre_action 01:11:14 INFO - Running main action method: populate_webroot 01:11:14 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:11:14 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:11:14 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:11:14 INFO - '--tppagecycles', 01:11:14 INFO - '7'], 01:11:14 INFO - 'tests': ['tsvgm']}}, 01:11:14 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:11:14 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:11:14 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:11:14 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:11:14 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:11:14 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:11:14 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:14 INFO - 'talos_options': ['--disable-e10s'], 01:11:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:11:14 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:14 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:11:14 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:14 INFO - 'talos_options': ['--disable-e10s'], 01:11:14 INFO - 'tests': ['damp', 'tps']}, 01:11:14 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:14 INFO - 'tests': ['damp', 'tps']}, 01:11:14 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:11:14 INFO - 'tests': ['dromaeo_dom']}, 01:11:14 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:11:14 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:11:14 INFO - 'tests': ['basic_compositor_video']}, 01:11:14 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:11:14 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:11:14 INFO - 'tests': ['a11yr', 01:11:14 INFO - 'ts_paint', 01:11:14 INFO - 'tpaint', 01:11:14 INFO - 'sessionrestore', 01:11:14 INFO - 'sessionrestore_no_auto_restore', 01:11:14 INFO - 'tabpaint']}, 01:11:14 INFO - 'other-e10s': {'tests': ['a11yr', 01:11:14 INFO - 'ts_paint', 01:11:14 INFO - 'tpaint', 01:11:14 INFO - 'sessionrestore', 01:11:14 INFO - 'sessionrestore_no_auto_restore', 01:11:14 INFO - 'tabpaint']}, 01:11:14 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:11:14 INFO - 'ts_paint', 01:11:14 INFO - 'tpaint', 01:11:14 INFO - 'sessionrestore', 01:11:14 INFO - 'sessionrestore_no_auto_restore', 01:11:14 INFO - 'tabpaint']}, 01:11:14 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:11:14 INFO - 'ts_paint', 01:11:14 INFO - 'tpaint', 01:11:14 INFO - 'sessionrestore', 01:11:14 INFO - 'sessionrestore_no_auto_restore', 01:11:14 INFO - 'tabpaint']}, 01:11:14 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:11:14 INFO - 'tests': ['a11yr', 01:11:14 INFO - 'ts_paint', 01:11:14 INFO - 'tpaint', 01:11:14 INFO - 'sessionrestore', 01:11:14 INFO - 'sessionrestore_no_auto_restore', 01:11:14 INFO - 'tabpaint']}, 01:11:14 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:11:14 INFO - 'tests': ['a11yr', 01:11:14 INFO - 'ts_paint', 01:11:14 INFO - 'tpaint', 01:11:14 INFO - 'sessionrestore', 01:11:14 INFO - 'sessionrestore_no_auto_restore', 01:11:14 INFO - 'tabpaint']}, 01:11:14 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:11:14 INFO - 'tests': ['tsvgx', 01:11:14 INFO - 'tsvgr_opacity', 01:11:14 INFO - 'tart', 01:11:14 INFO - 'tscrollx', 01:11:14 INFO - 'cart']}, 01:11:14 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:11:14 INFO - 'tsvgr_opacity', 01:11:14 INFO - 'tart', 01:11:14 INFO - 'tscrollx', 01:11:14 INFO - 'cart']}, 01:11:14 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:14 INFO - 'talos_options': ['--disable-e10s'], 01:11:14 INFO - 'tests': ['tp5o']}, 01:11:14 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:14 INFO - 'tests': ['tp5o']}, 01:11:14 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:14 INFO - 'talos_options': ['--disable-e10s', 01:11:14 INFO - '--xperf_path', 01:11:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:11:14 INFO - 'tests': ['tp5n']}, 01:11:14 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:11:14 INFO - 'talos_options': ['--xperf_path', 01:11:14 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:11:14 INFO - 'tests': ['tp5n']}}, 01:11:14 INFO - 'talos.zip': {'path': '', 01:11:14 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:11:14 INFO - Running post-action listener: _resource_record_post_action 01:11:14 INFO - [mozharness: 2016-09-27 08:11:14.660678Z] Finished populate-webroot step (success) 01:11:14 INFO - [mozharness: 2016-09-27 08:11:14.660770Z] Running create-virtualenv step. 01:11:14 INFO - Running pre-action listener: _resource_record_pre_action 01:11:14 INFO - Running main action method: create_virtualenv 01:11:14 INFO - Creating virtualenv /builds/slave/test/build/venv 01:11:14 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 01:11:14 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:11:14 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:11:14 INFO - Using real prefix '/usr' 01:11:14 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:11:15 INFO - Installing distribute.............................................................................................................................................................................................done. 01:11:17 INFO - Installing pip.................done. 01:11:17 INFO - Return code: 0 01:11:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 01:11:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 01:11:17 INFO - Reading from file tmpfile_stdout 01:11:17 INFO - Output received: 01:11:17 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) 01:11:17 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:11:17 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')]} 01:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:17 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')]} 01:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:17 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 0x7f39851baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454f60>, '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 0x1455d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14561d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', '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 01:11:17 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 01:11:17 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 01:11:17 INFO - Using env: {'DISPLAY': ':0', 01:11:17 INFO - 'HOME': '/home/cltbld', 01:11:17 INFO - 'LANG': 'en_US.UTF-8', 01:11:17 INFO - 'LANGUAGE': 'en_US:en', 01:11:17 INFO - 'LOGNAME': 'cltbld', 01:11:17 INFO - 'MAIL': '/var/mail/cltbld', 01:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:17 INFO - 'MOZ_NO_REMOTE': '1', 01:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:17 INFO - 'NO_EM_RESTART': '1', 01:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:17 INFO - 'PWD': '/builds/slave/test', 01:11:17 INFO - 'SHELL': '/bin/bash', 01:11:17 INFO - 'SHLVL': '1', 01:11:17 INFO - 'TERM': 'linux', 01:11:17 INFO - 'TMOUT': '86400', 01:11:17 INFO - 'USER': 'cltbld', 01:11:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', 01:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:17 INFO - '_': '/tools/buildbot/bin/python'} 01:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:17 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 01:11:17 INFO - Cleaning up... 01:11:17 INFO - Return code: 0 01:11:17 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:11:17 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')]} 01:11:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:17 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')]} 01:11:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:17 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 0x7f39851baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454f60>, '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 0x1455d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14561d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', '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 01:11:17 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 01:11:17 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 01:11:17 INFO - Using env: {'DISPLAY': ':0', 01:11:17 INFO - 'HOME': '/home/cltbld', 01:11:17 INFO - 'LANG': 'en_US.UTF-8', 01:11:17 INFO - 'LANGUAGE': 'en_US:en', 01:11:17 INFO - 'LOGNAME': 'cltbld', 01:11:17 INFO - 'MAIL': '/var/mail/cltbld', 01:11:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:17 INFO - 'MOZ_NO_REMOTE': '1', 01:11:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:17 INFO - 'NO_EM_RESTART': '1', 01:11:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:17 INFO - 'PWD': '/builds/slave/test', 01:11:17 INFO - 'SHELL': '/bin/bash', 01:11:17 INFO - 'SHLVL': '1', 01:11:17 INFO - 'TERM': 'linux', 01:11:17 INFO - 'TMOUT': '86400', 01:11:17 INFO - 'USER': 'cltbld', 01:11:17 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', 01:11:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:17 INFO - '_': '/tools/buildbot/bin/python'} 01:11:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:17 INFO - Downloading/unpacking psutil>=3.1.1 01:11:17 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 01:11:17 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 01:11:17 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 01:11:17 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 01:11:17 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 01:11:17 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 01:11:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:11:19 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:11:19 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:11:19 INFO - Installing collected packages: psutil 01:11:19 INFO - Running setup.py install for psutil 01:11:19 INFO - building 'psutil._psutil_linux' extension 01:11:19 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 01:11:20 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 01:11:20 INFO - building 'psutil._psutil_posix' extension 01:11:20 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 01:11:20 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 01:11:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:11:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:11:20 INFO - Successfully installed psutil 01:11:20 INFO - Cleaning up... 01:11:20 INFO - Return code: 0 01:11:20 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:11: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')]} 01:11:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11: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')]} 01:11:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:20 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 0x7f39851baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454f60>, '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 0x1455d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14561d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', '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 01:11:20 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 01:11:20 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 01:11:20 INFO - Using env: {'DISPLAY': ':0', 01:11:20 INFO - 'HOME': '/home/cltbld', 01:11:20 INFO - 'LANG': 'en_US.UTF-8', 01:11:20 INFO - 'LANGUAGE': 'en_US:en', 01:11:20 INFO - 'LOGNAME': 'cltbld', 01:11:20 INFO - 'MAIL': '/var/mail/cltbld', 01:11:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:20 INFO - 'MOZ_NO_REMOTE': '1', 01:11:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:20 INFO - 'NO_EM_RESTART': '1', 01:11:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:20 INFO - 'PWD': '/builds/slave/test', 01:11:20 INFO - 'SHELL': '/bin/bash', 01:11:20 INFO - 'SHLVL': '1', 01:11:20 INFO - 'TERM': 'linux', 01:11:20 INFO - 'TMOUT': '86400', 01:11:20 INFO - 'USER': 'cltbld', 01:11:20 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', 01:11:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:20 INFO - '_': '/tools/buildbot/bin/python'} 01:11:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:20 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:11:20 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 01:11:20 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 01:11:20 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 01:11:20 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 01:11:20 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 01:11:20 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 01:11:22 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:11:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:11:22 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:11:22 INFO - Installing collected packages: mozsystemmonitor 01:11:22 INFO - Running setup.py install for mozsystemmonitor 01:11:22 INFO - Successfully installed mozsystemmonitor 01:11:22 INFO - Cleaning up... 01:11:22 INFO - Return code: 0 01:11:22 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:11:22 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')]} 01:11:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:22 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')]} 01:11:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:22 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 0x7f39851baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454f60>, '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 0x1455d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14561d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', '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 01:11:22 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 01:11:22 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 01:11:22 INFO - Using env: {'DISPLAY': ':0', 01:11:22 INFO - 'HOME': '/home/cltbld', 01:11:22 INFO - 'LANG': 'en_US.UTF-8', 01:11:22 INFO - 'LANGUAGE': 'en_US:en', 01:11:22 INFO - 'LOGNAME': 'cltbld', 01:11:22 INFO - 'MAIL': '/var/mail/cltbld', 01:11:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:22 INFO - 'MOZ_NO_REMOTE': '1', 01:11:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:22 INFO - 'NO_EM_RESTART': '1', 01:11:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:22 INFO - 'PWD': '/builds/slave/test', 01:11:22 INFO - 'SHELL': '/bin/bash', 01:11:22 INFO - 'SHLVL': '1', 01:11:22 INFO - 'TERM': 'linux', 01:11:22 INFO - 'TMOUT': '86400', 01:11:22 INFO - 'USER': 'cltbld', 01:11:22 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', 01:11:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:22 INFO - '_': '/tools/buildbot/bin/python'} 01:11:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:22 INFO - Downloading/unpacking jsonschema==2.5.1 01:11:22 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 01:11:22 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 01:11:22 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 01:11:22 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 01:11:22 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 01:11:22 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 01:11:24 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:11:24 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:11: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 01:11: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 01:11: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 01:11: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 01:11: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 01:11: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 01:11:25 INFO - Downloading functools32-3.2.3-2.tar.gz 01:11:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:11:25 INFO - warning: no files found matching '*.txt' 01:11:25 INFO - no previously-included directories found matching 'build' 01:11:25 INFO - no previously-included directories found matching 'dist' 01:11:25 INFO - no previously-included directories found matching '.git*' 01:11:25 INFO - Installing collected packages: jsonschema, functools32 01:11:25 INFO - Running setup.py install for functools32 01:11:25 INFO - warning: no files found matching '*.txt' 01:11:25 INFO - no previously-included directories found matching 'build' 01:11:25 INFO - no previously-included directories found matching 'dist' 01:11:25 INFO - no previously-included directories found matching '.git*' 01:11:25 INFO - Successfully installed jsonschema functools32 01:11:25 INFO - Cleaning up... 01:11:25 INFO - Return code: 0 01:11:25 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 01:11:25 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')]} 01:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:25 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')]} 01:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:25 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 0x7f39851baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454f60>, '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 0x1455d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14561d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', '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 01:11:25 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 01:11:25 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 01:11:25 INFO - Using env: {'DISPLAY': ':0', 01:11:25 INFO - 'HOME': '/home/cltbld', 01:11:25 INFO - 'LANG': 'en_US.UTF-8', 01:11:25 INFO - 'LANGUAGE': 'en_US:en', 01:11:25 INFO - 'LOGNAME': 'cltbld', 01:11:25 INFO - 'MAIL': '/var/mail/cltbld', 01:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:25 INFO - 'MOZ_NO_REMOTE': '1', 01:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:25 INFO - 'NO_EM_RESTART': '1', 01:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:25 INFO - 'PWD': '/builds/slave/test', 01:11:25 INFO - 'SHELL': '/bin/bash', 01:11:25 INFO - 'SHLVL': '1', 01:11:25 INFO - 'TERM': 'linux', 01:11:25 INFO - 'TMOUT': '86400', 01:11:25 INFO - 'USER': 'cltbld', 01:11:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', 01:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:25 INFO - '_': '/tools/buildbot/bin/python'} 01:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:25 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 01:11:25 INFO - Cleaning up... 01:11:25 INFO - Return code: 0 01:11:25 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:11:25 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')]} 01:11:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:25 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')]} 01:11:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:25 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 0x7f39851baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454f60>, '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 0x1455d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14561d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', '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 01:11:25 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 01:11:25 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 01:11:25 INFO - Using env: {'DISPLAY': ':0', 01:11:25 INFO - 'HOME': '/home/cltbld', 01:11:25 INFO - 'LANG': 'en_US.UTF-8', 01:11:25 INFO - 'LANGUAGE': 'en_US:en', 01:11:25 INFO - 'LOGNAME': 'cltbld', 01:11:25 INFO - 'MAIL': '/var/mail/cltbld', 01:11:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:25 INFO - 'MOZ_NO_REMOTE': '1', 01:11:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:25 INFO - 'NO_EM_RESTART': '1', 01:11:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:25 INFO - 'PWD': '/builds/slave/test', 01:11:25 INFO - 'SHELL': '/bin/bash', 01:11:25 INFO - 'SHLVL': '1', 01:11:25 INFO - 'TERM': 'linux', 01:11:25 INFO - 'TMOUT': '86400', 01:11:25 INFO - 'USER': 'cltbld', 01:11:25 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', 01:11:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:25 INFO - '_': '/tools/buildbot/bin/python'} 01:11:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:25 INFO - Downloading/unpacking blobuploader==1.2.4 01:11:25 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 01:11:25 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 01:11:25 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 01:11:25 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 01:11:25 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 01:11:25 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 01:11:27 INFO - Downloading blobuploader-1.2.4.tar.gz 01:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:11:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:11:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:11:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:11:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:11:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:11:28 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 01:11:28 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 01:11:28 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 01:11:28 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 01:11:28 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 01:11:28 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 01:11:28 INFO - Downloading docopt-0.6.1.tar.gz 01:11:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:11:28 INFO - Installing collected packages: blobuploader, requests, docopt 01:11:28 INFO - Running setup.py install for blobuploader 01:11:28 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:11:28 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:11:28 INFO - Running setup.py install for requests 01:11:28 INFO - Running setup.py install for docopt 01:11:28 INFO - Successfully installed blobuploader requests docopt 01:11:28 INFO - Cleaning up... 01:11:28 INFO - Return code: 0 01:11:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:11:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:11:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:28 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 0x7f39851baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454f60>, '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 0x1455d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14561d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', '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 01:11:28 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 01:11:28 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 01:11:28 INFO - Using env: {'DISPLAY': ':0', 01:11:29 INFO - 'HOME': '/home/cltbld', 01:11:29 INFO - 'LANG': 'en_US.UTF-8', 01:11:29 INFO - 'LANGUAGE': 'en_US:en', 01:11:29 INFO - 'LOGNAME': 'cltbld', 01:11:29 INFO - 'MAIL': '/var/mail/cltbld', 01:11:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:29 INFO - 'MOZ_NO_REMOTE': '1', 01:11:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:29 INFO - 'NO_EM_RESTART': '1', 01:11:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:29 INFO - 'PWD': '/builds/slave/test', 01:11:29 INFO - 'SHELL': '/bin/bash', 01:11:29 INFO - 'SHLVL': '1', 01:11:29 INFO - 'TERM': 'linux', 01:11:29 INFO - 'TMOUT': '86400', 01:11:29 INFO - 'USER': 'cltbld', 01:11:29 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', 01:11:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:29 INFO - '_': '/tools/buildbot/bin/python'} 01:11:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:11:29 INFO - Running setup.py (path:/tmp/pip-NIKgwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:11:29 INFO - Running setup.py (path:/tmp/pip-ObQYoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:11:29 INFO - Running setup.py (path:/tmp/pip-qvFcAj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:11:29 INFO - Running setup.py (path:/tmp/pip-anZ_n7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:11:29 INFO - Running setup.py (path:/tmp/pip-NtlZ1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:11:29 INFO - Running setup.py (path:/tmp/pip-Nnvcgn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:11:29 INFO - Running setup.py (path:/tmp/pip-9AtnrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:11:29 INFO - Running setup.py (path:/tmp/pip-3Rx_DX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:11:29 INFO - Running setup.py (path:/tmp/pip-Mp3vFg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:11:29 INFO - Running setup.py (path:/tmp/pip-TH85vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:11:29 INFO - Running setup.py (path:/tmp/pip-pOP44V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:11:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:11:29 INFO - Running setup.py (path:/tmp/pip-NkD84_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:11:30 INFO - Running setup.py (path:/tmp/pip-yIcR2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:11:30 INFO - Running setup.py (path:/tmp/pip-BqwhnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:11:30 INFO - Running setup.py (path:/tmp/pip-IjFPpD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:11:30 INFO - Running setup.py (path:/tmp/pip-65UcLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:11:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:11:30 INFO - Running setup.py (path:/tmp/pip-SqA31z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:11:30 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:11:30 INFO - Running setup.py install for manifestparser 01:11:30 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:11:30 INFO - Running setup.py install for mozcrash 01:11:30 INFO - Running setup.py install for mozdebug 01:11:30 INFO - Running setup.py install for mozdevice 01:11:30 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:11:30 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:11:30 INFO - Running setup.py install for mozfile 01:11:30 INFO - Running setup.py install for mozhttpd 01:11:31 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Running setup.py install for mozinfo 01:11:31 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Running setup.py install for mozInstall 01:11:31 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Running setup.py install for mozleak 01:11:31 INFO - Running setup.py install for mozlog 01:11:31 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Running setup.py install for moznetwork 01:11:31 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Running setup.py install for mozprocess 01:11:31 INFO - Running setup.py install for mozprofile 01:11:31 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Running setup.py install for mozrunner 01:11:31 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:11:31 INFO - Running setup.py install for mozscreenshot 01:11:31 INFO - Running setup.py install for moztest 01:11:32 INFO - Running setup.py install for mozversion 01:11:32 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:11:32 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:11:32 INFO - Cleaning up... 01:11:32 INFO - Return code: 0 01:11:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:11:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:11:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:32 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 0x7f39851baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454f60>, '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 0x1455d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14561d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', '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 01:11:32 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 01:11:32 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 01:11:32 INFO - Using env: {'DISPLAY': ':0', 01:11:32 INFO - 'HOME': '/home/cltbld', 01:11:32 INFO - 'LANG': 'en_US.UTF-8', 01:11:32 INFO - 'LANGUAGE': 'en_US:en', 01:11:32 INFO - 'LOGNAME': 'cltbld', 01:11:32 INFO - 'MAIL': '/var/mail/cltbld', 01:11:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:32 INFO - 'MOZ_NO_REMOTE': '1', 01:11:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:32 INFO - 'NO_EM_RESTART': '1', 01:11:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:32 INFO - 'PWD': '/builds/slave/test', 01:11:32 INFO - 'SHELL': '/bin/bash', 01:11:32 INFO - 'SHLVL': '1', 01:11:32 INFO - 'TERM': 'linux', 01:11:32 INFO - 'TMOUT': '86400', 01:11:32 INFO - 'USER': 'cltbld', 01:11:32 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', 01:11:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:32 INFO - '_': '/tools/buildbot/bin/python'} 01:11:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:11:32 INFO - Running setup.py (path:/tmp/pip-djq1Nc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:11:32 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)) 01:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:11:32 INFO - Running setup.py (path:/tmp/pip-5NFL3c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:11:32 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)) 01:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:11:32 INFO - Running setup.py (path:/tmp/pip-PemQ4t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:11:32 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)) 01:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:11:32 INFO - Running setup.py (path:/tmp/pip-_09ZWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:11:32 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)) 01:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:11:32 INFO - Running setup.py (path:/tmp/pip-sjshwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:11:32 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)) 01:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:11:32 INFO - Running setup.py (path:/tmp/pip-WrqKN5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:11:32 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)) 01:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:11:32 INFO - Running setup.py (path:/tmp/pip-W4bQkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:11:32 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)) 01:11:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:11:32 INFO - Running setup.py (path:/tmp/pip-sppovI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:11:33 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)) 01:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:11:33 INFO - Running setup.py (path:/tmp/pip-6ubngN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:11:33 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)) 01:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:11:33 INFO - Running setup.py (path:/tmp/pip-Hybgq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:11:33 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)) 01:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:11:33 INFO - Running setup.py (path:/tmp/pip-lSxAjA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:11:33 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)) 01:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:11:33 INFO - Running setup.py (path:/tmp/pip-Zb6fIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:11:33 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)) 01:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:11:33 INFO - Running setup.py (path:/tmp/pip-D4WAeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:11:33 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)) 01:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:11:33 INFO - Running setup.py (path:/tmp/pip-M4sAMz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:11:33 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)) 01:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:11:33 INFO - Running setup.py (path:/tmp/pip-CSBgrb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:11:33 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)) 01:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:11:33 INFO - Running setup.py (path:/tmp/pip-CLeOQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:11:33 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)) 01:11:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:11:33 INFO - Running setup.py (path:/tmp/pip-XoxA9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:11:33 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)) 01:11:33 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)) 01:11:33 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)) 01:11:33 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)) 01:11:33 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)) 01:11:33 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)) 01:11:33 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:11:33 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 01:11:33 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 01:11:33 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 01:11:33 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 01:11:33 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 01:11:33 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 01:11:35 INFO - Downloading blessings-1.6.tar.gz 01:11:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:11:35 INFO - Installing collected packages: blessings 01:11:35 INFO - Running setup.py install for blessings 01:11:35 INFO - Successfully installed blessings 01:11:35 INFO - Cleaning up... 01:11:35 INFO - Return code: 0 01:11:35 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:11:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:11:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:11:36 INFO - Reading from file tmpfile_stdout 01:11:36 INFO - Current package versions: 01:11:36 INFO - argparse == 1.2.1 01:11:36 INFO - blessings == 1.6 01:11:36 INFO - blobuploader == 1.2.4 01:11:36 INFO - docopt == 0.6.1 01:11:36 INFO - functools32 == 3.2.3-2 01:11:36 INFO - jsonschema == 2.5.1 01:11:36 INFO - manifestparser == 1.1 01:11:36 INFO - mozInstall == 1.12 01:11:36 INFO - mozcrash == 0.17 01:11:36 INFO - mozdebug == 0.1 01:11:36 INFO - mozdevice == 0.48 01:11:36 INFO - mozfile == 1.2 01:11:36 INFO - mozhttpd == 0.7 01:11:36 INFO - mozinfo == 0.9 01:11:36 INFO - mozleak == 0.1 01:11:36 INFO - mozlog == 3.4 01:11:36 INFO - moznetwork == 0.27 01:11:36 INFO - mozprocess == 0.23 01:11:36 INFO - mozprofile == 0.28 01:11:36 INFO - mozrunner == 6.12 01:11:36 INFO - mozscreenshot == 0.1 01:11:36 INFO - mozsystemmonitor == 0.3 01:11:36 INFO - moztest == 0.7 01:11:36 INFO - mozversion == 1.4 01:11:36 INFO - psutil == 3.1.1 01:11:36 INFO - requests == 1.2.3 01:11:36 INFO - wsgiref == 0.1.2 01:11:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:11:36 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')]} 01:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:36 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')]} 01:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:36 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 0x7f39851baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454f60>, '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 0x1455d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14561d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', '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 01:11:36 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 01:11:36 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 01:11:36 INFO - Using env: {'DISPLAY': ':0', 01:11:36 INFO - 'HOME': '/home/cltbld', 01:11:36 INFO - 'LANG': 'en_US.UTF-8', 01:11:36 INFO - 'LANGUAGE': 'en_US:en', 01:11:36 INFO - 'LOGNAME': 'cltbld', 01:11:36 INFO - 'MAIL': '/var/mail/cltbld', 01:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:36 INFO - 'MOZ_NO_REMOTE': '1', 01:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:36 INFO - 'NO_EM_RESTART': '1', 01:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:36 INFO - 'PWD': '/builds/slave/test', 01:11:36 INFO - 'SHELL': '/bin/bash', 01:11:36 INFO - 'SHLVL': '1', 01:11:36 INFO - 'TERM': 'linux', 01:11:36 INFO - 'TMOUT': '86400', 01:11:36 INFO - 'USER': 'cltbld', 01:11:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', 01:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:36 INFO - '_': '/tools/buildbot/bin/python'} 01:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:36 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)) 01:11:36 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)) 01:11:36 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)) 01:11:36 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)) 01:11:36 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)) 01:11:36 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)) 01:11:36 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)) 01:11:36 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)) 01:11:36 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)) 01:11:36 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)) 01:11:36 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)) 01:11:36 INFO - Cleaning up... 01:11:36 INFO - Return code: 0 01:11:36 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:11:36 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')]} 01:11:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:11:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:36 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')]} 01:11:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:11:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:11:36 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 0x7f39851baf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1457ca0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1454f60>, '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 0x1455d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14561d0>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', '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 01:11:36 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 01:11:36 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 01:11:36 INFO - Using env: {'DISPLAY': ':0', 01:11:36 INFO - 'HOME': '/home/cltbld', 01:11:36 INFO - 'LANG': 'en_US.UTF-8', 01:11:36 INFO - 'LANGUAGE': 'en_US:en', 01:11:36 INFO - 'LOGNAME': 'cltbld', 01:11:36 INFO - 'MAIL': '/var/mail/cltbld', 01:11:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:36 INFO - 'MOZ_NO_REMOTE': '1', 01:11:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:36 INFO - 'NO_EM_RESTART': '1', 01:11:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:36 INFO - 'PWD': '/builds/slave/test', 01:11:36 INFO - 'SHELL': '/bin/bash', 01:11:36 INFO - 'SHLVL': '1', 01:11:36 INFO - 'TERM': 'linux', 01:11:36 INFO - 'TMOUT': '86400', 01:11:36 INFO - 'USER': 'cltbld', 01:11:36 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', 01:11:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:36 INFO - '_': '/tools/buildbot/bin/python'} 01:11:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:11:36 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:11:36 INFO - Cleaning up... 01:11:36 INFO - Return code: 0 01:11:36 INFO - Running post-action listener: _resource_record_post_action 01:11:36 INFO - Running post-action listener: _start_resource_monitoring 01:11:36 INFO - Starting resource monitoring. 01:11:36 INFO - [mozharness: 2016-09-27 08:11:36.532071Z] Finished create-virtualenv step (success) 01:11:36 INFO - [mozharness: 2016-09-27 08:11:36.532574Z] Running install step. 01:11:36 INFO - Running pre-action listener: _resource_record_pre_action 01:11:36 INFO - Running main action method: install 01:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:11:36 INFO - Reading from file tmpfile_stdout 01:11:36 INFO - Detecting whether we're running mozinstall >=1.0... 01:11:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:11:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:11:36 INFO - Reading from file tmpfile_stdout 01:11:36 INFO - Output received: 01:11:36 INFO - Usage: mozinstall [options] installer 01:11:36 INFO - Options: 01:11:36 INFO - -h, --help show this help message and exit 01:11:36 INFO - -d DEST, --destination=DEST 01:11:36 INFO - Directory to install application into. [default: 01:11:36 INFO - "/builds/slave/test"] 01:11:36 INFO - --app=APP Application being installed. [default: firefox] 01:11:36 INFO - mkdir: /builds/slave/test/build/application 01:11:36 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'] 01:11:36 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 01:11:52 INFO - Reading from file tmpfile_stdout 01:11:52 INFO - Output received: 01:11:52 INFO - /builds/slave/test/build/application/firefox/firefox 01:11:52 INFO - Running post-action listener: _resource_record_post_action 01:11:52 INFO - [mozharness: 2016-09-27 08:11:52.907747Z] Finished install step (success) 01:11:52 INFO - [mozharness: 2016-09-27 08:11:52.907988Z] Running run-tests step. 01:11:52 INFO - Running pre-action listener: _resource_record_pre_action 01:11:52 INFO - Running main action method: run_tests 01:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:11:52 INFO - Python 2.7.3 01:11:52 INFO - Return code: 0 01:11:52 INFO - grabbing minidump binary from tooltool 01:11:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 01:11:52 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 0x1454f60>, '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 0x1455d40>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14561d0>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:11:52 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 01:11:52 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 01:11:52 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 01:11:52 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:11:52 INFO - Return code: 0 01:11:52 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:11:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:11:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:11:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:11:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:11:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 01:11:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --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 01:11:52 INFO - Using env: {'DISPLAY': ':0', 01:11:52 INFO - 'HOME': '/home/cltbld', 01:11:52 INFO - 'LANG': 'en_US.UTF-8', 01:11:52 INFO - 'LANGUAGE': 'en_US:en', 01:11:52 INFO - 'LOGNAME': 'cltbld', 01:11:52 INFO - 'MAIL': '/var/mail/cltbld', 01:11:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:11:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:11:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:11:52 INFO - 'MOZ_NO_REMOTE': '1', 01:11:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:11:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:11:52 INFO - 'NO_EM_RESTART': '1', 01:11:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:11:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:11:52 INFO - 'PWD': '/builds/slave/test', 01:11:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:11:52 INFO - 'SHELL': '/bin/bash', 01:11:52 INFO - 'SHLVL': '1', 01:11:52 INFO - 'TERM': 'linux', 01:11:52 INFO - 'TMOUT': '86400', 01:11:52 INFO - 'USER': 'cltbld', 01:11:52 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284', 01:11:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:11:52 INFO - '_': '/tools/buildbot/bin/python'} 01:11:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--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 01:11:53 INFO - mozversion application_buildid: 20160926233117 01:11:53 INFO - mozversion application_changeset: df63260c1c90ea8ff0a5a314fbcae9365854abb0 01:11:53 INFO - mozversion application_display_name: Nightly 01:11:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:11:53 INFO - mozversion application_name: Firefox 01:11:53 INFO - mozversion application_remotingname: firefox 01:11:53 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 01:11:53 INFO - mozversion application_vendor: Mozilla 01:11:53 INFO - mozversion application_version: 52.0a1 01:11:53 INFO - mozversion platform_buildid: 20160926233117 01:11:53 INFO - mozversion platform_changeset: df63260c1c90ea8ff0a5a314fbcae9365854abb0 01:11:53 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 01:11:53 INFO - mozversion platform_version: 52.0a1 01:11:53 INFO - using testdate: 1474963913 01:11:53 INFO - actual date: 1474963913 01:11:53 INFO - starting webserver on 'localhost:54754' 01:11:53 INFO - SUITE-START | Running 2 tests 01:11:53 INFO - TEST-START | dromaeo_css 01:11:53 INFO - operating with platform_type : linux_ 01:11:53 INFO - Initialising browser for dromaeo_css test... 01:11:53 INFO - TEST-INFO | started process 14048 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrwtjQ/profile http://localhost:54754/getInfo.html) 01:11:58 INFO - PROCESS | 14048 | __metrics Screen width/height:1600/1200 01:11:58 INFO - PROCESS | 14048 | colorDepth:24 01:11:58 INFO - PROCESS | 14048 | Browser inner width/height: 1024/697 01:11:58 INFO - PROCESS | 14048 | __metrics 01:11:58 ERROR - PROCESS | 14048 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 01:11:59 INFO - TEST-INFO | 14048: exit 0 01:11:59 INFO - Browser initialized. 01:11:59 INFO - Running cycle 1/1 for dromaeo_css test... 01:11:59 INFO - TEST-INFO | started process 14170 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmptrwtjQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:12:11 INFO - PROCESS | 14170 | RSS: Main: 186183680 01:12:11 INFO - PROCESS | 14170 | 01:13:01 INFO - PROCESS | 14170 | 1474963981682 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] 01:15:14 INFO - PROCESS | 14170 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-dojo.html (next: http://localhost:54754/tests/dromaeo/cssquery-ext.html) 01:15:15 INFO - PROCESS | 14170 | RSS: Main: 202489856 01:15:15 INFO - PROCESS | 14170 | 01:18:18 INFO - PROCESS | 14170 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-ext.html (next: http://localhost:54754/tests/dromaeo/cssquery-jquery.html) 01:18:18 INFO - PROCESS | 14170 | RSS: Main: 199155712 01:18:18 INFO - PROCESS | 14170 | 01:21:20 INFO - PROCESS | 14170 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-jquery.html (next: http://localhost:54754/tests/dromaeo/cssquery-mootools.html) 01:21:21 INFO - PROCESS | 14170 | RSS: Main: 198688768 01:21:21 INFO - PROCESS | 14170 | 01:24:23 INFO - PROCESS | 14170 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-mootools.html (next: http://localhost:54754/tests/dromaeo/cssquery-prototype.html) 01:24:24 INFO - PROCESS | 14170 | RSS: Main: 195170304 01:24:24 INFO - PROCESS | 14170 | 01:27:27 INFO - PROCESS | 14170 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-prototype.html (next: http://localhost:54754/tests/dromaeo/cssquery-yui.html) 01:27:27 INFO - PROCESS | 14170 | RSS: Main: 198410240 01:27:27 INFO - PROCESS | 14170 | 01:30:30 INFO - PROCESS | 14170 | Cycle 1(1): loaded http://localhost:54754/tests/dromaeo/cssquery-yui.html (next: http://localhost:54754/tests/dromaeo/cssquery-dojo.html) 01:30:30 INFO - PROCESS | 14170 | RSS: Main: 199315456 01:30:30 INFO - PROCESS | 14170 | 01:30:30 INFO - PROCESS | 14170 | __start_tp_report 01:30:30 INFO - PROCESS | 14170 | _x_x_mozilla_page_load 01:30:30 INFO - PROCESS | 14170 | _x_x_mozilla_page_load_details 01:30:30 INFO - PROCESS | 14170 | |i|pagename|runs| 01:30:30 INFO - PROCESS | 14170 | |0;dojo.html;2578.587426011838;2610.699769526504;2611.386324213808;2626.789856811455;2656.7476089771476;4551.453825540932;4629.930551041729;4685.765711714418;4723;4724.881877953053;4580.427446569179;4730.148573256813;4774.045190961813;4781.8804529886775;4819.710817350952;4301.139772045588;4315.374270730742;4377.781110944456;4394.165108629366;4503.594676479116;4508.1659892919915;4512.345709872066;4518.683692141552;4525.208088584484;4533.773311334437;4249.192653395845;4297.03316753731;4328.394024836525;4379.562043795595;4399.38408622793;4331.480222373304;4336.067745434715;4342.609165175118;4404.119176164748;4485.416895803557;4297.484301883763;4331.545187755271;4338.1540599583095;4376.934345984812;4385.407969924051;4610.9308360374625;4669.369635099252;4725.8582242532775;4728.550787675165;4728.95271047292;5022.447530771612;5030.245463180516;5036;5036.118679231156;5079.898402031976;5063.18988961768;5072.974635126838;5077.898442031175;5079.720615366154;5082.23766435034;4521.9321710174045;4574.336721175478;4667.043256132485;4688.71867687933;4698.130845793471;5154.046501397253;5172.456892026283;5175.042617115846;5188.325517682752;5228.6862788232065;4945.085159245551;4969.3291405659775;4973.701577905337;4991.80032798684;5019.121653710586;4910.337104490919;5019.548240658358;5035.924461133086;5056.064628043824;5079.187330027178;5042.546170844642;5059.747012649353;5061.139606266944;5064.392272927273;5107.795688172431;5048.974755126201;5063.772130254148;5064.46823083571;5069.239614057847;5095.108356037678;4153.54311025787;4197.538270790211;4255.659547236213;4288.206681763883;4360.149770794665;3731.794751288651;3746.194568167857;3773.471713960048;3802.16352402471;3818.293615681108;4360.542143074931;4365.541618130114;4372.147431250875;4376.693631445768;4399.5160532341415;4906.852794416173;4954.479779623088;4958;5089.9745501273;5122.410922743932;4297.162053399557;4323;4324.935125973113;4339.153864996296;4357.9782101089295;4591.380163677927;4600.918784085738;4601.654875884322;4638.350630911675;4655.4180727409075;4812.374391329105;4817.518248175154;4818.204996175662;4864.343313652612;4880.267959806058;4941.085899108676;4989.850304490871;5025.824096156617;5099.056674515078;5106;4804.111239420718;4823.3729615149805;4824.565789079;4877.170880950318;4893.853184404474;4806.351142595705;4846.442659094249;4875.268709693574;4950.158473059517;5031.371078615173;4976.477469865612;4996.775145118406;5015.272785446017;5015.423226329019;5067.594592432522;4791.089692958327;4838.588719958843;4896.4858689838475;4912.95087049125;4946.084974279625;4890.095332363524;4907.043126590281;4984.975075124601;5021.824236151717;5030.949690503048;4842.854714358575;4881.389826271716;4906.656534042583;4916.385451818523;4918.532739389752;4838.709677419366;4885.096257192431;4953.18272485036;5019.121653710659;5029.44676085623;4855.174620314626;4909.26361045846;4915.827946021872;4922.852314430573;4985.52637499437 01:30:30 INFO - PROCESS | 14170 | |1;ext.html;545.8962797068557;552.1965540139098;558.0011778915735;567.0784974416572;572.0646742575888;37496.25007499848;39055.80472097639;39072.80463597681;42280.57719422805;42335.36496952548;39030.414543781866;39123;39167.21665566687;39254;39558.208835823265;7541.924580754177;7651.081870175587;7652.655630496641;7700.306972372486;7705.113911900119;7525.924740752577;7531.924680753177;7627.847443051136;7633.9618301908695;7646.082470103595;7585.81035474112;7604.239576042407;7616.543007419545;7637.579933103705;7650.961745191294;7545.358644515223;7582.355499782553;7583.544987300779;7616.753057847948;7619.428542859252;7573.962130189314;7629.465937384385;7631.885521717123;7633.389328853734;7634.236576342377;37247.62752372469;37386.06534836651;37525;37856;37869.81065094657;3003.4743919814164;3126.3747250549754;3226.2257058305836;3302.4055669979393;3512.9297414051575;27563;27622.585661215096;27913.860430697718;28147;28446.857765711247;3459.6021457532456;3477.4436090225695;3493.2664140530264;3511.10466830959;3549.538559987211;253394;257152;258539;258585;258612.70693646598;52404.73797630987;52797.7360113197;52909.2063619046;52923.73538132285;52979.205311920356;31660.525092123637;32437.837810810794;32537.186570335456;34276.828615856764;56043;12686.11197216186;12873;12877.678058048623;12892.355382230851;13011.284379359226;9370.10983956523;9477.90522094784;9556.808863822685;9595.136437720499;9634.807303854024;17505.912470437823;17565.912170439067;17580.472585822445;17584.736228956575;17696;6760.695768690421;6800.075967333995;6875.931240687629;6911.654417279216;6941.965290173517;779.7621725373815;865.5023361566998;890.17213990989;913.9131782480654;966.3231404505923;26380.34049148748;27499.587506187425;27656;28032.8598357011;28056.71943280541;910.1535571918047;946.5409276500892;963.9759006024906;1005.9195264378832;1006.7634105985088;13705.383257753425;14167.856893159187;14532.927335363256;14566.41734330615;14640.633984150481;336263;390704;400477;401486;600761;47981;48121;48127;48165;48729.5127048725;1176.9352685602373;1183.1303991566192;1208.1482554798845;1212.1272683667746;1214.2714371377103;26599.069032583768;27559.535111474957;27638.86180569084;28540.714592853805;28603.570946435404;41177.38233926434;41707.37438938479;41762.37356439595;41829.37255941102;41844.581554185286;310869;311609;314827;316232;317085;24172;24483;24562;24567.262982110566;24609.384765381008;39573.60426395814;40030;40067.79966100151;40197;40648.18703625852;33254.66745332516;34395;34555.65444345524;34602.307953841286;35037;34278.314433710686;34387;34393.828030860685;34780.47829282512;35271.823640882656;27525.449491009666;29717.405651887275;29939.101826945225;33372.66627333696;33937.15157121092;29510;31740.682593173773;31986.840065799523;32279.35441291208;32286.677133228368;23981.880090599436;24077.879610601834;24271.57284271559;24448.755512444648;24474.388140296636 01:30:30 INFO - PROCESS | 14170 | |2;jquery.html;348.1817728338407;361.5444539879751;368.9870854520091;370.4887255587289;379.1242230447666;15596.92201538992;15750.684986300266;16913.915430422847;17053;17058.14709264538;13681.589552313422;16885.49343519693;17046.744298835496;17106.401275955344;17155.056471894073;4398.692091553593;4556.863294101166;4626.329182268569;4726.621870250389;4737.147313483571;4667.15991121598;4700.482946875841;4703;4705.858824235278;4706.482286948433;4642.210824159901;5013.473585273548;5070.138076527;5080.110980578384;5100.081985242655;4956.628252881031;4996.9500304996845;5015.122353588125;5015.949840501603;5017.724025178613;4405.625521830616;4454.888627784331;4526.569975852289;4531;4555.589996900262;12234.327112008836;12375.381230938507;12387.62837114888;12465.065120115936;12573.685657858536;1867.1037901807074;1928.701051337045;1929.2861641192708;2065.0707181768266;2239.7648246934164;8793.384463087586;9153.313501487415;9362.438253704799;9589.904100958971;9607.711768646952;1580.1230317173963;1676.4886709553582;1737.730651748981;1799.2533098763997;1809.1587411853552;61554.69222653903;63482.68258658723;64783.3521664782;65248.67375663092;67750.3224967749;9616.615335386647;9986.151177150025;10074.3955362677;10227.28409011362;10251.692449226535;13693.657658558615;13697.931510342583;13727.313634318245;13738.65653358654;13740.65648358779;6810.148731408574;7082.610456424843;7127.322904324081;7279.41764658826;7289.635518224173;6621.602703837785;6718.832029199211;6875.862482750317;6901.309869013159;6908.171019477594;4094;4160.126373461547;4204.3693445982735;4309.41822853917;4366.235908715962;1751.448293787453;1814.97277540837;1822.9635407292046;1830.2130084063715;1845.8061903499938;779.7387875061804;811.7118422959883;815.9061707903548;827.8302947895787;872.7599910024667;15776.290066947015;16710.248038838283;16778.496645100666;17370.565735856704;17621.383251586132;819.148085990575;819.8196396792696;824.5011767880346;827.4456114403364;834.7120243515977;9194.49430281341;9720.756981075388;9761.414315141114;9816.116549510578;9967.352122112039;341154;349353;349702;350304;350322;72666.27333726596;73021.2697873025;74424.25575744282;74548.62725686337;74661.25338746543;852.8209076093966;886.3042511628341;914.7392992996831;944.0700909604035;948;15638.218089095728;15676.608084797515;15771.921140394224;15998.9200053999;16222;34548.65451345555;35679;36251;37017.62982370142;37106.44340334951;47931.520684792704;48496.757516212194;48548.514514854396;48839.5116048835;49378.259326110856;4750.239961606127;4816.518348165156;7354.96322518384;7625.199354067743;7808.297253247235;10150.847737284093;11277.266977646426;11940.283582985048;12168.209066410654;12346.938265308616;10279.280450368402;10285.84571231447;10340.37957722539;10416.739581510523;10836.783264334827;9789.167920726817;10199.38803671782;10312.639057632947;10351.223658225512;10532.210084243865;10345.224108192066;10356.326838755456;10471.738206544896;10537.63118290856;10855.2401331906;7481.625918704151;7514.736984205527;7671.654775535226;7959.641816118173;8143.104258531675;9971.551280192554;10608.522616482123;10627.521761520904;10698.62554810578;10735.141188704729 01:30:30 INFO - PROCESS | 14170 | |3;mootools.html;1317.5256907513296;1354.7358265138298;1418.9858101418984;1661.1943207544346;1672.197345274269;6741.191057073146;6982.3715865572085;7142.428605711543;7640.7325743598985;7650.196729343415;7121.181064177621;7386.704531818721;7409.222031686662;7525.51084179528;7602.619869006541;2146.796054374836;2176;2177.629802933497;2182.6398644223764;2183.8034576888076;2107.1360742095744;2119.5231073008526;2162.0378931375544;2166.04693934669;2168.1002384010617;2118.7139736135655;2124.3945475539476;2143.024923659731;2143.474848662072;2163.167180635451;2066.08059413561;2069.627467055929;2073.419442556087;2087.7912208779;2090.5400811821373;2029.8376129909573;2111.5354621983292;2135.3807395855183;2138.9358319250446;2142.3465842917904;7534.0582427196605;7665.8850117248285;7669.041369828771;7669.0797104347275;7723.575203363813;4253.936190957138;4386.495553011413;4388.626966707834;4389.034412429261;4394.868153955386;2700.1359564939225;2766.986165069162;2897.840618765967;2902.274431392152;2910.54886492594;888.6667499687617;936.0358830404695;955.6702937486625;957.8658987741721;960.4237457525498;10255.846162307571;10331.380117192992;10381.532831022621;10391.532381042796;10455.477226138662;3872.7676339419727;4058.837646494166;4134.1731653668785;4164.333706606928;4200.369944508348;8803.867941980876;8851.583746600512;8872.24585910192;8886.86669699955;8906.955465222632;4596.6092882105395;4598.517155698671;4600.332951722048;4606.976965115153;4610.861674149781;3676.28312479064;3804.429335599627;4032.1129351542613;4185.874423767292;4193.5387107418155;3548.964510354915;3617.1318883468302;3623.438367053111;3724.273766615538;3736.7384283100464;1175.18324764288;1204.0367705835297;1206.7707135644375;1210.6549633354628;1212.5271144253747;754.8754455514778;777.992220077792;779.6335722210551;790.8695065314274;824.221111050052;4960.528749768766;5001.474845141281;5017.498250174954;5176.301199338041;5212.791488340424;402.92143032109044;407.4743580780819;408.1897433594313;408.7567897101279;411.2084237842142;3497.632748561415;3584.4802503636824;3625.3474374612297;3653.141511744791;3779.981100094537;8589.52757598338;8973.50645714492;9007.909920900838;9009.144131307516;9053.77365565866;8964.417312874642;8978.86531702025;8982.416142950688;9011.63953441855;9021.684241051531;6923.515353925278;6950.79147625572;7003.194632617212;7051.788446346618;7056.188538318056;4821.2045012573935;4877.756112194305;4899.216125420058;4965.652404331662;5012;8199.95900020496;8266.628001740057;8420.705275315335;8445.1977062179;8517.659293628185;8417.116202798617;8457.78855528592;8488.448250863674;8613.353998450017;8650.653973840976;5795.043817770189;5970.97014514942;6291.245050593775;6415.358464153547;6423.229212494531;6745.662716864235;6922.7923162305215;6924;7026.297370262932;7063.328983746535;5975.103734439869;5992.730327135377;6074.149619053248;6096.756129754937;6115.235595550556;5830.708464576839;5843.532517398513;5857;5881.382454842351;6003.099535069775;5717.142428635738;5870.119482077723;5931.614445061057;5937.228160339128;6066.969665151646;4187.6440502557625;4283.421738065446;4300.8709738707885;4338.869833904988;4407.823687052482;4291.399204111364;4350.847720329773;4407.184670835777;4414.139242847742;4486.439195100613 01:30:30 INFO - PROCESS | 14170 | |4;prototype.html;290.77174418081796;291.8103232898616;297.31320649300113;300.58519243444056;303.5749950069903;4898.534639209274;5048.116579598569;5071.391433028042;5112.28428020077;5148.279240906276;4938.38270216223;4942.728149951751;4960.826371077013;4985.152524070908;4991.675541089836;3667.963320366789;3778.6410291022307;3872.7095467839886;3894.591067937868;3904.219156168763;3753.86861459849;3821.3503704370187;3825.2540754552733;3837.2517359114986;3839.4240863870505;3762.473253744478;3785.470034195215;3807.2956503046885;3824.655780979725;3826.426036094594;3806.809659517041;3806.9238615227678;3824.560175579802;3834.2331533693373;3835.8082095895093;3178.713915747594;3314.2708604107297;3341.3484370547753;3367.4948757686298;3383.1372999885116;4860.173770458995;4862.270659401082;4872.610191184696;4876.390451193601;4879.975600122012;4389.934150987738;4396.934045989281;4400.427944367244;4405.427294451732;4408.647308215335;5025.346704928336;5168.813261258355;5206.5314121729225;5222.294990176316;5224.059669259532;3637.563492380905;3642.2169233614636;3642.21692336149;3648.434492653643;3655.908602284964;5429.104197807357;5437.891242175174;5502.58730595203;5513.50378465936;5527.723613819293;3529.3117842021074;3736.925261494755;3745.7939813309986;3752.1745216052423;3753.7800214930257;3779.7732136071922;3785.507883975121;3788.3749181385315;3805.162864169878;3818.904527386782;4366.737995720267;4367.519572846984;4374.78126093694;4383.969767104728;4401.84593539231;5212.879230965361;5242.659227150223;5258.237555554423;5277.788888444419;5328.706921119298;1275.7320962597773;1311.5147395463548;1321.7488677151312;1327.2965328375976;1328.2296268164441;811.6712731343697;826.5949684654476;842.6966292134827;849.9320054395633;855.8459477294147;4063.553009168989;4087.8773636790943;4105.794710264475;4352.238358287287;4505.07645932583;5210.661307015108;5367.5169234769055;5369.315342328836;5381.811636592701;5394.163904594794;4577.176108300538;4594.264917613166;4597.678162528591;4600.309953506934;4600.4479462464715;2766.9308267293077;2836.305105249227;2848.430313937221;2867.913962581126;2881.1704567599304;5074.619403544749;5079.492050794891;5112.514311140436;5120.61595380348;5134.178531435027;5540.97491963988;5544.279243698294;5549.528290095306;5566.165075238747;5574.021222466047;4847.200211964986;5056.595472362275;5080.745962701924;5087.389513258433;5091.949080509222;5385.27298814655;5388.515033646991;5407.648502847303;5414.945850541444;5418.674879507243;5250.422453530185;5375.543078838343;5386.061018033426;5399.730013499231;5414.539764120094;5083.644144909821;5089.1094058538865;5105.795768169231;5112.335396398445;5125.666831655931;3746.4265008696957;3795.6773674237998;3801.239752049546;3803.7337386383792;3810.9618903810606;5271.1039123348355;5465.945340546544;5479.315085614298;5484.080571799838;5485.204645326485;5203.531682148625;5224.190250511177;5251.264822924717;5252.868678283074;5264.368275806928;5205.297284866495;5210.791568337376;5225.790968361223;5227.811035268559;5245.347715469615;5040.42035165946;5141.997310524412;5156.5616922562;5177.8187763428095;5190.506901844319;5027.371578552681;5251.186066159598;5262.947370526399;5285.550728187994;5324.7870085196155;4965.627577931597;5052.646314757932;5100.2349647553165;5118.590512759045;5130.640855140105 01:30:30 INFO - PROCESS | 14170 | |5;yui.html;649.7043845050503;655.2497390487891;683.8803209438347;734.9595772232528;755.3390783064816;13198.472061117556;14311.642208944782;14390.1365918045;14406.567802965901;14417.78373324401;12502;12566.497340106385;12573.308468034254;12574.182678125915;12597.181183223083;627.8712863862897;641.881251968385;741.9517731347445;752.5409500204885;758.7003133762161;776.8873513340562;779.286952438518;779.6179871862774;779.8908152858604;780.4029917113413;820.2371794231362;825.2902503846717;826.3471857232779;827.2058823529419;830.1781236575807;812.4353574265888;815.5962798414793;816.2572059425923;817.3787921179886;820.3806126374609;603.523216658839;604.2205554834259;604.7701873288122;605.4550904186224;605.9424354686298;13482.05625606208;13504.054716169872;13510.594682159552;13542.932285338511;13549.119307244997;13355.399007044609;13712.52006179779;13863.66008977975;13980.580582582437;14174.291285435791;11064.446777661085;11102.61140860066;11102.944485277603;11201.327920324726;11221.943890280496;3366.495025746158;3411.4541673332396;3425.5546778918583;3443.328550932569;3528.2943411317838;60949.69525152346;62432.375676243566;65369.346306536805;65642.3435765641;65967.67016164889;10413.791724165474;10507.842382364272;10575.20685948557;10582.470876456146;10744.247902646739;16940.407085752187;17712.114394280234;20852.47868803292;20920.58158836845;20996.160153593686;7198.5320954137815;7206.423486121098;7220.350168484862;7295.598742069131;7301.89047164293;3831.310364134427;3899.8245078971513;3925.4111883217174;3933.92132157361;3940.4680368150507;3005.6242969628797;3090.8300043497375;3101.9689803102133;3115.6572776994512;3136.6549679535233;494.66610038224053;498.93264409304277;499.3059647090547;510.62213961668095;538.8383484954498;448.91470620581987;510.79312878284355;514.5471984653481;517.6195496310208;520.6407578770636;7608.163102058769;7716.344110750537;7721;7888.271816327501;8432.409731318749;479.2284422080448;565.6408180805136;575.893459709955;577.8844231153702;588.1677426441623;3862.575116737157;3904.2581909437117;4098.959010409917;4177.4778152730905;4200.474940632421;71214.64392678003;82432.58783706043;87004;95710.52144739231;98409;61481;63027.36972630215;63656.36343636597;73077.90383144257;74256;43843.56156438459;63911.68044159842;65651.34348656549;68537;68748.65625671939;7974.481658692166;8058.879116813369;8530.573471326534;8563.871541927001;8591.054983951884;39900.60099399085;40639.1872162561;41370.58629413667;41661;42034;53587.19619205637;56053.439465604824;57905.42094579;58999;60757.39242607694;9845.556949937414;9997.850032249667;10045.598176072876;10269.640562580274;10325.277230593787;12419.565315213924;12468.750624987268;12738.522435352887;13095.607131786062;13370.264635445144;10801.567937282422;11119.944400277947;11284.605038823602;11623.953844154066;11711.297322160697;11515.19393642437;12270.693232669255;12354.629361119181;12690.302033387883;12712.491500339884;10190.082892539707;10332.690019299433;10500.509297169856;10515.737106572396;10566.577336906437;9612.663556775758;10056.748581285527;10186.898131018892;10265.435401053013;10523.210759193244;8085.757427277191;8580.266772253657;8713.782155446164;9192.770180745534;9261.629534818532 01:30:30 INFO - PROCESS | 14170 | __end_tp_report 01:30:30 INFO - PROCESS | 14170 | __start_cc_report 01:30:30 INFO - PROCESS | 14170 | _x_x_mozilla_cycle_collect,350 01:30:30 INFO - PROCESS | 14170 | __end_cc_report 01:30:30 INFO - PROCESS | 14170 | __startTimestamp1474965030804__endTimestamp 01:30:30 INFO - PROCESS | 14170 | 01:30:30 INFO - PROCESS | 14170 | ------- Summary: start ------- 01:30:30 INFO - PROCESS | 14170 | Number of tests: 6 01:30:30 INFO - PROCESS | 14170 | 01:30:30 INFO - PROCESS | 14170 | [#0] dojo.html Cycles:165 Average:4676.19 Median:4824.57 stddev:487.37 (10.1%) stddev-sans-first:460.25 01:30:30 INFO - PROCESS | 14170 | Values: 2578.6 2610.7 2611.4 2626.8 2656.7 4551.5 4629.9 4685.8 4723.0 4724.9 4580.4 4730.1 4774.0 4781.9 4819.7 4301.1 4315.4 4377.8 4394.2 4503.6 4508.2 4512.3 4518.7 4525.2 4533.8 4249.2 4297.0 4328.4 4379.6 4399.4 4331.5 4336.1 4342.6 4404.1 4485.4 4297.5 4331.5 4338.2 4376.9 4385.4 4610.9 4669.4 4725.9 4728.6 4729.0 5022.4 5030.2 5036.0 5036.1 5079.9 5063.2 5073.0 5077.9 5079.7 5082.2 4521.9 4574.3 4667.0 4688.7 4698.1 5154.0 5172.5 5175.0 5188.3 5228.7 4945.1 4969.3 4973.7 4991.8 5019.1 4910.3 5019.5 5035.9 5056.1 5079.2 5042.5 5059.7 5061.1 5064.4 5107.8 5049.0 5063.8 5064.5 5069.2 5095.1 4153.5 4197.5 4255.7 4288.2 4360.1 3731.8 3746.2 3773.5 3802.2 3818.3 4360.5 4365.5 4372.1 4376.7 4399.5 4906.9 4954.5 4958.0 5090.0 5122.4 4297.2 4323.0 4324.9 4339.2 4358.0 4591.4 4600.9 4601.7 4638.4 4655.4 4812.4 4817.5 4818.2 4864.3 4880.3 4941.1 4989.9 5025.8 5099.1 5106.0 4804.1 4823.4 4824.6 4877.2 4893.9 4806.4 4846.4 4875.3 4950.2 5031.4 4976.5 4996.8 5015.3 5015.4 5067.6 4791.1 4838.6 4896.5 4913.0 4946.1 4890.1 4907.0 4985.0 5021.8 5030.9 4842.9 4881.4 4906.7 4916.4 4918.5 4838.7 4885.1 4953.2 5019.1 5029.4 4855.2 4909.3 4915.8 4922.9 4985.5 01:30:30 INFO - PROCESS | 14170 | 01:30:30 INFO - PROCESS | 14170 | [#1] ext.html Cycles:180 Average:47426.78 Median:19410.68 stddev:91083.74 (469.2%) stddev-sans-first:91271.25 01:30:30 INFO - PROCESS | 14170 | Values: 545.9 552.2 558.0 567.1 572.1 37496.3 39055.8 39072.8 42280.6 42335.4 39030.4 39123.0 39167.2 39254.0 39558.2 7541.9 7651.1 7652.7 7700.3 7705.1 7525.9 7531.9 7627.8 7634.0 7646.1 7585.8 7604.2 7616.5 7637.6 7651.0 7545.4 7582.4 7583.5 7616.8 7619.4 7574.0 7629.5 7631.9 7633.4 7634.2 37247.6 37386.1 37525.0 37856.0 37869.8 3003.5 3126.4 3226.2 3302.4 3512.9 27563.0 27622.6 27913.9 28147.0 28446.9 3459.6 3477.4 3493.3 3511.1 3549.5 253394.0 257152.0 258539.0 258585.0 258612.7 52404.7 52797.7 52909.2 52923.7 52979.2 31660.5 32437.8 32537.2 34276.8 56043.0 12686.1 12873.0 12877.7 12892.4 13011.3 9370.1 9477.9 9556.8 9595.1 9634.8 17505.9 17565.9 17580.5 17584.7 17696.0 6760.7 6800.1 6875.9 6911.7 6942.0 779.8 865.5 890.2 913.9 966.3 26380.3 27499.6 27656.0 28032.9 28056.7 910.2 946.5 964.0 1005.9 1006.8 13705.4 14167.9 14532.9 14566.4 14640.6 336263.0 390704.0 400477.0 401486.0 600761.0 47981.0 48121.0 48127.0 48165.0 48729.5 1176.9 1183.1 1208.1 1212.1 1214.3 26599.1 27559.5 27638.9 28540.7 28603.6 41177.4 41707.4 41762.4 41829.4 41844.6 310869.0 311609.0 314827.0 316232.0 317085.0 24172.0 24483.0 24562.0 24567.3 24609.4 39573.6 40030.0 40067.8 40197.0 40648.2 33254.7 34395.0 34555.7 34602.3 35037.0 34278.3 34387.0 34393.8 34780.5 35271.8 27525.4 29717.4 29939.1 33372.7 33937.2 29510.0 31740.7 31986.8 32279.4 32286.7 23981.9 24077.9 24271.6 24448.8 24474.4 01:30:30 INFO - PROCESS | 14170 | 01:30:30 INFO - PROCESS | 14170 | [#2] jquery.html Cycles:180 Average:22499.28 Median:4382.46 stddev:57636.35 (1315.2%) stddev-sans-first:57774.04 01:30:30 INFO - PROCESS | 14170 | Values: 348.2 361.5 369.0 370.5 379.1 15596.9 15750.7 16913.9 17053.0 17058.1 13681.6 16885.5 17046.7 17106.4 17155.1 4398.7 4556.9 4626.3 4726.6 4737.1 4667.2 4700.5 4703.0 4705.9 4706.5 4642.2 5013.5 5070.1 5080.1 5100.1 4956.6 4997.0 5015.1 5015.9 5017.7 4405.6 4454.9 4526.6 4531.0 4555.6 12234.3 12375.4 12387.6 12465.1 12573.7 1867.1 1928.7 1929.3 2065.1 2239.8 8793.4 9153.3 9362.4 9589.9 9607.7 1580.1 1676.5 1737.7 1799.3 1809.2 61554.7 63482.7 64783.4 65248.7 67750.3 9616.6 9986.2 10074.4 10227.3 10251.7 13693.7 13697.9 13727.3 13738.7 13740.7 6810.1 7082.6 7127.3 7279.4 7289.6 6621.6 6718.8 6875.9 6901.3 6908.2 4094.0 4160.1 4204.4 4309.4 4366.2 1751.4 1815.0 1823.0 1830.2 1845.8 779.7 811.7 815.9 827.8 872.8 15776.3 16710.2 16778.5 17370.6 17621.4 819.1 819.8 824.5 827.4 834.7 9194.5 9720.8 9761.4 9816.1 9967.4 341154.0 349353.0 349702.0 350304.0 350322.0 72666.3 73021.3 74424.3 74548.6 74661.3 852.8 886.3 914.7 944.1 948.0 15638.2 15676.6 15771.9 15998.9 16222.0 34548.7 35679.0 36251.0 37017.6 37106.4 47931.5 48496.8 48548.5 48839.5 49378.3 4750.2 4816.5 7355.0 7625.2 7808.3 10150.8 11277.3 11940.3 12168.2 12346.9 10279.3 10285.8 10340.4 10416.7 10836.8 9789.2 10199.4 10312.6 10351.2 10532.2 10345.2 10356.3 10471.7 10537.6 10855.2 7481.6 7514.7 7671.7 7959.6 8143.1 9971.6 10608.5 10627.5 10698.6 10735.1 01:30:30 INFO - PROCESS | 14170 | 01:30:30 INFO - PROCESS | 14170 | [#3] mootools.html Cycles:180 Average:4877.14 Median:4849.48 stddev:2712.61 (55.9%) stddev-sans-first:2707.03 01:30:30 INFO - PROCESS | 14170 | Values: 1317.5 1354.7 1419.0 1661.2 1672.2 6741.2 6982.4 7142.4 7640.7 7650.2 7121.2 7386.7 7409.2 7525.5 7602.6 2146.8 2176.0 2177.6 2182.6 2183.8 2107.1 2119.5 2162.0 2166.0 2168.1 2118.7 2124.4 2143.0 2143.5 2163.2 2066.1 2069.6 2073.4 2087.8 2090.5 2029.8 2111.5 2135.4 2138.9 2142.3 7534.1 7665.9 7669.0 7669.1 7723.6 4253.9 4386.5 4388.6 4389.0 4394.9 2700.1 2767.0 2897.8 2902.3 2910.5 888.7 936.0 955.7 957.9 960.4 10255.8 10331.4 10381.5 10391.5 10455.5 3872.8 4058.8 4134.2 4164.3 4200.4 8803.9 8851.6 8872.2 8886.9 8907.0 4596.6 4598.5 4600.3 4607.0 4610.9 3676.3 3804.4 4032.1 4185.9 4193.5 3549.0 3617.1 3623.4 3724.3 3736.7 1175.2 1204.0 1206.8 1210.7 1212.5 754.9 778.0 779.6 790.9 824.2 4960.5 5001.5 5017.5 5176.3 5212.8 402.9 407.5 408.2 408.8 411.2 3497.6 3584.5 3625.3 3653.1 3780.0 8589.5 8973.5 9007.9 9009.1 9053.8 8964.4 8978.9 8982.4 9011.6 9021.7 6923.5 6950.8 7003.2 7051.8 7056.2 4821.2 4877.8 4899.2 4965.7 5012.0 8200.0 8266.6 8420.7 8445.2 8517.7 8417.1 8457.8 8488.4 8613.4 8650.7 5795.0 5971.0 6291.2 6415.4 6423.2 6745.7 6922.8 6924.0 7026.3 7063.3 5975.1 5992.7 6074.1 6096.8 6115.2 5830.7 5843.5 5857.0 5881.4 6003.1 5717.1 5870.1 5931.6 5937.2 6067.0 4187.6 4283.4 4300.9 4338.9 4407.8 4291.4 4350.8 4407.2 4414.1 4486.4 01:30:30 INFO - PROCESS | 14170 | 01:30:30 INFO - PROCESS | 14170 | [#4] prototype.html Cycles:180 Average:4318.24 Median:4975.39 stddev:1283.23 (25.8%) stddev-sans-first:1250.72 01:30:30 INFO - PROCESS | 14170 | Values: 290.8 291.8 297.3 300.6 303.6 4898.5 5048.1 5071.4 5112.3 5148.3 4938.4 4942.7 4960.8 4985.2 4991.7 3668.0 3778.6 3872.7 3894.6 3904.2 3753.9 3821.4 3825.3 3837.3 3839.4 3762.5 3785.5 3807.3 3824.7 3826.4 3806.8 3806.9 3824.6 3834.2 3835.8 3178.7 3314.3 3341.3 3367.5 3383.1 4860.2 4862.3 4872.6 4876.4 4880.0 4389.9 4396.9 4400.4 4405.4 4408.6 5025.3 5168.8 5206.5 5222.3 5224.1 3637.6 3642.2 3642.2 3648.4 3655.9 5429.1 5437.9 5502.6 5513.5 5527.7 3529.3 3736.9 3745.8 3752.2 3753.8 3779.8 3785.5 3788.4 3805.2 3818.9 4366.7 4367.5 4374.8 4384.0 4401.8 5212.9 5242.7 5258.2 5277.8 5328.7 1275.7 1311.5 1321.7 1327.3 1328.2 811.7 826.6 842.7 849.9 855.8 4063.6 4087.9 4105.8 4352.2 4505.1 5210.7 5367.5 5369.3 5381.8 5394.2 4577.2 4594.3 4597.7 4600.3 4600.4 2766.9 2836.3 2848.4 2867.9 2881.2 5074.6 5079.5 5112.5 5120.6 5134.2 5541.0 5544.3 5549.5 5566.2 5574.0 4847.2 5056.6 5080.7 5087.4 5091.9 5385.3 5388.5 5407.6 5414.9 5418.7 5250.4 5375.5 5386.1 5399.7 5414.5 5083.6 5089.1 5105.8 5112.3 5125.7 3746.4 3795.7 3801.2 3803.7 3811.0 5271.1 5465.9 5479.3 5484.1 5485.2 5203.5 5224.2 5251.3 5252.9 5264.4 5205.3 5210.8 5225.8 5227.8 5245.3 5040.4 5142.0 5156.6 5177.8 5190.5 5027.4 5251.2 5262.9 5285.6 5324.8 4965.6 5052.6 5100.2 5118.6 5130.6 01:30:30 INFO - PROCESS | 14170 | 01:30:30 INFO - PROCESS | 14170 | [#5] yui.html Cycles:180 Average:16496.18 Median:496.80 stddev:22344.76 (4497.7%) stddev-sans-first:22375.76 01:30:30 INFO - PROCESS | 14170 | Values: 649.7 655.2 683.9 735.0 755.3 13198.5 14311.6 14390.1 14406.6 14417.8 12502.0 12566.5 12573.3 12574.2 12597.2 627.9 641.9 742.0 752.5 758.7 776.9 779.3 779.6 779.9 780.4 820.2 825.3 826.3 827.2 830.2 812.4 815.6 816.3 817.4 820.4 603.5 604.2 604.8 605.5 605.9 13482.1 13504.1 13510.6 13542.9 13549.1 13355.4 13712.5 13863.7 13980.6 14174.3 11064.4 11102.6 11102.9 11201.3 11221.9 3366.5 3411.5 3425.6 3443.3 3528.3 60949.7 62432.4 65369.3 65642.3 65967.7 10413.8 10507.8 10575.2 10582.5 10744.2 16940.4 17712.1 20852.5 20920.6 20996.2 7198.5 7206.4 7220.4 7295.6 7301.9 3831.3 3899.8 3925.4 3933.9 3940.5 3005.6 3090.8 3102.0 3115.7 3136.7 494.7 498.9 499.3 510.6 538.8 448.9 510.8 514.5 517.6 520.6 7608.2 7716.3 7721.0 7888.3 8432.4 479.2 565.6 575.9 577.9 588.2 3862.6 3904.3 4099.0 4177.5 4200.5 71214.6 82432.6 87004.0 95710.5 98409.0 61481.0 63027.4 63656.4 73077.9 74256.0 43843.6 63911.7 65651.3 68537.0 68748.7 7974.5 8058.9 8530.6 8563.9 8591.1 39900.6 40639.2 41370.6 41661.0 42034.0 53587.2 56053.4 57905.4 58999.0 60757.4 9845.6 9997.9 10045.6 10269.6 10325.3 12419.6 12468.8 12738.5 13095.6 13370.3 10801.6 11119.9 11284.6 11624.0 11711.3 11515.2 12270.7 12354.6 12690.3 12712.5 10190.1 10332.7 10500.5 10515.7 10566.6 9612.7 10056.7 10186.9 10265.4 10523.2 8085.8 8580.3 8713.8 9192.8 9261.6 01:30:30 INFO - PROCESS | 14170 | -------- Summary: end -------- 01:30:30 INFO - PROCESS | 14170 | 01:30:31 INFO - TEST-INFO | 14170: exit 0 01:30:31 INFO - TEST-OK | dromaeo_css | took 1118671ms 01:30:31 INFO - TEST-START | kraken 01:30:31 INFO - operating with platform_type : linux_ 01:30:31 INFO - Initialising browser for kraken test... 01:30:31 INFO - TEST-INFO | started process 14523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjJhtRE/profile http://localhost:54754/getInfo.html) 01:30:36 INFO - PROCESS | 14523 | __metrics Screen width/height:1600/1200 01:30:36 INFO - PROCESS | 14523 | colorDepth:24 01:30:36 INFO - PROCESS | 14523 | Browser inner width/height: 1024/697 01:30:36 INFO - PROCESS | 14523 | __metrics 01:30:37 ERROR - PROCESS | 14523 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 3067: TypeError: this.tabs is undefined 01:30:38 INFO - TEST-INFO | 14523: exit 0 01:30:38 INFO - Browser initialized. 01:30:38 INFO - Running cycle 1/1 for kraken test... 01:30:38 INFO - TEST-INFO | started process 14645 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjJhtRE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:30:50 INFO - PROCESS | 14645 | RSS: Main: 186675200 01:30:50 INFO - PROCESS | 14645 | 01:30:53 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:54754/tests/kraken/driver.html?testName=audio-beat-detection) 01:30:54 INFO - PROCESS | 14645 | RSS: Main: 199991296 01:30:54 INFO - PROCESS | 14645 | 01:30:57 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:54754/tests/kraken/driver.html?testName=audio-dft) 01:30:57 INFO - PROCESS | 14645 | RSS: Main: 198213632 01:30:57 INFO - PROCESS | 14645 | 01:31:00 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:54754/tests/kraken/driver.html?testName=audio-fft) 01:31:01 INFO - PROCESS | 14645 | RSS: Main: 193994752 01:31:01 INFO - PROCESS | 14645 | 01:31:03 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:54754/tests/kraken/driver.html?testName=audio-oscillator) 01:31:04 INFO - PROCESS | 14645 | RSS: Main: 194637824 01:31:04 INFO - PROCESS | 14645 | 01:31:06 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:54754/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:31:06 INFO - PROCESS | 14645 | RSS: Main: 194650112 01:31:06 INFO - PROCESS | 14645 | 01:31:10 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:54754/tests/kraken/driver.html?testName=imaging-darkroom) 01:31:10 INFO - PROCESS | 14645 | RSS: Main: 194924544 01:31:10 INFO - PROCESS | 14645 | 01:31:14 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:54754/tests/kraken/driver.html?testName=imaging-desaturate) 01:31:14 INFO - PROCESS | 14645 | RSS: Main: 192729088 01:31:14 INFO - PROCESS | 14645 | 01:31:17 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:54754/tests/kraken/driver.html?testName=json-parse-financial) 01:31:18 INFO - PROCESS | 14645 | RSS: Main: 194510848 01:31:18 INFO - PROCESS | 14645 | 01:31:20 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:54754/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:31:20 INFO - PROCESS | 14645 | RSS: Main: 194949120 01:31:20 INFO - PROCESS | 14645 | 01:31:22 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:31:23 INFO - PROCESS | 14645 | RSS: Main: 194867200 01:31:23 INFO - PROCESS | 14645 | 01:31:25 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:31:26 INFO - PROCESS | 14645 | RSS: Main: 195117056 01:31:26 INFO - PROCESS | 14645 | 01:31:29 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:31:29 INFO - PROCESS | 14645 | RSS: Main: 194957312 01:31:29 INFO - PROCESS | 14645 | 01:31:32 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:31:33 INFO - PROCESS | 14645 | RSS: Main: 194990080 01:31:33 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | Cycle 1(1): loaded http://localhost:54754/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:54754/tests/kraken/driver.html?testName=ai-astar) 01:31:35 INFO - PROCESS | 14645 | RSS: Main: 196657152 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | __start_tp_report 01:31:35 INFO - PROCESS | 14645 | _x_x_mozilla_page_load 01:31:35 INFO - PROCESS | 14645 | _x_x_mozilla_page_load_details 01:31:35 INFO - PROCESS | 14645 | |i|pagename|runs| 01:31:35 INFO - PROCESS | 14645 | |0;ai-astar;108;115;115;116;114;115;117;115;115;115 01:31:35 INFO - PROCESS | 14645 | |1;audio-beat-detection;144;129;135;173;130;125;125;127;156;131 01:31:35 INFO - PROCESS | 14645 | |2;audio-dft;165;176;165;164;165;162;163;162;164;164 01:31:35 INFO - PROCESS | 14645 | |3;audio-fft;82;77;76;107;77;77;79;77;98;77 01:31:35 INFO - PROCESS | 14645 | |4;audio-oscillator;84;86;107;84;88;86;114;84;85;106 01:31:35 INFO - PROCESS | 14645 | |5;imaging-gaussian-blur;119;118;117;120;119;118;118;118;118;118 01:31:35 INFO - PROCESS | 14645 | |6;imaging-darkroom;147;147;147;148;147;148;148;150;147;149 01:31:35 INFO - PROCESS | 14645 | |7;imaging-desaturate;97;97;96;95;96;96;97;96;96;96 01:31:35 INFO - PROCESS | 14645 | |8;json-parse-financial;65;65;65;64;66;67;66;65;66;70 01:31:35 INFO - PROCESS | 14645 | |9;json-stringify-tinderbox;68;70;67;69;68;67;67;70;68;68 01:31:35 INFO - PROCESS | 14645 | |10;stanford-crypto-aes;86;87;84;83;84;84;84;87;84;87 01:31:35 INFO - PROCESS | 14645 | |11;stanford-crypto-ccm;138;135;132;145;138;144;149;137;168;136 01:31:35 INFO - PROCESS | 14645 | |12;stanford-crypto-pbkdf2;181;177;176;177;177;175;174;177;172;182 01:31:35 INFO - PROCESS | 14645 | |13;stanford-crypto-sha256-iterative;70;74;70;70;69;70;72;68;72;70 01:31:35 INFO - PROCESS | 14645 | __end_tp_report 01:31:35 INFO - PROCESS | 14645 | __start_cc_report 01:31:35 INFO - PROCESS | 14645 | _x_x_mozilla_cycle_collect,855 01:31:35 INFO - PROCESS | 14645 | __end_cc_report 01:31:35 INFO - PROCESS | 14645 | __startTimestamp1474965095506__endTimestamp 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | ------- Summary: start ------- 01:31:35 INFO - PROCESS | 14645 | Number of tests: 14 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:2.42 (2.1%) stddev-sans-first:0.83 01:31:35 INFO - PROCESS | 14645 | Values: 108.0 115.0 115.0 116.0 114.0 115.0 117.0 115.0 115.0 115.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#1] audio-beat-detection Cycles:10 Average:137.50 Median:133.00 stddev:15.79 (11.9%) stddev-sans-first:16.57 01:31:35 INFO - PROCESS | 14645 | Values: 144.0 129.0 135.0 173.0 130.0 125.0 125.0 127.0 156.0 131.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#2] audio-dft Cycles:10 Average:165.00 Median:164.50 stddev:4.03 (2.4%) stddev-sans-first:4.27 01:31:35 INFO - PROCESS | 14645 | Values: 165.0 176.0 165.0 164.0 165.0 162.0 163.0 162.0 164.0 164.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#3] audio-fft Cycles:10 Average:82.70 Median:77.00 stddev:10.78 (14.0%) stddev-sans-first:11.43 01:31:35 INFO - PROCESS | 14645 | Values: 82.0 77.0 76.0 107.0 77.0 77.0 79.0 77.0 98.0 77.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#4] audio-oscillator Cycles:10 Average:92.40 Median:84.50 stddev:11.70 (13.8%) stddev-sans-first:12.01 01:31:35 INFO - PROCESS | 14645 | Values: 84.0 86.0 107.0 84.0 88.0 86.0 114.0 84.0 85.0 106.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 01:31:35 INFO - PROCESS | 14645 | Values: 119.0 118.0 117.0 120.0 119.0 118.0 118.0 118.0 118.0 118.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.05 01:31:35 INFO - PROCESS | 14645 | Values: 147.0 147.0 147.0 148.0 147.0 148.0 148.0 150.0 147.0 149.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#7] imaging-desaturate Cycles:10 Average:96.20 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 01:31:35 INFO - PROCESS | 14645 | Values: 97.0 97.0 96.0 95.0 96.0 96.0 97.0 96.0 96.0 96.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#8] json-parse-financial Cycles:10 Average:65.90 Median:66.00 stddev:1.66 (2.5%) stddev-sans-first:1.73 01:31:35 INFO - PROCESS | 14645 | Values: 65.0 65.0 65.0 64.0 66.0 67.0 66.0 65.0 66.0 70.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:1.14 (1.7%) stddev-sans-first:1.20 01:31:35 INFO - PROCESS | 14645 | Values: 68.0 70.0 67.0 69.0 68.0 67.0 67.0 70.0 68.0 68.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#10] stanford-crypto-aes Cycles:10 Average:85.00 Median:85.00 stddev:1.56 (1.8%) stddev-sans-first:1.62 01:31:35 INFO - PROCESS | 14645 | Values: 86.0 87.0 84.0 83.0 84.0 84.0 84.0 87.0 84.0 87.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#11] stanford-crypto-ccm Cycles:10 Average:142.20 Median:141.00 stddev:10.43 (7.4%) stddev-sans-first:10.95 01:31:35 INFO - PROCESS | 14645 | Values: 138.0 135.0 132.0 145.0 138.0 144.0 149.0 137.0 168.0 136.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.80 Median:177.00 stddev:2.97 (1.7%) stddev-sans-first:2.74 01:31:35 INFO - PROCESS | 14645 | Values: 181.0 177.0 176.0 177.0 177.0 175.0 174.0 177.0 172.0 182.0 01:31:35 INFO - PROCESS | 14645 | 01:31:35 INFO - PROCESS | 14645 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.50 Median:70.00 stddev:1.72 (2.5%) stddev-sans-first:1.81 01:31:35 INFO - PROCESS | 14645 | Values: 70.0 74.0 70.0 70.0 69.0 70.0 72.0 68.0 72.0 70.0 01:31:35 INFO - PROCESS | 14645 | -------- Summary: end -------- 01:31:35 INFO - PROCESS | 14645 | 01:31:36 INFO - TEST-INFO | 14645: exit 0 01:31:36 INFO - TEST-OK | kraken | took 64932ms 01:31:36 INFO - SUITE-END | took 1183s 01:31:37 INFO - Completed test suite (00:19:43) 01:31:37 INFO - javascript benchmark 01:31:37 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6262.251442631319, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2578.587426011838, 2610.699769526504, 2611.386324213808, 2626.789856811455, 2656.7476089771476, 4551.453825540932, 4629.930551041729, 4685.765711714418, 4723.0, 4724.881877953053, 4580.427446569179, 4730.148573256813, 4774.045190961813, 4781.8804529886775, 4819.710817350952, 4301.139772045588, 4315.374270730742, 4377.781110944456, 4394.165108629366, 4503.594676479116, 4508.1659892919915, 4512.345709872066, 4518.683692141552, 4525.208088584484, 4533.773311334437, 4249.192653395845, 4297.03316753731, 4328.394024836525, 4379.562043795595, 4399.38408622793, 4331.480222373304, 4336.067745434715, 4342.609165175118, 4404.119176164748, 4485.416895803557, 4297.484301883763, 4331.545187755271, 4338.1540599583095, 4376.934345984812, 4385.407969924051, 4610.9308360374625, 4669.369635099252, 4725.8582242532775, 4728.550787675165, 4728.95271047292, 5022.447530771612, 5030.245463180516, 5036.0, 5036.118679231156, 5079.898402031976, 5063.18988961768, 5072.974635126838, 5077.898442031175, 5079.720615366154, 5082.23766435034, 4521.9321710174045, 4574.336721175478, 4667.043256132485, 4688.71867687933, 4698.130845793471, 5154.046501397253, 5172.456892026283, 5175.042617115846, 5188.325517682752, 5228.6862788232065, 4945.085159245551, 4969.3291405659775, 4973.701577905337, 4991.80032798684, 5019.121653710586, 4910.337104490919, 5019.548240658358, 5035.924461133086, 5056.064628043824, 5079.187330027178, 5042.546170844642, 5059.747012649353, 5061.139606266944, 5064.392272927273, 5107.795688172431, 5048.974755126201, 5063.772130254148, 5064.46823083571, 5069.239614057847, 5095.108356037678, 4153.54311025787, 4197.538270790211, 4255.659547236213, 4288.206681763883, 4360.149770794665, 3731.794751288651, 3746.194568167857, 3773.471713960048, 3802.16352402471, 3818.293615681108, 4360.542143074931, 4365.541618130114, 4372.147431250875, 4376.693631445768, 4399.5160532341415, 4906.852794416173, 4954.479779623088, 4958.0, 5089.9745501273, 5122.410922743932, 4297.162053399557, 4323.0, 4324.935125973113, 4339.153864996296, 4357.9782101089295, 4591.380163677927, 4600.918784085738, 4601.654875884322, 4638.350630911675, 4655.4180727409075, 4812.374391329105, 4817.518248175154, 4818.204996175662, 4864.343313652612, 4880.267959806058, 4941.085899108676, 4989.850304490871, 5025.824096156617, 5099.056674515078, 5106.0, 4804.111239420718, 4823.3729615149805, 4824.565789079, 4877.170880950318, 4893.853184404474, 4806.351142595705, 4846.442659094249, 4875.268709693574, 4950.158473059517, 5031.371078615173, 4976.477469865612, 4996.775145118406, 5015.272785446017, 5015.423226329019, 5067.594592432522, 4791.089692958327, 4838.588719958843, 4896.4858689838475, 4912.95087049125, 4946.084974279625, 4890.095332363524, 4907.043126590281, 4984.975075124601, 5021.824236151717, 5030.949690503048, 4842.854714358575, 4881.389826271716, 4906.656534042583, 4916.385451818523, 4918.532739389752, 4838.709677419366, 4885.096257192431, 4953.18272485036, 5019.121653710659, 5029.44676085623, 4855.174620314626, 4909.26361045846, 4915.827946021872, 4922.852314430573, 4985.52637499437], "value": 4644.948805146854, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [545.8962797068557, 552.1965540139098, 558.0011778915735, 567.0784974416572, 572.0646742575888, 37496.25007499848, 39055.80472097639, 39072.80463597681, 42280.57719422805, 42335.36496952548, 39030.414543781866, 39123.0, 39167.21665566687, 39254.0, 39558.208835823265, 7541.924580754177, 7651.081870175587, 7652.655630496641, 7700.306972372486, 7705.113911900119, 7525.924740752577, 7531.924680753177, 7627.847443051136, 7633.9618301908695, 7646.082470103595, 7585.81035474112, 7604.239576042407, 7616.543007419545, 7637.579933103705, 7650.961745191294, 7545.358644515223, 7582.355499782553, 7583.544987300779, 7616.753057847948, 7619.428542859252, 7573.962130189314, 7629.465937384385, 7631.885521717123, 7633.389328853734, 7634.236576342377, 37247.62752372469, 37386.06534836651, 37525.0, 37856.0, 37869.81065094657, 3003.4743919814164, 3126.3747250549754, 3226.2257058305836, 3302.4055669979393, 3512.9297414051575, 27563.0, 27622.585661215096, 27913.860430697718, 28147.0, 28446.857765711247, 3459.6021457532456, 3477.4436090225695, 3493.2664140530264, 3511.10466830959, 3549.538559987211, 253394.0, 257152.0, 258539.0, 258585.0, 258612.70693646598, 52404.73797630987, 52797.7360113197, 52909.2063619046, 52923.73538132285, 52979.205311920356, 31660.525092123637, 32437.837810810794, 32537.186570335456, 34276.828615856764, 56043.0, 12686.11197216186, 12873.0, 12877.678058048623, 12892.355382230851, 13011.284379359226, 9370.10983956523, 9477.90522094784, 9556.808863822685, 9595.136437720499, 9634.807303854024, 17505.912470437823, 17565.912170439067, 17580.472585822445, 17584.736228956575, 17696.0, 6760.695768690421, 6800.075967333995, 6875.931240687629, 6911.654417279216, 6941.965290173517, 779.7621725373815, 865.5023361566998, 890.17213990989, 913.9131782480654, 966.3231404505923, 26380.34049148748, 27499.587506187425, 27656.0, 28032.8598357011, 28056.71943280541, 910.1535571918047, 946.5409276500892, 963.9759006024906, 1005.9195264378832, 1006.7634105985088, 13705.383257753425, 14167.856893159187, 14532.927335363256, 14566.41734330615, 14640.633984150481, 336263.0, 390704.0, 400477.0, 401486.0, 600761.0, 47981.0, 48121.0, 48127.0, 48165.0, 48729.5127048725, 1176.9352685602373, 1183.1303991566192, 1208.1482554798845, 1212.1272683667746, 1214.2714371377103, 26599.069032583768, 27559.535111474957, 27638.86180569084, 28540.714592853805, 28603.570946435404, 41177.38233926434, 41707.37438938479, 41762.37356439595, 41829.37255941102, 41844.581554185286, 310869.0, 311609.0, 314827.0, 316232.0, 317085.0, 24172.0, 24483.0, 24562.0, 24567.262982110566, 24609.384765381008, 39573.60426395814, 40030.0, 40067.79966100151, 40197.0, 40648.18703625852, 33254.66745332516, 34395.0, 34555.65444345524, 34602.307953841286, 35037.0, 34278.314433710686, 34387.0, 34393.828030860685, 34780.47829282512, 35271.823640882656, 27525.449491009666, 29717.405651887275, 29939.101826945225, 33372.66627333696, 33937.15157121092, 29510.0, 31740.682593173773, 31986.840065799523, 32279.35441291208, 32286.677133228368, 23981.880090599436, 24077.879610601834, 24271.57284271559, 24448.755512444648, 24474.388140296636], "value": 16922.596793486195, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [348.1817728338407, 361.5444539879751, 368.9870854520091, 370.4887255587289, 379.1242230447666, 15596.92201538992, 15750.684986300266, 16913.915430422847, 17053.0, 17058.14709264538, 13681.589552313422, 16885.49343519693, 17046.744298835496, 17106.401275955344, 17155.056471894073, 4398.692091553593, 4556.863294101166, 4626.329182268569, 4726.621870250389, 4737.147313483571, 4667.15991121598, 4700.482946875841, 4703.0, 4705.858824235278, 4706.482286948433, 4642.210824159901, 5013.473585273548, 5070.138076527, 5080.110980578384, 5100.081985242655, 4956.628252881031, 4996.9500304996845, 5015.122353588125, 5015.949840501603, 5017.724025178613, 4405.625521830616, 4454.888627784331, 4526.569975852289, 4531.0, 4555.589996900262, 12234.327112008836, 12375.381230938507, 12387.62837114888, 12465.065120115936, 12573.685657858536, 1867.1037901807074, 1928.701051337045, 1929.2861641192708, 2065.0707181768266, 2239.7648246934164, 8793.384463087586, 9153.313501487415, 9362.438253704799, 9589.904100958971, 9607.711768646952, 1580.1230317173963, 1676.4886709553582, 1737.730651748981, 1799.2533098763997, 1809.1587411853552, 61554.69222653903, 63482.68258658723, 64783.3521664782, 65248.67375663092, 67750.3224967749, 9616.615335386647, 9986.151177150025, 10074.3955362677, 10227.28409011362, 10251.692449226535, 13693.657658558615, 13697.931510342583, 13727.313634318245, 13738.65653358654, 13740.65648358779, 6810.148731408574, 7082.610456424843, 7127.322904324081, 7279.41764658826, 7289.635518224173, 6621.602703837785, 6718.832029199211, 6875.862482750317, 6901.309869013159, 6908.171019477594, 4094.0, 4160.126373461547, 4204.3693445982735, 4309.41822853917, 4366.235908715962, 1751.448293787453, 1814.97277540837, 1822.9635407292046, 1830.2130084063715, 1845.8061903499938, 779.7387875061804, 811.7118422959883, 815.9061707903548, 827.8302947895787, 872.7599910024667, 15776.290066947015, 16710.248038838283, 16778.496645100666, 17370.565735856704, 17621.383251586132, 819.148085990575, 819.8196396792696, 824.5011767880346, 827.4456114403364, 834.7120243515977, 9194.49430281341, 9720.756981075388, 9761.414315141114, 9816.116549510578, 9967.352122112039, 341154.0, 349353.0, 349702.0, 350304.0, 350322.0, 72666.27333726596, 73021.2697873025, 74424.25575744282, 74548.62725686337, 74661.25338746543, 852.8209076093966, 886.3042511628341, 914.7392992996831, 944.0700909604035, 948.0, 15638.218089095728, 15676.608084797515, 15771.921140394224, 15998.9200053999, 16222.0, 34548.65451345555, 35679.0, 36251.0, 37017.62982370142, 37106.44340334951, 47931.520684792704, 48496.757516212194, 48548.514514854396, 48839.5116048835, 49378.259326110856, 4750.239961606127, 4816.518348165156, 7354.96322518384, 7625.199354067743, 7808.297253247235, 10150.847737284093, 11277.266977646426, 11940.283582985048, 12168.209066410654, 12346.938265308616, 10279.280450368402, 10285.84571231447, 10340.37957722539, 10416.739581510523, 10836.783264334827, 9789.167920726817, 10199.38803671782, 10312.639057632947, 10351.223658225512, 10532.210084243865, 10345.224108192066, 10356.326838755456, 10471.738206544896, 10537.63118290856, 10855.2401331906, 7481.625918704151, 7514.736984205527, 7671.654775535226, 7959.641816118173, 8143.104258531675, 9971.551280192554, 10608.522616482123, 10627.521761520904, 10698.62554810578, 10735.141188704729], "value": 7839.679053404624, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1317.5256907513296, 1354.7358265138298, 1418.9858101418984, 1661.1943207544346, 1672.197345274269, 6741.191057073146, 6982.3715865572085, 7142.428605711543, 7640.7325743598985, 7650.196729343415, 7121.181064177621, 7386.704531818721, 7409.222031686662, 7525.51084179528, 7602.619869006541, 2146.796054374836, 2176.0, 2177.629802933497, 2182.6398644223764, 2183.8034576888076, 2107.1360742095744, 2119.5231073008526, 2162.0378931375544, 2166.04693934669, 2168.1002384010617, 2118.7139736135655, 2124.3945475539476, 2143.024923659731, 2143.474848662072, 2163.167180635451, 2066.08059413561, 2069.627467055929, 2073.419442556087, 2087.7912208779, 2090.5400811821373, 2029.8376129909573, 2111.5354621983292, 2135.3807395855183, 2138.9358319250446, 2142.3465842917904, 7534.0582427196605, 7665.8850117248285, 7669.041369828771, 7669.0797104347275, 7723.575203363813, 4253.936190957138, 4386.495553011413, 4388.626966707834, 4389.034412429261, 4394.868153955386, 2700.1359564939225, 2766.986165069162, 2897.840618765967, 2902.274431392152, 2910.54886492594, 888.6667499687617, 936.0358830404695, 955.6702937486625, 957.8658987741721, 960.4237457525498, 10255.846162307571, 10331.380117192992, 10381.532831022621, 10391.532381042796, 10455.477226138662, 3872.7676339419727, 4058.837646494166, 4134.1731653668785, 4164.333706606928, 4200.369944508348, 8803.867941980876, 8851.583746600512, 8872.24585910192, 8886.86669699955, 8906.955465222632, 4596.6092882105395, 4598.517155698671, 4600.332951722048, 4606.976965115153, 4610.861674149781, 3676.28312479064, 3804.429335599627, 4032.1129351542613, 4185.874423767292, 4193.5387107418155, 3548.964510354915, 3617.1318883468302, 3623.438367053111, 3724.273766615538, 3736.7384283100464, 1175.18324764288, 1204.0367705835297, 1206.7707135644375, 1210.6549633354628, 1212.5271144253747, 754.8754455514778, 777.992220077792, 779.6335722210551, 790.8695065314274, 824.221111050052, 4960.528749768766, 5001.474845141281, 5017.498250174954, 5176.301199338041, 5212.791488340424, 402.92143032109044, 407.4743580780819, 408.1897433594313, 408.7567897101279, 411.2084237842142, 3497.632748561415, 3584.4802503636824, 3625.3474374612297, 3653.141511744791, 3779.981100094537, 8589.52757598338, 8973.50645714492, 9007.909920900838, 9009.144131307516, 9053.77365565866, 8964.417312874642, 8978.86531702025, 8982.416142950688, 9011.63953441855, 9021.684241051531, 6923.515353925278, 6950.79147625572, 7003.194632617212, 7051.788446346618, 7056.188538318056, 4821.2045012573935, 4877.756112194305, 4899.216125420058, 4965.652404331662, 5012.0, 8199.95900020496, 8266.628001740057, 8420.705275315335, 8445.1977062179, 8517.659293628185, 8417.116202798617, 8457.78855528592, 8488.448250863674, 8613.353998450017, 8650.653973840976, 5795.043817770189, 5970.97014514942, 6291.245050593775, 6415.358464153547, 6423.229212494531, 6745.662716864235, 6922.7923162305215, 6924.0, 7026.297370262932, 7063.328983746535, 5975.103734439869, 5992.730327135377, 6074.149619053248, 6096.756129754937, 6115.235595550556, 5830.708464576839, 5843.532517398513, 5857.0, 5881.382454842351, 6003.099535069775, 5717.142428635738, 5870.119482077723, 5931.614445061057, 5937.228160339128, 6066.969665151646, 4187.6440502557625, 4283.421738065446, 4300.8709738707885, 4338.869833904988, 4407.823687052482, 4291.399204111364, 4350.847720329773, 4407.184670835777, 4414.139242847742, 4486.439195100613], "value": 3897.3447594122295, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.77174418081796, 291.8103232898616, 297.31320649300113, 300.58519243444056, 303.5749950069903, 4898.534639209274, 5048.116579598569, 5071.391433028042, 5112.28428020077, 5148.279240906276, 4938.38270216223, 4942.728149951751, 4960.826371077013, 4985.152524070908, 4991.675541089836, 3667.963320366789, 3778.6410291022307, 3872.7095467839886, 3894.591067937868, 3904.219156168763, 3753.86861459849, 3821.3503704370187, 3825.2540754552733, 3837.2517359114986, 3839.4240863870505, 3762.473253744478, 3785.470034195215, 3807.2956503046885, 3824.655780979725, 3826.426036094594, 3806.809659517041, 3806.9238615227678, 3824.560175579802, 3834.2331533693373, 3835.8082095895093, 3178.713915747594, 3314.2708604107297, 3341.3484370547753, 3367.4948757686298, 3383.1372999885116, 4860.173770458995, 4862.270659401082, 4872.610191184696, 4876.390451193601, 4879.975600122012, 4389.934150987738, 4396.934045989281, 4400.427944367244, 4405.427294451732, 4408.647308215335, 5025.346704928336, 5168.813261258355, 5206.5314121729225, 5222.294990176316, 5224.059669259532, 3637.563492380905, 3642.2169233614636, 3642.21692336149, 3648.434492653643, 3655.908602284964, 5429.104197807357, 5437.891242175174, 5502.58730595203, 5513.50378465936, 5527.723613819293, 3529.3117842021074, 3736.925261494755, 3745.7939813309986, 3752.1745216052423, 3753.7800214930257, 3779.7732136071922, 3785.507883975121, 3788.3749181385315, 3805.162864169878, 3818.904527386782, 4366.737995720267, 4367.519572846984, 4374.78126093694, 4383.969767104728, 4401.84593539231, 5212.879230965361, 5242.659227150223, 5258.237555554423, 5277.788888444419, 5328.706921119298, 1275.7320962597773, 1311.5147395463548, 1321.7488677151312, 1327.2965328375976, 1328.2296268164441, 811.6712731343697, 826.5949684654476, 842.6966292134827, 849.9320054395633, 855.8459477294147, 4063.553009168989, 4087.8773636790943, 4105.794710264475, 4352.238358287287, 4505.07645932583, 5210.661307015108, 5367.5169234769055, 5369.315342328836, 5381.811636592701, 5394.163904594794, 4577.176108300538, 4594.264917613166, 4597.678162528591, 4600.309953506934, 4600.4479462464715, 2766.9308267293077, 2836.305105249227, 2848.430313937221, 2867.913962581126, 2881.1704567599304, 5074.619403544749, 5079.492050794891, 5112.514311140436, 5120.61595380348, 5134.178531435027, 5540.97491963988, 5544.279243698294, 5549.528290095306, 5566.165075238747, 5574.021222466047, 4847.200211964986, 5056.595472362275, 5080.745962701924, 5087.389513258433, 5091.949080509222, 5385.27298814655, 5388.515033646991, 5407.648502847303, 5414.945850541444, 5418.674879507243, 5250.422453530185, 5375.543078838343, 5386.061018033426, 5399.730013499231, 5414.539764120094, 5083.644144909821, 5089.1094058538865, 5105.795768169231, 5112.335396398445, 5125.666831655931, 3746.4265008696957, 3795.6773674237998, 3801.239752049546, 3803.7337386383792, 3810.9618903810606, 5271.1039123348355, 5465.945340546544, 5479.315085614298, 5484.080571799838, 5485.204645326485, 5203.531682148625, 5224.190250511177, 5251.264822924717, 5252.868678283074, 5264.368275806928, 5205.297284866495, 5210.791568337376, 5225.790968361223, 5227.811035268559, 5245.347715469615, 5040.42035165946, 5141.997310524412, 5156.5616922562, 5177.8187763428095, 5190.506901844319, 5027.371578552681, 5251.186066159598, 5262.947370526399, 5285.550728187994, 5324.7870085196155, 4965.627577931597, 5052.646314757932, 5100.2349647553165, 5118.590512759045, 5130.640855140105], "value": 3904.7298273700126, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [649.7043845050503, 655.2497390487891, 683.8803209438347, 734.9595772232528, 755.3390783064816, 13198.472061117556, 14311.642208944782, 14390.1365918045, 14406.567802965901, 14417.78373324401, 12502.0, 12566.497340106385, 12573.308468034254, 12574.182678125915, 12597.181183223083, 627.8712863862897, 641.881251968385, 741.9517731347445, 752.5409500204885, 758.7003133762161, 776.8873513340562, 779.286952438518, 779.6179871862774, 779.8908152858604, 780.4029917113413, 820.2371794231362, 825.2902503846717, 826.3471857232779, 827.2058823529419, 830.1781236575807, 812.4353574265888, 815.5962798414793, 816.2572059425923, 817.3787921179886, 820.3806126374609, 603.523216658839, 604.2205554834259, 604.7701873288122, 605.4550904186224, 605.9424354686298, 13482.05625606208, 13504.054716169872, 13510.594682159552, 13542.932285338511, 13549.119307244997, 13355.399007044609, 13712.52006179779, 13863.66008977975, 13980.580582582437, 14174.291285435791, 11064.446777661085, 11102.61140860066, 11102.944485277603, 11201.327920324726, 11221.943890280496, 3366.495025746158, 3411.4541673332396, 3425.5546778918583, 3443.328550932569, 3528.2943411317838, 60949.69525152346, 62432.375676243566, 65369.346306536805, 65642.3435765641, 65967.67016164889, 10413.791724165474, 10507.842382364272, 10575.20685948557, 10582.470876456146, 10744.247902646739, 16940.407085752187, 17712.114394280234, 20852.47868803292, 20920.58158836845, 20996.160153593686, 7198.5320954137815, 7206.423486121098, 7220.350168484862, 7295.598742069131, 7301.89047164293, 3831.310364134427, 3899.8245078971513, 3925.4111883217174, 3933.92132157361, 3940.4680368150507, 3005.6242969628797, 3090.8300043497375, 3101.9689803102133, 3115.6572776994512, 3136.6549679535233, 494.66610038224053, 498.93264409304277, 499.3059647090547, 510.62213961668095, 538.8383484954498, 448.91470620581987, 510.79312878284355, 514.5471984653481, 517.6195496310208, 520.6407578770636, 7608.163102058769, 7716.344110750537, 7721.0, 7888.271816327501, 8432.409731318749, 479.2284422080448, 565.6408180805136, 575.893459709955, 577.8844231153702, 588.1677426441623, 3862.575116737157, 3904.2581909437117, 4098.959010409917, 4177.4778152730905, 4200.474940632421, 71214.64392678003, 82432.58783706043, 87004.0, 95710.52144739231, 98409.0, 61481.0, 63027.36972630215, 63656.36343636597, 73077.90383144257, 74256.0, 43843.56156438459, 63911.68044159842, 65651.34348656549, 68537.0, 68748.65625671939, 7974.481658692166, 8058.879116813369, 8530.573471326534, 8563.871541927001, 8591.054983951884, 39900.60099399085, 40639.1872162561, 41370.58629413667, 41661.0, 42034.0, 53587.19619205637, 56053.439465604824, 57905.42094579, 58999.0, 60757.39242607694, 9845.556949937414, 9997.850032249667, 10045.598176072876, 10269.640562580274, 10325.277230593787, 12419.565315213924, 12468.750624987268, 12738.522435352887, 13095.607131786062, 13370.264635445144, 10801.567937282422, 11119.944400277947, 11284.605038823602, 11623.953844154066, 11711.297322160697, 11515.19393642437, 12270.693232669255, 12354.629361119181, 12690.302033387883, 12712.491500339884, 10190.082892539707, 10332.690019299433, 10500.509297169856, 10515.737106572396, 10566.577336906437, 9612.663556775758, 10056.748581285527, 10186.898131018892, 10265.435401053013, 10523.210759193244, 8085.757427277191, 8580.266772253657, 8713.782155446164, 9192.770180745534, 9261.629534818532], "value": 6430.257126641032, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1563.0, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [108.0, 115.0, 115.0, 116.0, 114.0, 115.0, 117.0, 115.0, 115.0, 115.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 129.0, 135.0, 173.0, 130.0, 125.0, 125.0, 127.0, 156.0, 131.0], "value": 137.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 176.0, 165.0, 164.0, 165.0, 162.0, 163.0, 162.0, 164.0, 164.0], "value": 165.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 77.0, 76.0, 107.0, 77.0, 77.0, 79.0, 77.0, 98.0, 77.0], "value": 82.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 107.0, 84.0, 88.0, 86.0, 114.0, 84.0, 85.0, 106.0], "value": 92.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 118.0, 117.0, 120.0, 119.0, 118.0, 118.0, 118.0, 118.0, 118.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 148.0, 150.0, 147.0, 149.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 97.0, 96.0, 95.0, 96.0, 96.0, 97.0, 96.0, 96.0, 96.0], "value": 96.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 64.0, 66.0, 67.0, 66.0, 65.0, 66.0, 70.0], "value": 65.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 70.0, 67.0, 69.0, 68.0, 67.0, 67.0, 70.0, 68.0, 68.0], "value": 68.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 84.0, 83.0, 84.0, 84.0, 84.0, 87.0, 84.0, 87.0], "value": 85.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 135.0, 132.0, 145.0, 138.0, 144.0, 149.0, 137.0, 168.0, 136.0], "value": 142.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 177.0, 176.0, 177.0, 177.0, 175.0, 174.0, 177.0, 172.0, 182.0], "value": 176.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 74.0, 70.0, 70.0, 69.0, 70.0, 72.0, 68.0, 72.0, 70.0], "value": 70.5, "unit": "score"}]}]} 01:31:37 INFO - Return code: 0 01:31:37 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:31:37 ERROR - # TBPL SUCCESS # 01:31:37 INFO - Running post-action listener: _resource_record_post_action 01:31:37 INFO - [mozharness: 2016-09-27 08:31:37.302380Z] Finished run-tests step (success) 01:31:37 INFO - Running post-run listener: _resource_record_post_run 01:31:37 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 16384; Write bytes: 402923520; Read time: 40; Write time: 283088 01:31:37 INFO - TinderboxPrint: CPU usage
13.4% 01:31:37 INFO - TinderboxPrint: I/O read bytes / time
16,384 / 40 01:31:37 INFO - TinderboxPrint: I/O write bytes / time
402,923,520 / 283,088 01:31:37 INFO - TinderboxPrint: CPU idle
8,290.3 (86.6%) 01:31:37 INFO - TinderboxPrint: CPU user
1,219.3 (12.7%) 01:31:37 INFO - TinderboxPrint: Swap in / out
0 / 0 01:31:37 INFO - install - Wall time: 16s; CPU: 13.0%; Read bytes: 0; Write bytes: 110530560; Read time: 0; Write time: 66748 01:31:37 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 12288; Write bytes: 292392960; Read time: 28; Write time: 216340 01:31:37 INFO - Running post-run listener: _upload_blobber_files 01:31:37 INFO - Blob upload gear active. 01:31:37 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:31:37 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 01:31:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:31:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:31:38 INFO - (blobuploader) - INFO - Open directory for files ... 01:31:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:31:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:31:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:31:39 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:31:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:31:39 INFO - (blobuploader) - INFO - Done attempting. 01:31:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:31:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:31:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:31:45 INFO - (blobuploader) - INFO - Done attempting. 01:31:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:31:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:31:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:31:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:31:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:31:45 INFO - (blobuploader) - INFO - Done attempting. 01:31:45 INFO - (blobuploader) - INFO - Iteration through files over. 01:31:45 INFO - Return code: 0 01:31:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:31:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:31:45 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/337f994e79a17ec8cc6870eed6e339181252ce2aac6f5c22042b1642416b980c1274a09fae01f0a1ad7a34cee920693e043f523122118b6d8a2b2842a4b49d5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6fe7252f3598e5c828c709cd5f9b41555a942805b88c0a711df03505029a8fe7bad4009fe2c7af5327ec9048cca21deefd7227bbe0a969bfba621916d39c3597", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8eb90dc66b7aca8c9c78ef38bd881fa9816fbd3c2c8cbcfaaa29df41918b96d28797c897547a044316b05d8ffdc30fd91c5afe5410fa6df88328591424a53a6b"} 01:31:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:31:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:31:45 INFO - Contents: 01:31:45 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/337f994e79a17ec8cc6870eed6e339181252ce2aac6f5c22042b1642416b980c1274a09fae01f0a1ad7a34cee920693e043f523122118b6d8a2b2842a4b49d5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6fe7252f3598e5c828c709cd5f9b41555a942805b88c0a711df03505029a8fe7bad4009fe2c7af5327ec9048cca21deefd7227bbe0a969bfba621916d39c3597", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8eb90dc66b7aca8c9c78ef38bd881fa9816fbd3c2c8cbcfaaa29df41918b96d28797c897547a044316b05d8ffdc30fd91c5afe5410fa6df88328591424a53a6b"} 01:31:45 INFO - Running post-run listener: copy_logs_to_upload_dir 01:31:45 INFO - Copying logs to upload dir... 01:31:45 INFO - mkdir: /builds/slave/test/build/upload/logs 01:31:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1245.658652 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 45 secs) (at 2016-09-27 01:31:45.540080) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 01:31:45.543696) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/337f994e79a17ec8cc6870eed6e339181252ce2aac6f5c22042b1642416b980c1274a09fae01f0a1ad7a34cee920693e043f523122118b6d8a2b2842a4b49d5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6fe7252f3598e5c828c709cd5f9b41555a942805b88c0a711df03505029a8fe7bad4009fe2c7af5327ec9048cca21deefd7227bbe0a969bfba621916d39c3597", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8eb90dc66b7aca8c9c78ef38bd881fa9816fbd3c2c8cbcfaaa29df41918b96d28797c897547a044316b05d8ffdc30fd91c5afe5410fa6df88328591424a53a6b"} build_url:https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/artifacts/public/build/firefox-52.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011402 build_url: 'https://queue.taskcluster.net/v1/task/Kem2g9WdRJuBc71DQr-SUg/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-Non-PGO/sha512/337f994e79a17ec8cc6870eed6e339181252ce2aac6f5c22042b1642416b980c1274a09fae01f0a1ad7a34cee920693e043f523122118b6d8a2b2842a4b49d5e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/6fe7252f3598e5c828c709cd5f9b41555a942805b88c0a711df03505029a8fe7bad4009fe2c7af5327ec9048cca21deefd7227bbe0a969bfba621916d39c3597", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/8eb90dc66b7aca8c9c78ef38bd881fa9816fbd3c2c8cbcfaaa29df41918b96d28797c897547a044316b05d8ffdc30fd91c5afe5410fa6df88328591424a53a6b"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-09-27 01:31:45.569657) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 01:31:45.569997) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1474962711.307375-1369578284 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004363 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-09-27 01:31:45.655348) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 01:31:45.655979) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-09-27 01:31:45.656749) ========= ========= Total master_lag: 0.18 =========