builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-053 starttime: 1468409019.09 results: success (0) buildid: 20160713010620 builduid: 3c0c255ab5f942f0b8747a6bf81a3941 revision: 7054f1c4d2b1 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:39.092717) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:39.093174) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:39.093482) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:39.106632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:39.106933) ========= 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=920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-13 04:23:39-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-07-13 04:23:39 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.119208 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:39.237740) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:39.238067) ========= 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=920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019476 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:39.287649) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:39.287973) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7054f1c4d2b1 --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 7054f1c4d2b1 --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=920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-13 04:23:39,933 Setting DEBUG logging. 2016-07-13 04:23:39,933 attempt 1/10 2016-07-13 04:23:39,933 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7054f1c4d2b1?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-13 04:23:40,299 unpacking tar archive at: fx-team-7054f1c4d2b1/testing/mozharness/ program finished with exit code 0 elapsedTime=0.701884 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:40.003431) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:40.003738) ========= script_repo_revision: 7054f1c4d2b1 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:40.004203) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:40.004541) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-13 04:23:40.012970) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-13 04:23:40.013400) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:23:40 INFO - MultiFileLogger online at 20160713 04:23:40 in /builds/slave/test 04:23:40 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 04:23:40 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:23:40 INFO - {'append_to_log': False, 04:23:40 INFO - 'base_work_dir': '/builds/slave/test', 04:23:40 INFO - 'blob_upload_branch': 'Fx-Team', 04:23:40 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:23:40 INFO - 'branch': 'Fx-Team', 04:23:40 INFO - 'buildbot_json_path': 'buildprops.json', 04:23:40 INFO - 'config_files': ('talos/linux_config.py',), 04:23:40 INFO - 'default_actions': ('clobber', 04:23:40 INFO - 'read-buildbot-config', 04:23:40 INFO - 'download-and-extract', 04:23:40 INFO - 'populate-webroot', 04:23:40 INFO - 'create-virtualenv', 04:23:40 INFO - 'install', 04:23:40 INFO - 'run-tests'), 04:23:40 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:23:40 INFO - 'download_minidump_stackwalk': True, 04:23:40 INFO - 'download_symbols': 'ondemand', 04:23:40 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:23:40 INFO - 'tooltool.py': '/tools/tooltool.py', 04:23:40 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:23:40 INFO - '/tools/misc-python/virtualenv.py')}, 04:23:40 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:23:40 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:23:40 INFO - 'installer_path': 'installer.exe', 04:23:40 INFO - 'log_level': 'info', 04:23:40 INFO - 'log_name': 'talos', 04:23:40 INFO - 'log_to_console': True, 04:23:40 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:23:40 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:23:40 INFO - 'opt_config_files': (), 04:23:40 INFO - 'pip_index': False, 04:23:40 INFO - 'sps_profile': False, 04:23:40 INFO - 'sps_profile_interval': 0, 04:23:40 INFO - 'suite': 'dromaeojs-e10s', 04:23:40 INFO - 'system_bits': '32', 04:23:40 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:23:40 INFO - 'title': 'talos-linux64-ix-053', 04:23:40 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:23:40 INFO - 'use_talos_json': True, 04:23:40 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:23:40 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:23:40 INFO - 'work_dir': 'build'} 04:23:40 INFO - ##### 04:23:40 INFO - ##### Running clobber step. 04:23:40 INFO - ##### 04:23:40 INFO - Running pre-action listener: _resource_record_pre_action 04:23:40 INFO - Running main action method: clobber 04:23:40 INFO - rmtree: /builds/slave/test/build 04:23:40 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:23:41 INFO - Running post-action listener: _resource_record_post_action 04:23:41 INFO - ##### 04:23:41 INFO - ##### Finished clobber step (success) 04:23:41 INFO - ##### 04:23:41 INFO - ##### 04:23:41 INFO - ##### Running read-buildbot-config step. 04:23:41 INFO - ##### 04:23:41 INFO - Running pre-action listener: _resource_record_pre_action 04:23:41 INFO - Running main action method: read_buildbot_config 04:23:41 INFO - Using buildbot properties: 04:23:41 INFO - { 04:23:41 INFO - "project": "", 04:23:41 INFO - "product": "firefox", 04:23:41 INFO - "script_repo_revision": "production", 04:23:41 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 04:23:41 INFO - "repository": "", 04:23:41 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team pgo talos dromaeojs-e10s", 04:23:41 INFO - "buildid": "20160713010620", 04:23:41 INFO - "pgo_build": "True", 04:23:41 INFO - "basedir": "/builds/slave/test", 04:23:41 INFO - "buildnumber": 921, 04:23:41 INFO - "slavename": "talos-linux64-ix-053", 04:23:41 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:23:41 INFO - "platform": "ubuntu64_hw", 04:23:41 INFO - "scheduler": "tests-fx-team-linux64-pgo-talos", 04:23:41 INFO - "branch": "fx-team", 04:23:41 INFO - "repo_path": "integration/fx-team", 04:23:41 INFO - "revision": "7054f1c4d2b1", 04:23:41 INFO - "stage_platform": "linux64-pgo", 04:23:41 INFO - "builduid": "3c0c255ab5f942f0b8747a6bf81a3941", 04:23:41 INFO - "slavebuilddir": "test" 04:23:41 INFO - } 04:23:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:23:41 INFO - Running post-action listener: _resource_record_post_action 04:23:41 INFO - ##### 04:23:41 INFO - ##### Finished read-buildbot-config step (success) 04:23:41 INFO - ##### 04:23:41 INFO - ##### 04:23:41 INFO - ##### Running download-and-extract step. 04:23:41 INFO - ##### 04:23:41 INFO - Running pre-action listener: _resource_record_pre_action 04:23:41 INFO - Running main action method: download_and_extract 04:23:41 INFO - mkdir: /builds/slave/test/build/tests 04:23:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:41 INFO - https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:23:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:23:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:23:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:23:42 INFO - Downloaded 1361 bytes. 04:23:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:23:42 INFO - Using the following test package requirements: 04:23:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:23:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:23:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:42 INFO - u'jsshell-linux-x86_64.zip'], 04:23:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:23:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:23:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:23:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:23:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:23:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:23:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:23:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:23:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:42 INFO - https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:23:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:23:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:23:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:43 INFO - Downloaded 24320264 bytes. 04:23:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:23:45 INFO - Return code: 0 04:23:45 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:23:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:45 INFO - https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:23:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:23:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:23:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:23:46 INFO - Downloaded 24320264 bytes. 04:23:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:23:47 INFO - Return code: 0 04:23:47 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:47 INFO - https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:23:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:23:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:23:48 INFO - Downloaded 14403317 bytes. 04:23:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:23:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:23:48 INFO - Return code: 0 04:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:48 INFO - https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:23:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:23:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:23:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:23:50 INFO - Downloaded 60793306 bytes. 04:23:50 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:23:50 INFO - mkdir: /builds/slave/test/properties 04:23:50 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:23:50 INFO - Writing to file /builds/slave/test/properties/build_url 04:23:50 INFO - Contents: 04:23:50 INFO - build_url:https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:23:51 INFO - Running post-action listener: _resource_record_post_action 04:23:51 INFO - Running post-action listener: set_extra_try_arguments 04:23:51 INFO - ##### 04:23:51 INFO - ##### Finished download-and-extract step (success) 04:23:51 INFO - ##### 04:23:51 INFO - ##### 04:23:51 INFO - ##### Running populate-webroot step. 04:23:51 INFO - ##### 04:23:51 INFO - Running pre-action listener: _resource_record_pre_action 04:23:51 INFO - Running main action method: populate_webroot 04:23:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:23:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:23:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:23:51 INFO - '--tppagecycles', 04:23:51 INFO - '7'], 04:23:51 INFO - 'tests': ['tsvgm']}}, 04:23:51 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:23:51 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:23:51 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:23:51 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:23:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:23:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['damp', 'tps']}, 04:23:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'tests': ['damp', 'tps']}, 04:23:51 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['dromaeo_dom']}, 04:23:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:23:51 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['basic_compositor_video']}, 04:23:51 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:23:51 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'other-e10s': {'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['a11yr', 04:23:51 INFO - 'ts_paint', 04:23:51 INFO - 'tpaint', 04:23:51 INFO - 'sessionrestore', 04:23:51 INFO - 'sessionrestore_no_auto_restore', 04:23:51 INFO - 'tabpaint']}, 04:23:51 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['tsvgx', 04:23:51 INFO - 'tsvgr_opacity', 04:23:51 INFO - 'tart', 04:23:51 INFO - 'tscrollx', 04:23:51 INFO - 'cart']}, 04:23:51 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:23:51 INFO - 'tsvgr_opacity', 04:23:51 INFO - 'tart', 04:23:51 INFO - 'tscrollx', 04:23:51 INFO - 'cart']}, 04:23:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'talos_options': ['--disable-e10s'], 04:23:51 INFO - 'tests': ['tp5o']}, 04:23:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'tests': ['tp5o']}, 04:23:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'talos_options': ['--disable-e10s', 04:23:51 INFO - '--xperf_path', 04:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:51 INFO - 'tests': ['tp5n']}, 04:23:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:23:51 INFO - 'talos_options': ['--xperf_path', 04:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:23:51 INFO - 'tests': ['tp5n']}}, 04:23:51 INFO - 'talos.zip': {'path': '', 04:23:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:23:51 INFO - Running post-action listener: _resource_record_post_action 04:23:51 INFO - ##### 04:23:51 INFO - ##### Finished populate-webroot step (success) 04:23:51 INFO - ##### 04:23:51 INFO - ##### 04:23:51 INFO - ##### Running create-virtualenv step. 04:23:51 INFO - ##### 04:23:51 INFO - Running pre-action listener: _resource_record_pre_action 04:23:51 INFO - Running main action method: create_virtualenv 04:23:51 INFO - Creating virtualenv /builds/slave/test/build/venv 04:23:51 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 04:23:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:23:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:23:51 INFO - Using real prefix '/usr' 04:23:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:23:51 INFO - Installing distribute.............................................................................................................................................................................................done. 04:23:53 INFO - Installing pip.................done. 04:23:53 INFO - Return code: 0 04:23:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:53 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 0x2355030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26143b0>, '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 0x26152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2615740>, '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': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', '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 04:23:53 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 04:23:53 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 04:23:53 INFO - Using env: {'DISPLAY': ':0', 04:23:53 INFO - 'HOME': '/home/cltbld', 04:23:53 INFO - 'LANG': 'en_US.UTF-8', 04:23:53 INFO - 'LANGUAGE': 'en_US:en', 04:23:53 INFO - 'LOGNAME': 'cltbld', 04:23:53 INFO - 'MAIL': '/var/mail/cltbld', 04:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:53 INFO - 'MOZ_NO_REMOTE': '1', 04:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:53 INFO - 'NO_EM_RESTART': '1', 04:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:53 INFO - 'PWD': '/builds/slave/test', 04:23:53 INFO - 'SHELL': '/bin/bash', 04:23:53 INFO - 'SHLVL': '1', 04:23:53 INFO - 'TERM': 'linux', 04:23:53 INFO - 'TMOUT': '86400', 04:23:53 INFO - 'USER': 'cltbld', 04:23:53 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', 04:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:53 INFO - '_': '/tools/buildbot/bin/python'} 04:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:54 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 04:23:54 INFO - Cleaning up... 04:23:54 INFO - Return code: 0 04:23:54 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:23:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:54 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:54 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 0x2355030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26143b0>, '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 0x26152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2615740>, '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': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', '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 04:23:54 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 04:23:54 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 04:23:54 INFO - Using env: {'DISPLAY': ':0', 04:23:54 INFO - 'HOME': '/home/cltbld', 04:23:54 INFO - 'LANG': 'en_US.UTF-8', 04:23:54 INFO - 'LANGUAGE': 'en_US:en', 04:23:54 INFO - 'LOGNAME': 'cltbld', 04:23:54 INFO - 'MAIL': '/var/mail/cltbld', 04:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:54 INFO - 'MOZ_NO_REMOTE': '1', 04:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:54 INFO - 'NO_EM_RESTART': '1', 04:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:54 INFO - 'PWD': '/builds/slave/test', 04:23:54 INFO - 'SHELL': '/bin/bash', 04:23:54 INFO - 'SHLVL': '1', 04:23:54 INFO - 'TERM': 'linux', 04:23:54 INFO - 'TMOUT': '86400', 04:23:54 INFO - 'USER': 'cltbld', 04:23:54 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', 04:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:54 INFO - '_': '/tools/buildbot/bin/python'} 04:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:54 INFO - Downloading/unpacking psutil>=3.1.1 04:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:56 INFO - Installing collected packages: psutil 04:23:56 INFO - Running setup.py install for psutil 04:23:56 INFO - building 'psutil._psutil_linux' extension 04:23:56 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 04:23:56 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 04:23:56 INFO - building 'psutil._psutil_posix' extension 04:23:56 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 04:23:56 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 04:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:23:56 INFO - Successfully installed psutil 04:23:56 INFO - Cleaning up... 04:23:56 INFO - Return code: 0 04:23:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:56 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 0x2355030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26143b0>, '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 0x26152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2615740>, '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': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', '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 04:23:56 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 04:23:56 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 04:23:56 INFO - Using env: {'DISPLAY': ':0', 04:23:56 INFO - 'HOME': '/home/cltbld', 04:23:56 INFO - 'LANG': 'en_US.UTF-8', 04:23:56 INFO - 'LANGUAGE': 'en_US:en', 04:23:56 INFO - 'LOGNAME': 'cltbld', 04:23:56 INFO - 'MAIL': '/var/mail/cltbld', 04:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:56 INFO - 'MOZ_NO_REMOTE': '1', 04:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:56 INFO - 'NO_EM_RESTART': '1', 04:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:56 INFO - 'PWD': '/builds/slave/test', 04:23:56 INFO - 'SHELL': '/bin/bash', 04:23:56 INFO - 'SHLVL': '1', 04:23:56 INFO - 'TERM': 'linux', 04:23:56 INFO - 'TMOUT': '86400', 04:23:56 INFO - 'USER': 'cltbld', 04:23:56 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', 04:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:56 INFO - '_': '/tools/buildbot/bin/python'} 04:23:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:57 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:23:57 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 04:23:57 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 04:23:57 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 04:23:57 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 04:23:57 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 04:23:57 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 04:23:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:23:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:23:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:23:59 INFO - Installing collected packages: mozsystemmonitor 04:23:59 INFO - Running setup.py install for mozsystemmonitor 04:23:59 INFO - Successfully installed mozsystemmonitor 04:23:59 INFO - Cleaning up... 04:23:59 INFO - Return code: 0 04:23:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:23:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:23:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:59 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:23:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:23:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:23:59 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 0x2355030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26143b0>, '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 0x26152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2615740>, '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': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', '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 04:23:59 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 04:23:59 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 04:23:59 INFO - Using env: {'DISPLAY': ':0', 04:23:59 INFO - 'HOME': '/home/cltbld', 04:23:59 INFO - 'LANG': 'en_US.UTF-8', 04:23:59 INFO - 'LANGUAGE': 'en_US:en', 04:23:59 INFO - 'LOGNAME': 'cltbld', 04:23:59 INFO - 'MAIL': '/var/mail/cltbld', 04:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:23:59 INFO - 'MOZ_NO_REMOTE': '1', 04:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:23:59 INFO - 'NO_EM_RESTART': '1', 04:23:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:23:59 INFO - 'PWD': '/builds/slave/test', 04:23:59 INFO - 'SHELL': '/bin/bash', 04:23:59 INFO - 'SHLVL': '1', 04:23:59 INFO - 'TERM': 'linux', 04:23:59 INFO - 'TMOUT': '86400', 04:23:59 INFO - 'USER': 'cltbld', 04:23:59 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', 04:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:23:59 INFO - '_': '/tools/buildbot/bin/python'} 04:23:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:23:59 INFO - Downloading/unpacking jsonschema==2.5.1 04:23:59 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 04:23:59 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 04:23:59 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 04:23:59 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 04:23:59 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 04:23:59 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 04:24:01 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:24:01 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:24:01 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 04:24:01 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 04:24:01 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 04:24:01 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 04:24:01 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 04:24:01 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 04:24:01 INFO - Downloading functools32-3.2.3-2.tar.gz 04:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:24:01 INFO - warning: no files found matching '*.txt' 04:24:01 INFO - no previously-included directories found matching 'build' 04:24:01 INFO - no previously-included directories found matching 'dist' 04:24:01 INFO - no previously-included directories found matching '.git*' 04:24:01 INFO - Installing collected packages: jsonschema, functools32 04:24:01 INFO - Running setup.py install for functools32 04:24:01 INFO - warning: no files found matching '*.txt' 04:24:01 INFO - no previously-included directories found matching 'build' 04:24:01 INFO - no previously-included directories found matching 'dist' 04:24:01 INFO - no previously-included directories found matching '.git*' 04:24:01 INFO - Successfully installed jsonschema functools32 04:24:01 INFO - Cleaning up... 04:24:01 INFO - Return code: 0 04:24:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:24:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:01 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:01 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 0x2355030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26143b0>, '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 0x26152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2615740>, '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': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', '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 04:24:01 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 04:24:01 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 04:24:01 INFO - Using env: {'DISPLAY': ':0', 04:24:01 INFO - 'HOME': '/home/cltbld', 04:24:01 INFO - 'LANG': 'en_US.UTF-8', 04:24:01 INFO - 'LANGUAGE': 'en_US:en', 04:24:01 INFO - 'LOGNAME': 'cltbld', 04:24:01 INFO - 'MAIL': '/var/mail/cltbld', 04:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:01 INFO - 'MOZ_NO_REMOTE': '1', 04:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:01 INFO - 'NO_EM_RESTART': '1', 04:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:01 INFO - 'PWD': '/builds/slave/test', 04:24:01 INFO - 'SHELL': '/bin/bash', 04:24:01 INFO - 'SHLVL': '1', 04:24:01 INFO - 'TERM': 'linux', 04:24:01 INFO - 'TMOUT': '86400', 04:24:01 INFO - 'USER': 'cltbld', 04:24:01 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', 04:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:01 INFO - '_': '/tools/buildbot/bin/python'} 04:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:24:02 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 04:24:02 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 04:24:02 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 04:24:02 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 04:24:02 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 04:24:02 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 04:24:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:24:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:24:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:24:03 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 04:24:03 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 04:24:03 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 04:24:03 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 04:24:03 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 04:24:03 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 04:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:24:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:24:04 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 04:24:04 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 04:24:04 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 04:24:04 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 04:24:04 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 04:24:04 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 04:24:04 INFO - Downloading docopt-0.6.1.tar.gz 04:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:24:04 INFO - Installing collected packages: blobuploader, requests, docopt 04:24:04 INFO - Running setup.py install for blobuploader 04:24:04 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:24:04 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:24:04 INFO - Running setup.py install for requests 04:24:05 INFO - Running setup.py install for docopt 04:24:05 INFO - Successfully installed blobuploader requests docopt 04:24:05 INFO - Cleaning up... 04:24:05 INFO - Return code: 0 04:24:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:05 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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:05 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 0x2355030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26143b0>, '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 0x26152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2615740>, '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': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', '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 04:24:05 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 04:24:05 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 04:24:05 INFO - Using env: {'DISPLAY': ':0', 04:24:05 INFO - 'HOME': '/home/cltbld', 04:24:05 INFO - 'LANG': 'en_US.UTF-8', 04:24:05 INFO - 'LANGUAGE': 'en_US:en', 04:24:05 INFO - 'LOGNAME': 'cltbld', 04:24:05 INFO - 'MAIL': '/var/mail/cltbld', 04:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:05 INFO - 'MOZ_NO_REMOTE': '1', 04:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:05 INFO - 'NO_EM_RESTART': '1', 04:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:05 INFO - 'PWD': '/builds/slave/test', 04:24:05 INFO - 'SHELL': '/bin/bash', 04:24:05 INFO - 'SHLVL': '1', 04:24:05 INFO - 'TERM': 'linux', 04:24:05 INFO - 'TMOUT': '86400', 04:24:05 INFO - 'USER': 'cltbld', 04:24:05 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', 04:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:05 INFO - '_': '/tools/buildbot/bin/python'} 04:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:05 INFO - Running setup.py (path:/tmp/pip-CFxuT0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:05 INFO - Running setup.py (path:/tmp/pip-t8BFv2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:05 INFO - Running setup.py (path:/tmp/pip-QyxPyM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:05 INFO - Running setup.py (path:/tmp/pip-5PEXhB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:05 INFO - Running setup.py (path:/tmp/pip-rA5Vbb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:05 INFO - Running setup.py (path:/tmp/pip-TMRNCh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:05 INFO - Running setup.py (path:/tmp/pip-RW0Nxi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:06 INFO - Running setup.py (path:/tmp/pip-1iXJok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:06 INFO - Running setup.py (path:/tmp/pip-8vmjrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:06 INFO - Running setup.py (path:/tmp/pip-ojUaLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:06 INFO - Running setup.py (path:/tmp/pip-CBBVLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:06 INFO - Running setup.py (path:/tmp/pip-QYvOog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:06 INFO - Running setup.py (path:/tmp/pip-Eo3nYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:06 INFO - Running setup.py (path:/tmp/pip-lDYGSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:06 INFO - Running setup.py (path:/tmp/pip-CEIhAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:06 INFO - Running setup.py (path:/tmp/pip-quWGH0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:06 INFO - Running setup.py (path:/tmp/pip-zsJqLU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:06 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:24:06 INFO - Running setup.py install for manifestparser 04:24:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:24:06 INFO - Running setup.py install for mozcrash 04:24:06 INFO - Running setup.py install for mozdebug 04:24:07 INFO - Running setup.py install for mozdevice 04:24:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for mozfile 04:24:07 INFO - Running setup.py install for mozhttpd 04:24:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for mozinfo 04:24:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for mozInstall 04:24:07 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for mozleak 04:24:07 INFO - Running setup.py install for mozlog 04:24:07 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for moznetwork 04:24:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:24:07 INFO - Running setup.py install for mozprocess 04:24:07 INFO - Running setup.py install for mozprofile 04:24:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:24:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:24:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:24:08 INFO - Running setup.py install for mozrunner 04:24:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:24:08 INFO - Running setup.py install for mozscreenshot 04:24:08 INFO - Running setup.py install for moztest 04:24:08 INFO - Running setup.py install for mozversion 04:24:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:24:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:24:08 INFO - Cleaning up... 04:24:08 INFO - Return code: 0 04:24:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:08 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 0x2355030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26143b0>, '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 0x26152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2615740>, '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': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', '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 04:24:08 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 04:24:08 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 04:24:08 INFO - Using env: {'DISPLAY': ':0', 04:24:08 INFO - 'HOME': '/home/cltbld', 04:24:08 INFO - 'LANG': 'en_US.UTF-8', 04:24:08 INFO - 'LANGUAGE': 'en_US:en', 04:24:08 INFO - 'LOGNAME': 'cltbld', 04:24:08 INFO - 'MAIL': '/var/mail/cltbld', 04:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:08 INFO - 'MOZ_NO_REMOTE': '1', 04:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:08 INFO - 'NO_EM_RESTART': '1', 04:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:08 INFO - 'PWD': '/builds/slave/test', 04:24:08 INFO - 'SHELL': '/bin/bash', 04:24:08 INFO - 'SHLVL': '1', 04:24:08 INFO - 'TERM': 'linux', 04:24:08 INFO - 'TMOUT': '86400', 04:24:08 INFO - 'USER': 'cltbld', 04:24:08 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', 04:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:08 INFO - '_': '/tools/buildbot/bin/python'} 04:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:24:08 INFO - Running setup.py (path:/tmp/pip-H5lwyf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:24:08 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)) 04:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:24:08 INFO - Running setup.py (path:/tmp/pip-9_zq2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:24:08 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)) 04:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:24:08 INFO - Running setup.py (path:/tmp/pip-BYDC5R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:24:08 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)) 04:24:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:24:08 INFO - Running setup.py (path:/tmp/pip-rN5SZ_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:24:09 INFO - Running setup.py (path:/tmp/pip-DhOuDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:24:09 INFO - Running setup.py (path:/tmp/pip-rFFnlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:24:09 INFO - Running setup.py (path:/tmp/pip-b7rIIf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:24:09 INFO - Running setup.py (path:/tmp/pip-amrw1O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:24:09 INFO - Running setup.py (path:/tmp/pip-5pduWV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:24:09 INFO - Running setup.py (path:/tmp/pip-cboz86-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:24:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:24:09 INFO - Running setup.py (path:/tmp/pip-E0cdLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:24:09 INFO - Running setup.py (path:/tmp/pip-3DDCLs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:24:09 INFO - Running setup.py (path:/tmp/pip-kLeHfr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:24:09 INFO - Running setup.py (path:/tmp/pip-XDunuO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:09 INFO - Running setup.py (path:/tmp/pip-FsYaKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:24:09 INFO - Running setup.py (path:/tmp/pip-u_4KWF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:24:09 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)) 04:24:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:24:09 INFO - Running setup.py (path:/tmp/pip-bt76ci-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:24:09 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)) 04:24:09 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)) 04:24:09 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)) 04:24:09 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)) 04:24:09 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)) 04:24:09 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)) 04:24:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:24:09 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 04:24:09 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 04:24:09 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 04:24:09 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 04:24:09 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 04:24:09 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 04:24:11 INFO - Downloading blessings-1.6.tar.gz 04:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:24:12 INFO - Installing collected packages: blessings 04:24:12 INFO - Running setup.py install for blessings 04:24:12 INFO - Successfully installed blessings 04:24:12 INFO - Cleaning up... 04:24:12 INFO - Return code: 0 04:24:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:12 INFO - Reading from file tmpfile_stdout 04:24:12 INFO - Current package versions: 04:24:12 INFO - argparse == 1.2.1 04:24:12 INFO - blessings == 1.6 04:24:12 INFO - blobuploader == 1.2.4 04:24:12 INFO - docopt == 0.6.1 04:24:12 INFO - functools32 == 3.2.3-2 04:24:12 INFO - jsonschema == 2.5.1 04:24:12 INFO - manifestparser == 1.1 04:24:12 INFO - mozInstall == 1.12 04:24:12 INFO - mozcrash == 0.17 04:24:12 INFO - mozdebug == 0.1 04:24:12 INFO - mozdevice == 0.48 04:24:12 INFO - mozfile == 1.2 04:24:12 INFO - mozhttpd == 0.7 04:24:12 INFO - mozinfo == 0.9 04:24:12 INFO - mozleak == 0.1 04:24:12 INFO - mozlog == 3.2 04:24:12 INFO - moznetwork == 0.27 04:24:12 INFO - mozprocess == 0.23 04:24:12 INFO - mozprofile == 0.28 04:24:12 INFO - mozrunner == 6.12 04:24:12 INFO - mozscreenshot == 0.1 04:24:12 INFO - mozsystemmonitor == 0.3 04:24:12 INFO - moztest == 0.7 04:24:12 INFO - mozversion == 1.4 04:24:12 INFO - psutil == 3.1.1 04:24:12 INFO - requests == 1.2.3 04:24:12 INFO - wsgiref == 0.1.2 04:24:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:12 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 0x2355030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26143b0>, '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 0x26152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2615740>, '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': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', '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 04:24:12 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 04:24:12 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 04:24:12 INFO - Using env: {'DISPLAY': ':0', 04:24:12 INFO - 'HOME': '/home/cltbld', 04:24:12 INFO - 'LANG': 'en_US.UTF-8', 04:24:12 INFO - 'LANGUAGE': 'en_US:en', 04:24:12 INFO - 'LOGNAME': 'cltbld', 04:24:12 INFO - 'MAIL': '/var/mail/cltbld', 04:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:12 INFO - 'MOZ_NO_REMOTE': '1', 04:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:12 INFO - 'NO_EM_RESTART': '1', 04:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:12 INFO - 'PWD': '/builds/slave/test', 04:24:12 INFO - 'SHELL': '/bin/bash', 04:24:12 INFO - 'SHLVL': '1', 04:24:12 INFO - 'TERM': 'linux', 04:24:12 INFO - 'TMOUT': '86400', 04:24:12 INFO - 'USER': 'cltbld', 04:24:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', 04:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:12 INFO - '_': '/tools/buildbot/bin/python'} 04:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:12 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)) 04:24:12 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)) 04:24:12 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)) 04:24:12 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)) 04:24:12 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)) 04:24:12 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)) 04:24:12 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)) 04:24:12 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)) 04:24:12 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)) 04:24:12 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)) 04:24:12 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)) 04:24:12 INFO - Cleaning up... 04:24:12 INFO - Return code: 0 04:24:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:24:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:24:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:24:12 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 0x2355030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24b88a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2616180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26143b0>, '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 0x26152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2615740>, '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': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', '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 04:24:12 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 04:24:12 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 04:24:12 INFO - Using env: {'DISPLAY': ':0', 04:24:12 INFO - 'HOME': '/home/cltbld', 04:24:12 INFO - 'LANG': 'en_US.UTF-8', 04:24:12 INFO - 'LANGUAGE': 'en_US:en', 04:24:12 INFO - 'LOGNAME': 'cltbld', 04:24:12 INFO - 'MAIL': '/var/mail/cltbld', 04:24:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:12 INFO - 'MOZ_NO_REMOTE': '1', 04:24:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:12 INFO - 'NO_EM_RESTART': '1', 04:24:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:12 INFO - 'PWD': '/builds/slave/test', 04:24:12 INFO - 'SHELL': '/bin/bash', 04:24:12 INFO - 'SHLVL': '1', 04:24:12 INFO - 'TERM': 'linux', 04:24:12 INFO - 'TMOUT': '86400', 04:24:12 INFO - 'USER': 'cltbld', 04:24:12 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', 04:24:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:12 INFO - '_': '/tools/buildbot/bin/python'} 04:24:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:24:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:24:12 INFO - Cleaning up... 04:24:12 INFO - Return code: 0 04:24:12 INFO - Running post-action listener: _resource_record_post_action 04:24:12 INFO - Running post-action listener: _start_resource_monitoring 04:24:12 INFO - Starting resource monitoring. 04:24:12 INFO - ##### 04:24:12 INFO - ##### Finished create-virtualenv step (success) 04:24:12 INFO - ##### 04:24:12 INFO - ##### 04:24:12 INFO - ##### Running install step. 04:24:12 INFO - ##### 04:24:12 INFO - Running pre-action listener: _resource_record_pre_action 04:24:12 INFO - Running main action method: install 04:24:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:24:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:24:13 INFO - Reading from file tmpfile_stdout 04:24:13 INFO - Detecting whether we're running mozinstall >=1.0... 04:24:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:24:13 INFO - Reading from file tmpfile_stdout 04:24:13 INFO - Output received: 04:24:13 INFO - Usage: mozinstall [options] installer 04:24:13 INFO - Options: 04:24:13 INFO - -h, --help show this help message and exit 04:24:13 INFO - -d DEST, --destination=DEST 04:24:13 INFO - Directory to install application into. [default: 04:24:13 INFO - "/builds/slave/test"] 04:24:13 INFO - --app=APP Application being installed. [default: firefox] 04:24:13 INFO - mkdir: /builds/slave/test/build/application 04:24:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:24:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:24:30 INFO - Reading from file tmpfile_stdout 04:24:30 INFO - Output received: 04:24:30 INFO - /builds/slave/test/build/application/firefox/firefox 04:24:30 INFO - Running post-action listener: _resource_record_post_action 04:24:30 INFO - ##### 04:24:30 INFO - ##### Finished install step (success) 04:24:30 INFO - ##### 04:24:30 INFO - ##### 04:24:30 INFO - ##### Running run-tests step. 04:24:30 INFO - ##### 04:24:30 INFO - Running pre-action listener: _resource_record_pre_action 04:24:30 INFO - Running main action method: run_tests 04:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:24:30 INFO - Python 2.7.3 04:24:30 INFO - Return code: 0 04:24:30 INFO - grabbing minidump binary from tooltool 04:24:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:24:30 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 0x26143b0>, '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 0x26152b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2615740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:24:30 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 04:24:30 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 04:24:30 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 04:24:30 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:24:30 INFO - Return code: 0 04:24:30 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:24:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:24:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:24:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:24:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:24:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 04:24:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 04:24:30 INFO - Using env: {'DISPLAY': ':0', 04:24:30 INFO - 'HOME': '/home/cltbld', 04:24:30 INFO - 'LANG': 'en_US.UTF-8', 04:24:30 INFO - 'LANGUAGE': 'en_US:en', 04:24:30 INFO - 'LOGNAME': 'cltbld', 04:24:30 INFO - 'MAIL': '/var/mail/cltbld', 04:24:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:24:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:24:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:24:30 INFO - 'MOZ_NO_REMOTE': '1', 04:24:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:24:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:24:30 INFO - 'NO_EM_RESTART': '1', 04:24:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:24:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:24:30 INFO - 'PWD': '/builds/slave/test', 04:24:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:24:30 INFO - 'SHELL': '/bin/bash', 04:24:30 INFO - 'SHLVL': '1', 04:24:30 INFO - 'TERM': 'linux', 04:24:30 INFO - 'TMOUT': '86400', 04:24:30 INFO - 'USER': 'cltbld', 04:24:30 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032', 04:24:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:24:30 INFO - '_': '/tools/buildbot/bin/python'} 04:24:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 04:24:30 INFO - mozversion application_buildid: 20160713010620 04:24:30 INFO - mozversion application_changeset: 7054f1c4d2b11ed3511731565a264e4521cba9b4 04:24:30 INFO - mozversion application_display_name: Nightly 04:24:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:24:30 INFO - mozversion application_name: Firefox 04:24:30 INFO - mozversion application_remotingname: firefox 04:24:30 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:24:30 INFO - mozversion application_vendor: Mozilla 04:24:30 INFO - mozversion application_version: 50.0a1 04:24:30 INFO - mozversion platform_buildid: 20160713010620 04:24:30 INFO - mozversion platform_changeset: 7054f1c4d2b11ed3511731565a264e4521cba9b4 04:24:30 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:24:30 INFO - mozversion platform_version: 50.0a1 04:24:30 INFO - using testdate: 1468409070 04:24:30 INFO - actual date: 1468409070 04:24:30 INFO - starting webserver on 'localhost:43225' 04:24:30 INFO - SUITE-START | Running 2 tests 04:24:30 INFO - TEST-START | dromaeo_css 04:24:30 INFO - operating with platform_type : linux_ 04:24:30 INFO - Initialising browser for dromaeo_css test... 04:24:30 INFO - TEST-INFO | started process 7543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSvHXEU/profile http://localhost:43225/getInfo.html) 04:24:35 INFO - PROCESS | 7543 | __metrics Screen width/height:1600/1200 04:24:35 INFO - PROCESS | 7543 | colorDepth:24 04:24:35 INFO - PROCESS | 7543 | Browser inner width/height: 1024/697 04:24:35 INFO - PROCESS | 7543 | __metrics 04:24:36 ERROR - PROCESS | 7543 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 04:24:37 INFO - TEST-INFO | 7543: exit 0 04:24:37 INFO - Browser initialized. 04:24:37 INFO - Running cycle 1/1 for dromaeo_css test... 04:24:37 INFO - TEST-INFO | started process 7666 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSvHXEU/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:24:48 INFO - PROCESS | 7666 | RSS: Main: 167579648 04:24:48 INFO - PROCESS | 7666 | 04:25:38 INFO - PROCESS | 7666 | 1468409138457 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] 04:27:46 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:43225/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43225/tests/dromaeo/cssquery-ext.html) 04:27:47 INFO - PROCESS | 7666 | RSS: Main: 170741760 04:27:47 INFO - PROCESS | 7666 | 04:30:49 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:43225/tests/dromaeo/cssquery-ext.html (next: http://localhost:43225/tests/dromaeo/cssquery-jquery.html) 04:30:50 INFO - PROCESS | 7666 | RSS: Main: 167780352 04:30:50 INFO - PROCESS | 7666 | 04:33:52 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:43225/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43225/tests/dromaeo/cssquery-mootools.html) 04:33:52 INFO - PROCESS | 7666 | RSS: Main: 171388928 04:33:52 INFO - PROCESS | 7666 | 04:36:54 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:43225/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43225/tests/dromaeo/cssquery-prototype.html) 04:36:55 INFO - PROCESS | 7666 | RSS: Main: 167714816 04:36:55 INFO - PROCESS | 7666 | 04:39:57 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:43225/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43225/tests/dromaeo/cssquery-yui.html) 04:39:58 INFO - PROCESS | 7666 | RSS: Main: 168636416 04:39:58 INFO - PROCESS | 7666 | 04:43:01 INFO - PROCESS | 7666 | Cycle 1(1): loaded http://localhost:43225/tests/dromaeo/cssquery-yui.html (next: http://localhost:43225/tests/dromaeo/cssquery-dojo.html) 04:43:01 INFO - PROCESS | 7666 | RSS: Main: 170147840 04:43:01 INFO - PROCESS | 7666 | 04:43:01 INFO - PROCESS | 7666 | __start_tp_report 04:43:01 INFO - PROCESS | 7666 | _x_x_mozilla_page_load 04:43:01 INFO - PROCESS | 7666 | _x_x_mozilla_page_load_details 04:43:01 INFO - PROCESS | 7666 | |i|pagename|runs| 04:43:01 INFO - PROCESS | 7666 | |0;dojo.html;3070.58547096142;3085.6142982127235;3108.424941385843;3108.5803416538774;3126.0778070469223;5299.258103865462;5354.518093371596;5357.678539287641;5436.537894278981;5461;5451.809186678467;5523.917141242885;5525.917111243324;5538.806141785029;5565.109582466806;4965.553100220979;5004.724740139291;5107.131787596099;5161.664491808039;5188.662736922107;511.6428087527116;4934.235193545006;4974.278729584208;5023.547880690737;5115.309433226523;5012.573931215851;5038.294638750578;5048.621353398491;5056.519630635084;5064.063148317555;5057.645964782467;5062.190049592047;5084.313617661605;5088.669236499616;5091.287219789232;4981.37732783402;5018.197088465864;5042.647014708972;5065.797368105272;5072.391313042459;5575.637583557056;5581.609287349887;5600.6079574429805;5615.606907516475;5620.718964051781;5707.6290041147195;5764.394738552433;5916.792912248051;5919.052951527778;5950.761969521214;5927.318358388754;5987.1019347097845;5988;6041.184440100574;6042.486388656969;5624.184493248456;5626.718664066781;5626.859328516779;5628.127640215773;5633.267675202238;5991.460768530766;6059.182010428536;6143.784967526204;6155.876882462326;6181.96909015452;5878;5927.377625349276;5940.940590594125;5941.643501389844;5982.102684597346;5979.4618484336615;6004.819855404345;6006.309274433496;6025.969870150621;6029.547783916224;5560.4161563035295;5865.384134665884;5879.235699359056;5980.252468441445;5983.640981541122;5862.765489380462;5902.793402230901;5908.320543137508;5917.171595976567;5918.496927761188;4516.932246016312;4536.138133754576;4541.954580454153;4578.198815207325;4586.1057093866375;3930.508686414198;4019.8995025124605;4036.495438070241;4046.5751096135073;4063.6342729153926;5647.858803529944;5696.971515142398;5716.228309178291;5718.857028574319;5751.194832723422;6014.578979471483;6017.398260174035;6028.457438830438;6037.577369584087;6039.396060393926;5553.639013464192;5749.712514374264;5791.8552036199435;5827.854303642358;5833.562482813806;5160.8967820643375;5168.508991645787;5198.298229739013;5198.636095473281;5205.06308864408;6154;6231.096491008779;6234.657093859791;6242.843928901813;6243.313235544087;5825.0388685866355;5914.970425148019;5928.466438020599;5966.19456373384;6026.879462410815;6144.763605695434;6187.474064704551;6196.132541444112;6214.658193799384;6224.751009959551;5779;5897.026990546683;5903.144044113494;5918.112283157561;5956.255468066492;5917.940820591739;5937.732802023833;5982.880342393215;6016.6690832002905;6026.849328766816;5821.126830975219;5829.417058294137;5876.588638795243;5883.0881213411985;5894.174815525744;5653.3781284057895;5798.855028624318;5841.211436456024;5841.795537156179;5862;5830.067189249699;5916.171735956884;5918.822435326947;5931.258592675916;5952.434518720888;5915.37888521699;5938.673372964528;5940.108983652314;5966.254218222723;5970.253718285215;5675.262215911905;5707.315122185199;5721.427857214246;5858.297004359334;5864.765409383577 04:43:01 INFO - PROCESS | 7666 | |1;ext.html;553.1269515567848;589.764094362255;597.0566504922224;612.6201754911954;625.9687015649216;37308.81345593275;41837.16325673492;41964.790176049115;41977.3703394449;42167.15665686684;42302.57697423025;42786.57213427865;42835;42912.141757164834;42913;8813.427127236726;8948.821023579525;8990.460572365646;9004.77488062797;9006.549672516381;8933.196012358887;9009.144131307516;9012.098790121001;9012.77468063297;9016.77458063547;8924.062973387765;9036.27709783219;9037.051109633492;9041.95479022604;9054.728358149267;8945.507997060158;8953.910460895373;9005.14451127142;9021.09789021096;9022.909770902272;8908.8663670045;8928.73213803587;8930.821383572356;8964.68623598171;8987.191152796215;32332.515012274835;40853;41325.173496529904;41368.79315603433;41473;3413.9146521336916;3590.407582748843;3645.76302540334;3709.7403181777286;3761.981190094032;31285.217869553217;31339.529907051412;31461.483081353435;32845;33958.32083358319;4499.415076040126;4533.478649955265;4574.268117101248;4713.434387873443;4741.2651039089;352103;357223;357832;359366.9999999974;359465;34406.13984650404;35458;35522.46716299257;62408.37591624026;62507.37492625107;36941.26117477635;37031.074223144635;37178.8141059293;37306.626933730855;37335.81332093377;15146.545603631908;15326;15347.309371078329;15376.538703838904;15379.231038448257;13605.115667481581;13629.25039122838;13661.726765464635;13677.658058548417;13768.93115534436;8368.3305335573;8460.323174146053;8496.915030849736;8545.359098067669;8551.871721924175;3292.4732042873025;3362.899113026613;3376.5272861798876;3380.864765409405;3386.204242003127;980.367662857453;996.0537489385113;1013.2704452793977;1073.6188653028219;1082.3884505254507;33130.70516601838;33455.33089338248;33501.66498335034;33663.66336336654;34151.48772768411;1169.7952858249773;1170.9473073711704;1179.598936361624;1184.2420850655587;1190.2263528706237;17386.826131738522;17520.38678646241;17622.735658965124;17690.469285921445;17814.554636134202;566547;572515;576606;579151;580257;57891;58040.41959580435;58334;58458.707706461195;58561;1305.451710281684;1348.042889548412;1371.9519816806364;1380.8412032616377;1390.193687661134;30134;31002;31383.529247061768;31567.526487103172;31624.525632115077;51099;55590.607080186295;57416.1387579195;57534;61713.69143154255;502776;503638;503879;505900;508870;43742.78128609336;44501.554984449744;44569;44970.10059798851;45502;48669.756651216514;48786.26820597623;49089;50275.49724502708;50558.74720626373;41131;41268.38097428601;42216.59259111746;42969.785151075295;43064.569354306055;41715.37426938538;41735;42586.78706606447;42785.34605135307;43225.56774432216;35872;41010.589894100674;41018.28289746598;41476.377854332815;41986.37020444757;34940.30119397547;37099.25801483901;37387.62612373842;37542.43686344652;37583.43624845575;28283.717162828107;28518.714812851606;28754.856225718737;28961.275968100123;29139.271518211368 04:43:01 INFO - PROCESS | 7666 | |2;jquery.html;384.3216722484813;384.5366333568049;385.1624476389246;394.7197489782254;409.0612045355908;14402.639934001656;19123.52191195219;20126;20316.288929887458;20379.796202037975;19190.328338508156;19454.902725486387;19656.312029078985;20213.696794548094;20225.089870955806;5722.713864306789;5855.882882342351;5919.88160236795;5925.585209035369;5938.8218353449465;5443.346798384199;5757.798477053304;5812.215350927634;5813.331466881299;5824.941750582503;5759.654420734749;5778.942210577882;5787.305523337205;5816.738246778905;5828.18405423239;5942.673152976585;6197.256329240475;6227.564070515065;6347.39699728525;6356.555041147121;5401.918971215435;5612.438756124355;5634.0703783875615;5648.293963254593;5649.6327738696855;14063.64840878976;14176.503822366167;14280.714385712228;14537.127772333693;14547.636309092251;2302.5855346037706;2338.6608941703357;2401.807855371566;2450.779429851304;2474.8391354561895;10251.538680759384;10488.265821392506;10548.94725526375;10583.10043646291;10677.305975111592;1896.421591414618;1944.3389247655723;1957;2009.3067891577382;2029.2796057399705;77390;79756;80720;81853;86583.56708216418;10415.583376664848;10523.473826308655;10558.419286939292;10839.241253112365;11123.443827808576;14678;14726.410943562138;14768.556943291718;14855.777163342558;15102.320395582225;8084.8383032339025;8273.627686754111;8324.417290789586;8415.45299555527;8423;8224.506529608243;8229.917700822914;8258.545779982158;8395.076541580422;8409.4022135794;4442.311441726538;4620.653450991189;4694.953050469451;4730.455997560324;4762.880927976759;1871.5414723392855;1959.549303660166;1963.2441510018746;1989.5225145965153;2004.8696834705697;900.6622516556291;914.3919293669768;982.1798798003604;1020.8974307747615;1101.8787933327328;20153.29463468801;20486.38540843777;20553.075111619713;20964.47588810292;21221.469463263235;989.4508547756064;1028.5937054863286;1055.9809783558749;1078.9730256743644;1098.8956049175315;9179.770505737277;11315.15136364776;11420.828687569694;11452.255603385753;11557.942210288895;368137;374212;376747;485319;488851;94660;100732;101514.49242753739;102205.48897255467;103738;1046.0951277145214;1087.8251488392516;1088.711491454765;1092.7377429417043;1096.8409580610767;18330.633387331913;18397.448076557725;19127.713084304025;19294.13176407037;19439.805601944365;41388.586114138474;41790.582094178666;43006;44630;45271.54728452805;55374;56566.151507726594;59526.70236648789;59974;61101.38898610957;7711.922880771345;7988.241117093867;8714.38999270045;8963.551822408985;9405.717828465156;14514.709705806035;14676.633084172981;14726.63183420423;14839.183844888203;14958.626034349229;12393.318367489876;12650.873491264969;12828.486860525847;12884.226946383247;12941.09412341127;11658.475368608602;11757.412129393668;12769.489220431078;12801.423935923092;12902.612921612366;5610.905873354656;12140.575079872162;12170.330631815335;12608.243505389706;12762.106652534234;8126.228008339198;8250.628721707417;8305.750827475185;8348.081711011662;8416.915830841857;10984.505697243803;11236.83144752813;11649.242799218024;12571.30857802793;12740.490380385052 04:43:01 INFO - PROCESS | 7666 | |3;mootools.html;1454.8108745863037;1509.6075020494673;1634.811996620389;1774.618457031738;1814.2652225848535;7942.722004729836;8638.611262493187;8641.092685268042;9179.357444978854;9211.58547865346;8874.689385871496;8899.599518021689;8942.061083586228;8944.150305720947;8945.686900958468;2329.9883500582473;2355.857409156558;2357.210334537932;2360.1031607989025;2361.988190059047;2391.354334329739;2419.6854408926815;2420.394901274681;2431.0397393029743;2439.1097249503982;2324.7094113235844;2346.554154710608;2352.8353015288935;2353.62342025276;2361.055577768898;2294.9885250573807;2303.79265866072;2314.0975019742314;2315.8494697844585;2316.907323707058;2282.349530383849;2284.6230371988604;2290.393045842853;2298.321995011459;2298.954020919589;9072.591733372014;9120.908790912072;9161.358704890661;9211.861822072675;9234.722958311262;5079.111155547765;5154.226865970097;5182;5276.155815069609;5280.656757310762;3382.797032178077;3432.262063656301;3446.7931924084637;3497.4928635347733;3559.519464872235;1117.2570240789864;1136.1705954653066;1166.3177041430772;1177.9057675385948;1181.5037684172669;12425.62723118308;12473.126881118325;12491.500339986389;12561.309127997865;12585.874141258653;4501.077279157765;4649.976750116228;4695.272232803921;4820.758962051884;4831.51684831514;10591.94704026475;10605.946970265253;10663.89336106629;10708.78582428347;10726.624568140234;5323.467653234646;5331.040412725669;5331.4401987790725;5346.91979620306;5354.839354819362;4262;4754.429468463806;4901.828436004723;4911.656184067152;4923.532264434873;3917.334053210961;3982.8605998789903;4054.553999060101;4088.6320231178743;4133.958660413417;1234.6542967968983;1272.033254726396;1275.0819410024767;1278.367208231931;1279.4242590834162;969.9078587534173;975.775401870662;976.5947131940308;985.8619793228954;1001.3741411617739;5989;6013.6993150342305;6014.6391216527145;6062.424069713458;6225.564210505221;459.21245064714174;459.6185166311953;462.7293033575396;470.30864628995323;473.9549742774431;3957.584453632385;4067.2678917794487;4077.6941729369823;4089.6523795477124;4107.938380924288;11005.17461190398;11312.490937907814;11344.716382090348;11415.543378264776;11462.713432164262;10480.895191048145;11206.38364889939;11265.831012534654;11284.43577821122;11285.717857053474;8134.633941472648;8186.386021048445;8207.589620518951;8238.09380968093;8255.215754503433;6136.140940268455;6437.130987316839;6437.839054023687;6477.4494167996245;6486.286508484157;10298.485075746034;10349.275550711378;10403.063724264852;10439.321444106108;10456.111230545488;9849.507524623883;10344.586216551254;10722.678319650424;10867.728306792078;10911.345319280868;6997.895031574429;7649.541027538366;7669.079710434784;7959.204079591995;8024.39817013738;8870.290376769972;8896.911030889867;8903.821923561622;8944.597493112955;8965.327600430124;7358.521696089737;7623.771286861403;7636.121845987783;7666.080070391588;7744.612769361622;7660.616969151632;7710.306072453506;7771.145174030965;7775.650095745592;7815.25755053269;7499.062617172854;7500.549967001997;7502.737404190827;7553.660085296285;7574.810629734301;5060.696358218372;5292.841214763564;5390.27231323782;5395.946040539701;5404.243405923253;5081.71322904687;5156.587473002076;5237.057329680694;5269.789208431773;5471.50756431923 04:43:01 INFO - PROCESS | 7666 | |4;prototype.html;323.25328491185365;334.41644330643027;336.23338787564364;339.73500669477806;340.1343580587405;5518.227448157261;5621.437856214377;5637.66174029558;5713.257276554047;5714.77140914364;5526.640768350055;5655.717214139287;5679.744411501482;5686.232358631583;5699.943000570003;4395.296752519597;4398.868033958986;4404.713693609921;4419.491758447787;4423.159599676067;4134.917301653965;4337;4363.650907927358;4419.933700994472;4456.8885777855485;4295.613394794468;4301.26878430666;4314.288142456491;4327.706315652709;4338.891527711817;4344.522102568715;4353.521112677603;4358.237308471021;4394;4402.7798610069685;3766.773993560395;3808.8857334280015;3842.692584593226;3858.421236814472;3871.3031654302213;5442.755076021588;5475.863103422406;5477.808276710336;5487.862803429906;5497.642653227527;4948.579370753454;4972.83138462461;4983.259207435895;5001.274815151783;5028.547430731252;5710.030039636319;5869.354371019184;5895.852603684899;5898.498627616657;5919.526437884959;4140.482439695038;4147.875563733062;4164.708470407073;4175.895602609929;4194.748315101104;6169.784057557964;6178.331850400366;6205.503559715212;6209.813705588885;6211.19254496917;4123.175364927027;4220.514640816284;4235.661147108224;4240.830366785356;4316.827326906889;4286.2284788738325;4288.31386978082;4295.8281668733525;4314.69797114199;4339.305711086211;4975.875603109879;4981.850544483671;4983.878627308826;4991.725455099931;5007.599392048627;5714.285714285715;5916.201312822714;6013.30846952606;6019.819405417757;6033.336333003366;1485.6731519065788;1486.9330880110422;1494.4993427201791;1494.9535325272136;1502.2864139533854;935.4655822955526;942.5617088054088;947.8199142162968;955.159459675495;962.9229661627193;5058;5058.54473097423;5087.389513258433;5097.541221290027;5154.5103215194495;5333;5338.97330513345;5358.866028349323;5365.907296154503;5420.24116623673;5080.974595127001;5107.821226257063;5162.432132465426;5349.973250133802;5779.450952159538;3214.6659136458106;3227.951580726291;3256.055743834309;3261.951070733941;3272.6563710810497;6054.636721796706;6313.390085528161;6319.620822750558;6334.968325158345;6355.459785918249;6200.131981522591;6204.689765511706;6215.440610345091;6266.467350275278;6278.497720182374;6333.429991300713;6335.936640633627;6342.207224096988;6362.618242905441;6370.394812492806;5865.912011319749;6081.939180608138;6100.298465676504;6122.7244773984385;6170.845728856635;6044.395560443921;6066.484348830399;6074.511744622596;6078.027515597483;6110.602810817282;6048.637081775108;6303.747850085945;6321.399467050623;6327.588706734047;6408.93591064102;4273.508546517191;4308.870733877989;4321.13577284538;4325.437693100002;4329.870103896888;6091.573589848668;6152.477039451696;6219.253689557282;6221.671405797876;6231.626102433868;5700.543956483389;5948.940510594839;5982.192404025401;5983.474214075557;5993.741314324041;5942.049272116441;5968.850778730392;6015.646479542068;6018.666560076737;6047.879042419215;5728.369879313355;5896.55775816824;5926.644401335933;5940.970295148497;5966.463018328198;6002.969985150046;6007.639541627516;6021.578489505868;6042.912275790224;6046.667433291212;5869.388122285542;5914.4381283777975;5918.674472903859;5948.2862056553495;5949.423402798176 04:43:01 INFO - PROCESS | 7666 | |5;yui.html;753.5328096580117;760.9201033891442;773.4237992695442;800.8558459477293;830.1822704635932;15572.221388930551;16425.42511012115;16524.669506609862;16630.75053874193;16666.166691665414;15178.31697573609;15344.079355238693;15365.92317038416;15384.923075384608;15400.537983860475;670.1154476091549;803.6905791270374;826.9503829770233;828.9295409890167;830.2154464031493;818.3984771193168;818.5293456262643;822.6462621072936;824.3858325547476;824.8391563645091;877.0352612126674;877.8507653698855;877.9912200877974;879.1560102301798;879.7844528090627;858.6651206029622;867.0549101479355;867.4968518259394;867.8784970104191;869.2958703450194;633.0567454492818;635.3106879036251;635.5011316116872;637.3276193615734;637.91069250305;15769.68460630781;15814.683706325925;15829.60425989348;15853.60365990848;15855.524334269874;15724;15759.95957714532;15807.841921580866;15949.760753588705;16078.5980350491;12065.698357541043;12089.395530223454;12128.151029427943;12218.144729868913;12247.387630618523;3823.6941044716355;3847.634474724897;3893.1435084281698;3917.764934103963;3988.74073185242;71227.64386178037;73700.6314968427;78170.6091469539;80439.59780201061;80599;12519.681140763589;12534;12738.235705857678;12814.67963300925;12852.614421567368;24002.039918403418;24117.276481705576;24184.395390115387;24275.150369736974;24285.7571424287;9409.106134917172;9587.280953928483;9889.50552472388;9964;9967.850482242773;4921.458639549646;5039.21892106724;5043.5965122790085;5149.665271757323;5355.598330125178;3687.5574931007914;3799.8290076946605;3809.961900381016;3814.0274230071154;3819.4843696101225;682.474494639125;688.4905170174035;688.6935313785317;706.9540479868792;708.7200555780438;714.2250658036089;750.3097150621442;762.7414765636744;763.6334559411403;771.4946709905021;10365.740856478498;10429.895701043044;10451.634192803367;10650.520726567323;10836.500004986834;755.3956834532352;774.972875949339;781.2773184804033;795.2326005404697;808.9635966381527;4894.412670479565;5144.768485418165;5153.149730294459;5173.922391164136;5177.249298851721;90230.54884725534;113967.43016285032;120090;123500;124063.37968310101;103338;105361;106480;106522.46738766256;106691.46654266835;92641;93335.53332233295;93514;94299;96038.51980740052;9881;9960.601575936882;10012.249081319076;10052.547635356574;10068.295219334575;53148.40554783363;53561.46438535565;53806;53935.19097213623;55759.721201395354;76461.23538764541;77293;78689.60655196688;80038.59980700059;82073.58963205146;12576.182548134342;12686.175398599062;13107.213567186;13132.955311471767;13231.470741170246;14552.345144468312;14581.416743330148;14585.854141458449;14660.85339146595;14704.485343012942;13540.661483462993;13546.79679804784;13563.31903800011;13670.453181873012;13928.164310141425;13229.404676789374;13245.139065960682;13268.867311326763;13291.933540332237;13396.351674048394;12795.104342696295;12810.67973300675;13005.21968681882;13122.737545249232;13417.974478408027;10823.242373034127;11075.778484430428;11086.223964322742;11390.943045284721;11423.428828558704;11485.196036277715;11601;11628.418579071182;11639.243449175776;11659.883401166218 04:43:01 INFO - PROCESS | 7666 | __end_tp_report 04:43:01 INFO - PROCESS | 7666 | __start_cc_report 04:43:01 INFO - PROCESS | 7666 | _x_x_mozilla_cycle_collect,355 04:43:01 INFO - PROCESS | 7666 | __end_cc_report 04:43:01 INFO - PROCESS | 7666 | __startTimestamp1468410181254__endTimestamp 04:43:01 INFO - PROCESS | 7666 | 04:43:01 INFO - PROCESS | 7666 | ------- Summary: start ------- 04:43:01 INFO - PROCESS | 7666 | Number of tests: 6 04:43:01 INFO - PROCESS | 7666 | 04:43:01 INFO - PROCESS | 7666 | [#0] dojo.html Cycles:165 Average:5514.44 Median:5821.13 stddev:763.29 (13.1%) stddev-sans-first:741.16 04:43:01 INFO - PROCESS | 7666 | Values: 3070.6 3085.6 3108.4 3108.6 3126.1 5299.3 5354.5 5357.7 5436.5 5461.0 5451.8 5523.9 5525.9 5538.8 5565.1 4965.6 5004.7 5107.1 5161.7 5188.7 511.6 4934.2 4974.3 5023.5 5115.3 5012.6 5038.3 5048.6 5056.5 5064.1 5057.6 5062.2 5084.3 5088.7 5091.3 4981.4 5018.2 5042.6 5065.8 5072.4 5575.6 5581.6 5600.6 5615.6 5620.7 5707.6 5764.4 5916.8 5919.1 5950.8 5927.3 5987.1 5988.0 6041.2 6042.5 5624.2 5626.7 5626.9 5628.1 5633.3 5991.5 6059.2 6143.8 6155.9 6182.0 5878.0 5927.4 5940.9 5941.6 5982.1 5979.5 6004.8 6006.3 6026.0 6029.5 5560.4 5865.4 5879.2 5980.3 5983.6 5862.8 5902.8 5908.3 5917.2 5918.5 4516.9 4536.1 4542.0 4578.2 4586.1 3930.5 4019.9 4036.5 4046.6 4063.6 5647.9 5697.0 5716.2 5718.9 5751.2 6014.6 6017.4 6028.5 6037.6 6039.4 5553.6 5749.7 5791.9 5827.9 5833.6 5160.9 5168.5 5198.3 5198.6 5205.1 6154.0 6231.1 6234.7 6242.8 6243.3 5825.0 5915.0 5928.5 5966.2 6026.9 6144.8 6187.5 6196.1 6214.7 6224.8 5779.0 5897.0 5903.1 5918.1 5956.3 5917.9 5937.7 5982.9 6016.7 6026.8 5821.1 5829.4 5876.6 5883.1 5894.2 5653.4 5798.9 5841.2 5841.8 5862.0 5830.1 5916.2 5918.8 5931.3 5952.4 5915.4 5938.7 5940.1 5966.3 5970.3 5675.3 5707.3 5721.4 5858.3 5864.8 04:43:01 INFO - PROCESS | 7666 | 04:43:01 INFO - PROCESS | 7666 | [#1] ext.html Cycles:180 Average:62663.04 Median:41900.98 stddev:129842.95 (309.9%) stddev-sans-first:130123.45 04:43:01 INFO - PROCESS | 7666 | Values: 553.1 589.8 597.1 612.6 626.0 37308.8 41837.2 41964.8 41977.4 42167.2 42302.6 42786.6 42835.0 42912.1 42913.0 8813.4 8948.8 8990.5 9004.8 9006.5 8933.2 9009.1 9012.1 9012.8 9016.8 8924.1 9036.3 9037.1 9042.0 9054.7 8945.5 8953.9 9005.1 9021.1 9022.9 8908.9 8928.7 8930.8 8964.7 8987.2 32332.5 40853.0 41325.2 41368.8 41473.0 3413.9 3590.4 3645.8 3709.7 3762.0 31285.2 31339.5 31461.5 32845.0 33958.3 4499.4 4533.5 4574.3 4713.4 4741.3 352103.0 357223.0 357832.0 359367.0 359465.0 34406.1 35458.0 35522.5 62408.4 62507.4 36941.3 37031.1 37178.8 37306.6 37335.8 15146.5 15326.0 15347.3 15376.5 15379.2 13605.1 13629.3 13661.7 13677.7 13768.9 8368.3 8460.3 8496.9 8545.4 8551.9 3292.5 3362.9 3376.5 3380.9 3386.2 980.4 996.1 1013.3 1073.6 1082.4 33130.7 33455.3 33501.7 33663.7 34151.5 1169.8 1170.9 1179.6 1184.2 1190.2 17386.8 17520.4 17622.7 17690.5 17814.6 566547.0 572515.0 576606.0 579151.0 580257.0 57891.0 58040.4 58334.0 58458.7 58561.0 1305.5 1348.0 1372.0 1380.8 1390.2 30134.0 31002.0 31383.5 31567.5 31624.5 51099.0 55590.6 57416.1 57534.0 61713.7 502776.0 503638.0 503879.0 505900.0 508870.0 43742.8 44501.6 44569.0 44970.1 45502.0 48669.8 48786.3 49089.0 50275.5 50558.7 41131.0 41268.4 42216.6 42969.8 43064.6 41715.4 41735.0 42586.8 42785.3 43225.6 35872.0 41010.6 41018.3 41476.4 41986.4 34940.3 37099.3 37387.6 37542.4 37583.4 28283.7 28518.7 28754.9 28961.3 29139.3 04:43:01 INFO - PROCESS | 7666 | 04:43:01 INFO - PROCESS | 7666 | [#2] jquery.html Cycles:180 Average:27267.86 Median:20758.78 stddev:70368.23 (339.0%) stddev-sans-first:70536.68 04:43:01 INFO - PROCESS | 7666 | Values: 384.3 384.5 385.2 394.7 409.1 14402.6 19123.5 20126.0 20316.3 20379.8 19190.3 19454.9 19656.3 20213.7 20225.1 5722.7 5855.9 5919.9 5925.6 5938.8 5443.3 5757.8 5812.2 5813.3 5824.9 5759.7 5778.9 5787.3 5816.7 5828.2 5942.7 6197.3 6227.6 6347.4 6356.6 5401.9 5612.4 5634.1 5648.3 5649.6 14063.6 14176.5 14280.7 14537.1 14547.6 2302.6 2338.7 2401.8 2450.8 2474.8 10251.5 10488.3 10548.9 10583.1 10677.3 1896.4 1944.3 1957.0 2009.3 2029.3 77390.0 79756.0 80720.0 81853.0 86583.6 10415.6 10523.5 10558.4 10839.2 11123.4 14678.0 14726.4 14768.6 14855.8 15102.3 8084.8 8273.6 8324.4 8415.5 8423.0 8224.5 8229.9 8258.5 8395.1 8409.4 4442.3 4620.7 4695.0 4730.5 4762.9 1871.5 1959.5 1963.2 1989.5 2004.9 900.7 914.4 982.2 1020.9 1101.9 20153.3 20486.4 20553.1 20964.5 21221.5 989.5 1028.6 1056.0 1079.0 1098.9 9179.8 11315.2 11420.8 11452.3 11557.9 368137.0 374212.0 376747.0 485319.0 488851.0 94660.0 100732.0 101514.5 102205.5 103738.0 1046.1 1087.8 1088.7 1092.7 1096.8 18330.6 18397.4 19127.7 19294.1 19439.8 41388.6 41790.6 43006.0 44630.0 45271.5 55374.0 56566.2 59526.7 59974.0 61101.4 7711.9 7988.2 8714.4 8963.6 9405.7 14514.7 14676.6 14726.6 14839.2 14958.6 12393.3 12650.9 12828.5 12884.2 12941.1 11658.5 11757.4 12769.5 12801.4 12902.6 5610.9 12140.6 12170.3 12608.2 12762.1 8126.2 8250.6 8305.8 8348.1 8416.9 10984.5 11236.8 11649.2 12571.3 12740.5 04:43:01 INFO - PROCESS | 7666 | 04:43:01 INFO - PROCESS | 7666 | [#3] mootools.html Cycles:180 Average:5909.75 Median:4672.62 stddev:3408.28 (72.9%) stddev-sans-first:3401.40 04:43:01 INFO - PROCESS | 7666 | Values: 1454.8 1509.6 1634.8 1774.6 1814.3 7942.7 8638.6 8641.1 9179.4 9211.6 8874.7 8899.6 8942.1 8944.2 8945.7 2330.0 2355.9 2357.2 2360.1 2362.0 2391.4 2419.7 2420.4 2431.0 2439.1 2324.7 2346.6 2352.8 2353.6 2361.1 2295.0 2303.8 2314.1 2315.8 2316.9 2282.3 2284.6 2290.4 2298.3 2299.0 9072.6 9120.9 9161.4 9211.9 9234.7 5079.1 5154.2 5182.0 5276.2 5280.7 3382.8 3432.3 3446.8 3497.5 3559.5 1117.3 1136.2 1166.3 1177.9 1181.5 12425.6 12473.1 12491.5 12561.3 12585.9 4501.1 4650.0 4695.3 4820.8 4831.5 10591.9 10605.9 10663.9 10708.8 10726.6 5323.5 5331.0 5331.4 5346.9 5354.8 4262.0 4754.4 4901.8 4911.7 4923.5 3917.3 3982.9 4054.6 4088.6 4134.0 1234.7 1272.0 1275.1 1278.4 1279.4 969.9 975.8 976.6 985.9 1001.4 5989.0 6013.7 6014.6 6062.4 6225.6 459.2 459.6 462.7 470.3 474.0 3957.6 4067.3 4077.7 4089.7 4107.9 11005.2 11312.5 11344.7 11415.5 11462.7 10480.9 11206.4 11265.8 11284.4 11285.7 8134.6 8186.4 8207.6 8238.1 8255.2 6136.1 6437.1 6437.8 6477.4 6486.3 10298.5 10349.3 10403.1 10439.3 10456.1 9849.5 10344.6 10722.7 10867.7 10911.3 6997.9 7649.5 7669.1 7959.2 8024.4 8870.3 8896.9 8903.8 8944.6 8965.3 7358.5 7623.8 7636.1 7666.1 7744.6 7660.6 7710.3 7771.1 7775.7 7815.3 7499.1 7500.5 7502.7 7553.7 7574.8 5060.7 5292.8 5390.3 5395.9 5404.2 5081.7 5156.6 5237.1 5269.8 5471.5 04:43:01 INFO - PROCESS | 7666 | 04:43:01 INFO - PROCESS | 7666 | [#4] prototype.html Cycles:180 Average:4944.64 Median:5574.04 stddev:1476.79 (26.5%) stddev-sans-first:1439.62 04:43:01 INFO - PROCESS | 7666 | Values: 323.3 334.4 336.2 339.7 340.1 5518.2 5621.4 5637.7 5713.3 5714.8 5526.6 5655.7 5679.7 5686.2 5699.9 4395.3 4398.9 4404.7 4419.5 4423.2 4134.9 4337.0 4363.7 4419.9 4456.9 4295.6 4301.3 4314.3 4327.7 4338.9 4344.5 4353.5 4358.2 4394.0 4402.8 3766.8 3808.9 3842.7 3858.4 3871.3 5442.8 5475.9 5477.8 5487.9 5497.6 4948.6 4972.8 4983.3 5001.3 5028.5 5710.0 5869.4 5895.9 5898.5 5919.5 4140.5 4147.9 4164.7 4175.9 4194.7 6169.8 6178.3 6205.5 6209.8 6211.2 4123.2 4220.5 4235.7 4240.8 4316.8 4286.2 4288.3 4295.8 4314.7 4339.3 4975.9 4981.9 4983.9 4991.7 5007.6 5714.3 5916.2 6013.3 6019.8 6033.3 1485.7 1486.9 1494.5 1495.0 1502.3 935.5 942.6 947.8 955.2 962.9 5058.0 5058.5 5087.4 5097.5 5154.5 5333.0 5339.0 5358.9 5365.9 5420.2 5081.0 5107.8 5162.4 5350.0 5779.5 3214.7 3228.0 3256.1 3262.0 3272.7 6054.6 6313.4 6319.6 6335.0 6355.5 6200.1 6204.7 6215.4 6266.5 6278.5 6333.4 6335.9 6342.2 6362.6 6370.4 5865.9 6081.9 6100.3 6122.7 6170.8 6044.4 6066.5 6074.5 6078.0 6110.6 6048.6 6303.7 6321.4 6327.6 6408.9 4273.5 4308.9 4321.1 4325.4 4329.9 6091.6 6152.5 6219.3 6221.7 6231.6 5700.5 5948.9 5982.2 5983.5 5993.7 5942.0 5968.9 6015.6 6018.7 6047.9 5728.4 5896.6 5926.6 5941.0 5966.5 6003.0 6007.6 6021.6 6042.9 6046.7 5869.4 5914.4 5918.7 5948.3 5949.4 04:43:01 INFO - PROCESS | 7666 | 04:43:01 INFO - PROCESS | 7666 | [#5] yui.html Cycles:180 Average:21713.75 Median:3816.76 stddev:31178.07 (816.9%) stddev-sans-first:31225.81 04:43:01 INFO - PROCESS | 7666 | Values: 753.5 760.9 773.4 800.9 830.2 15572.2 16425.4 16524.7 16630.8 16666.2 15178.3 15344.1 15365.9 15384.9 15400.5 670.1 803.7 827.0 828.9 830.2 818.4 818.5 822.6 824.4 824.8 877.0 877.9 878.0 879.2 879.8 858.7 867.1 867.5 867.9 869.3 633.1 635.3 635.5 637.3 637.9 15769.7 15814.7 15829.6 15853.6 15855.5 15724.0 15760.0 15807.8 15949.8 16078.6 12065.7 12089.4 12128.2 12218.1 12247.4 3823.7 3847.6 3893.1 3917.8 3988.7 71227.6 73700.6 78170.6 80439.6 80599.0 12519.7 12534.0 12738.2 12814.7 12852.6 24002.0 24117.3 24184.4 24275.2 24285.8 9409.1 9587.3 9889.5 9964.0 9967.9 4921.5 5039.2 5043.6 5149.7 5355.6 3687.6 3799.8 3810.0 3814.0 3819.5 682.5 688.5 688.7 707.0 708.7 714.2 750.3 762.7 763.6 771.5 10365.7 10429.9 10451.6 10650.5 10836.5 755.4 775.0 781.3 795.2 809.0 4894.4 5144.8 5153.1 5173.9 5177.2 90230.5 113967.4 120090.0 123500.0 124063.4 103338.0 105361.0 106480.0 106522.5 106691.5 92641.0 93335.5 93514.0 94299.0 96038.5 9881.0 9960.6 10012.2 10052.5 10068.3 53148.4 53561.5 53806.0 53935.2 55759.7 76461.2 77293.0 78689.6 80038.6 82073.6 12576.2 12686.2 13107.2 13133.0 13231.5 14552.3 14581.4 14585.9 14660.9 14704.5 13540.7 13546.8 13563.3 13670.5 13928.2 13229.4 13245.1 13268.9 13291.9 13396.4 12795.1 12810.7 13005.2 13122.7 13418.0 10823.2 11075.8 11086.2 11390.9 11423.4 11485.2 11601.0 11628.4 11639.2 11659.9 04:43:01 INFO - PROCESS | 7666 | -------- Summary: end -------- 04:43:01 INFO - PROCESS | 7666 | 04:43:02 INFO - TEST-INFO | 7666: exit 0 04:43:02 INFO - TEST-OK | dromaeo_css | took 1111427ms 04:43:02 INFO - TEST-START | kraken 04:43:02 INFO - operating with platform_type : linux_ 04:43:02 INFO - Initialising browser for kraken test... 04:43:02 INFO - TEST-INFO | started process 7919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKICNOF/profile http://localhost:43225/getInfo.html) 04:43:06 INFO - PROCESS | 7919 | __metrics Screen width/height:1600/1200 04:43:06 INFO - PROCESS | 7919 | colorDepth:24 04:43:06 INFO - PROCESS | 7919 | Browser inner width/height: 1024/697 04:43:06 INFO - PROCESS | 7919 | __metrics 04:43:07 ERROR - PROCESS | 7919 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2964: TypeError: this.tabs is undefined 04:43:08 INFO - TEST-INFO | 7919: exit 0 04:43:08 INFO - Browser initialized. 04:43:08 INFO - Running cycle 1/1 for kraken test... 04:43:08 INFO - TEST-INFO | started process 8042 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKICNOF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:20 INFO - PROCESS | 8042 | RSS: Main: 168239104 04:43:20 INFO - PROCESS | 8042 | 04:43:22 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43225/tests/kraken/driver.html?testName=audio-beat-detection) 04:43:23 INFO - PROCESS | 8042 | RSS: Main: 173948928 04:43:23 INFO - PROCESS | 8042 | 04:43:26 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43225/tests/kraken/driver.html?testName=audio-dft) 04:43:26 INFO - PROCESS | 8042 | RSS: Main: 172785664 04:43:26 INFO - PROCESS | 8042 | 04:43:29 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43225/tests/kraken/driver.html?testName=audio-fft) 04:43:30 INFO - PROCESS | 8042 | RSS: Main: 167395328 04:43:30 INFO - PROCESS | 8042 | 04:43:32 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43225/tests/kraken/driver.html?testName=audio-oscillator) 04:43:33 INFO - PROCESS | 8042 | RSS: Main: 168439808 04:43:33 INFO - PROCESS | 8042 | 04:43:35 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43225/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:43:35 INFO - PROCESS | 8042 | RSS: Main: 168472576 04:43:35 INFO - PROCESS | 8042 | 04:43:38 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43225/tests/kraken/driver.html?testName=imaging-darkroom) 04:43:39 INFO - PROCESS | 8042 | RSS: Main: 168611840 04:43:39 INFO - PROCESS | 8042 | 04:43:43 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43225/tests/kraken/driver.html?testName=imaging-desaturate) 04:43:43 INFO - PROCESS | 8042 | RSS: Main: 167202816 04:43:43 INFO - PROCESS | 8042 | 04:43:46 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43225/tests/kraken/driver.html?testName=json-parse-financial) 04:43:47 INFO - PROCESS | 8042 | RSS: Main: 167702528 04:43:47 INFO - PROCESS | 8042 | 04:43:48 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43225/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:43:49 INFO - PROCESS | 8042 | RSS: Main: 167882752 04:43:49 INFO - PROCESS | 8042 | 04:43:51 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43225/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:43:51 INFO - PROCESS | 8042 | RSS: Main: 168751104 04:43:51 INFO - PROCESS | 8042 | 04:43:53 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43225/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:43:54 INFO - PROCESS | 8042 | RSS: Main: 168964096 04:43:54 INFO - PROCESS | 8042 | 04:43:57 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:43:57 INFO - PROCESS | 8042 | RSS: Main: 169095168 04:43:57 INFO - PROCESS | 8042 | 04:44:00 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:44:01 INFO - PROCESS | 8042 | RSS: Main: 168624128 04:44:01 INFO - PROCESS | 8042 | 04:44:02 INFO - PROCESS | 8042 | Cycle 1(1): loaded http://localhost:43225/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43225/tests/kraken/driver.html?testName=ai-astar) 04:44:02 INFO - PROCESS | 8042 | RSS: Main: 169635840 04:44:02 INFO - PROCESS | 8042 | 04:44:02 INFO - PROCESS | 8042 | __start_tp_report 04:44:02 INFO - PROCESS | 8042 | _x_x_mozilla_page_load 04:44:02 INFO - PROCESS | 8042 | _x_x_mozilla_page_load_details 04:44:02 INFO - PROCESS | 8042 | |i|pagename|runs| 04:44:02 INFO - PROCESS | 8042 | |0;ai-astar;102;112;108;110;113;111;111;113;111;113 04:44:02 INFO - PROCESS | 8042 | |1;audio-beat-detection;158;116;148;179;119;151;144;120;174;122 04:44:02 INFO - PROCESS | 8042 | |2;audio-dft;163;162;163;164;162;166;176;163;162;163 04:44:02 INFO - PROCESS | 8042 | |3;audio-fft;74;75;76;136;78;75;83;76;170;76 04:44:02 INFO - PROCESS | 8042 | |4;audio-oscillator;83;83;157;83;83;86;137;83;83;162 04:44:02 INFO - PROCESS | 8042 | |5;imaging-gaussian-blur;118;118;117;117;118;118;118;118;121;118 04:44:02 INFO - PROCESS | 8042 | |6;imaging-darkroom;147;148;149;148;147;146;147;146;147;148 04:44:02 INFO - PROCESS | 8042 | |7;imaging-desaturate;96;97;95;95;96;96;96;95;96;96 04:44:02 INFO - PROCESS | 8042 | |8;json-parse-financial;54;54;55;54;57;56;53;55;56;55 04:44:02 INFO - PROCESS | 8042 | |9;json-stringify-tinderbox;61;60;62;61;61;60;61;62;64;62 04:44:02 INFO - PROCESS | 8042 | |10;stanford-crypto-aes;76;76;75;76;79;78;76;75;84;76 04:44:02 INFO - PROCESS | 8042 | |11;stanford-crypto-ccm;121;132;128;126;129;144;125;132;171;132 04:44:02 INFO - PROCESS | 8042 | |12;stanford-crypto-pbkdf2;161;156;155;161;160;157;158;158;160;163 04:44:02 INFO - PROCESS | 8042 | |13;stanford-crypto-sha256-iterative;62;63;63;64;62;63;63;63;63;61 04:44:02 INFO - PROCESS | 8042 | __end_tp_report 04:44:02 INFO - PROCESS | 8042 | __start_cc_report 04:44:02 INFO - PROCESS | 8042 | _x_x_mozilla_cycle_collect,906 04:44:02 INFO - PROCESS | 8042 | __end_cc_report 04:44:02 INFO - PROCESS | 8042 | __startTimestamp1468410242991__endTimestamp 04:44:02 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | ------- Summary: start ------- 04:44:03 INFO - PROCESS | 8042 | Number of tests: 14 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.34 (3.0%) stddev-sans-first:1.66 04:44:03 INFO - PROCESS | 8042 | Values: 102.0 112.0 108.0 110.0 113.0 111.0 111.0 113.0 111.0 113.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#1] audio-beat-detection Cycles:10 Average:143.10 Median:149.50 stddev:23.21 (15.5%) stddev-sans-first:23.98 04:44:03 INFO - PROCESS | 8042 | Values: 158.0 116.0 148.0 179.0 119.0 151.0 144.0 120.0 174.0 122.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#2] audio-dft Cycles:10 Average:164.40 Median:163.00 stddev:4.25 (2.6%) stddev-sans-first:4.48 04:44:03 INFO - PROCESS | 8042 | Values: 163.0 162.0 163.0 164.0 162.0 166.0 176.0 163.0 162.0 163.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#3] audio-fft Cycles:10 Average:91.90 Median:76.00 stddev:33.28 (43.8%) stddev-sans-first:34.66 04:44:03 INFO - PROCESS | 8042 | Values: 74.0 75.0 76.0 136.0 78.0 75.0 83.0 76.0 170.0 76.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#4] audio-oscillator Cycles:10 Average:104.00 Median:83.00 stddev:33.72 (40.6%) stddev-sans-first:34.90 04:44:03 INFO - PROCESS | 8042 | Values: 83.0 83.0 157.0 83.0 83.0 86.0 137.0 83.0 83.0 162.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#5] imaging-gaussian-blur Cycles:10 Average:118.10 Median:118.00 stddev:1.10 (0.9%) stddev-sans-first:1.17 04:44:03 INFO - PROCESS | 8042 | Values: 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 121.0 118.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#6] imaging-darkroom Cycles:10 Average:147.30 Median:147.50 stddev:0.95 (0.6%) stddev-sans-first:1.00 04:44:03 INFO - PROCESS | 8042 | Values: 147.0 148.0 149.0 148.0 147.0 146.0 147.0 146.0 147.0 148.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 04:44:03 INFO - PROCESS | 8042 | Values: 96.0 97.0 95.0 95.0 96.0 96.0 96.0 95.0 96.0 96.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#8] json-parse-financial Cycles:10 Average:54.90 Median:55.00 stddev:1.20 (2.2%) stddev-sans-first:1.22 04:44:03 INFO - PROCESS | 8042 | Values: 54.0 54.0 55.0 54.0 57.0 56.0 53.0 55.0 56.0 55.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#9] json-stringify-tinderbox Cycles:10 Average:61.40 Median:61.50 stddev:1.17 (1.9%) stddev-sans-first:1.24 04:44:03 INFO - PROCESS | 8042 | Values: 61.0 60.0 62.0 61.0 61.0 60.0 61.0 62.0 64.0 62.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#10] stanford-crypto-aes Cycles:10 Average:77.10 Median:76.00 stddev:2.73 (3.6%) stddev-sans-first:2.86 04:44:03 INFO - PROCESS | 8042 | Values: 76.0 76.0 75.0 76.0 79.0 78.0 76.0 75.0 84.0 76.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#11] stanford-crypto-ccm Cycles:10 Average:134.00 Median:132.00 stddev:14.36 (10.9%) stddev-sans-first:14.44 04:44:03 INFO - PROCESS | 8042 | Values: 121.0 132.0 128.0 126.0 129.0 144.0 125.0 132.0 171.0 132.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.90 Median:160.00 stddev:2.51 (1.6%) stddev-sans-first:2.55 04:44:03 INFO - PROCESS | 8042 | Values: 161.0 156.0 155.0 161.0 160.0 157.0 158.0 158.0 160.0 163.0 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - PROCESS | 8042 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.70 Median:63.00 stddev:0.82 (1.3%) stddev-sans-first:0.83 04:44:03 INFO - PROCESS | 8042 | Values: 62.0 63.0 63.0 64.0 62.0 63.0 63.0 63.0 63.0 61.0 04:44:03 INFO - PROCESS | 8042 | -------- Summary: end -------- 04:44:03 INFO - PROCESS | 8042 | 04:44:03 INFO - TEST-INFO | 8042: exit 0 04:44:04 INFO - TEST-OK | kraken | took 61953ms 04:44:04 INFO - SUITE-END | took 1173s 04:44:04 INFO - Completed test suite (00:19:33) 04:44:04 INFO - javascript benchmark 04:44:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7372.332657282698, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3070.58547096142, 3085.6142982127235, 3108.424941385843, 3108.5803416538774, 3126.0778070469223, 5299.258103865462, 5354.518093371596, 5357.678539287641, 5436.537894278981, 5461.0, 5451.809186678467, 5523.917141242885, 5525.917111243324, 5538.806141785029, 5565.109582466806, 4965.553100220979, 5004.724740139291, 5107.131787596099, 5161.664491808039, 5188.662736922107, 511.6428087527116, 4934.235193545006, 4974.278729584208, 5023.547880690737, 5115.309433226523, 5012.573931215851, 5038.294638750578, 5048.621353398491, 5056.519630635084, 5064.063148317555, 5057.645964782467, 5062.190049592047, 5084.313617661605, 5088.669236499616, 5091.287219789232, 4981.37732783402, 5018.197088465864, 5042.647014708972, 5065.797368105272, 5072.391313042459, 5575.637583557056, 5581.609287349887, 5600.6079574429805, 5615.606907516475, 5620.718964051781, 5707.6290041147195, 5764.394738552433, 5916.792912248051, 5919.052951527778, 5950.761969521214, 5927.318358388754, 5987.1019347097845, 5988.0, 6041.184440100574, 6042.486388656969, 5624.184493248456, 5626.718664066781, 5626.859328516779, 5628.127640215773, 5633.267675202238, 5991.460768530766, 6059.182010428536, 6143.784967526204, 6155.876882462326, 6181.96909015452, 5878.0, 5927.377625349276, 5940.940590594125, 5941.643501389844, 5982.102684597346, 5979.4618484336615, 6004.819855404345, 6006.309274433496, 6025.969870150621, 6029.547783916224, 5560.4161563035295, 5865.384134665884, 5879.235699359056, 5980.252468441445, 5983.640981541122, 5862.765489380462, 5902.793402230901, 5908.320543137508, 5917.171595976567, 5918.496927761188, 4516.932246016312, 4536.138133754576, 4541.954580454153, 4578.198815207325, 4586.1057093866375, 3930.508686414198, 4019.8995025124605, 4036.495438070241, 4046.5751096135073, 4063.6342729153926, 5647.858803529944, 5696.971515142398, 5716.228309178291, 5718.857028574319, 5751.194832723422, 6014.578979471483, 6017.398260174035, 6028.457438830438, 6037.577369584087, 6039.396060393926, 5553.639013464192, 5749.712514374264, 5791.8552036199435, 5827.854303642358, 5833.562482813806, 5160.8967820643375, 5168.508991645787, 5198.298229739013, 5198.636095473281, 5205.06308864408, 6154.0, 6231.096491008779, 6234.657093859791, 6242.843928901813, 6243.313235544087, 5825.0388685866355, 5914.970425148019, 5928.466438020599, 5966.19456373384, 6026.879462410815, 6144.763605695434, 6187.474064704551, 6196.132541444112, 6214.658193799384, 6224.751009959551, 5779.0, 5897.026990546683, 5903.144044113494, 5918.112283157561, 5956.255468066492, 5917.940820591739, 5937.732802023833, 5982.880342393215, 6016.6690832002905, 6026.849328766816, 5821.126830975219, 5829.417058294137, 5876.588638795243, 5883.0881213411985, 5894.174815525744, 5653.3781284057895, 5798.855028624318, 5841.211436456024, 5841.795537156179, 5862.0, 5830.067189249699, 5916.171735956884, 5918.822435326947, 5931.258592675916, 5952.434518720888, 5915.37888521699, 5938.673372964528, 5940.108983652314, 5966.254218222723, 5970.253718285215, 5675.262215911905, 5707.315122185199, 5721.427857214246, 5858.297004359334, 5864.765409383577], "value": 5461.885759638614, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [553.1269515567848, 589.764094362255, 597.0566504922224, 612.6201754911954, 625.9687015649216, 37308.81345593275, 41837.16325673492, 41964.790176049115, 41977.3703394449, 42167.15665686684, 42302.57697423025, 42786.57213427865, 42835.0, 42912.141757164834, 42913.0, 8813.427127236726, 8948.821023579525, 8990.460572365646, 9004.77488062797, 9006.549672516381, 8933.196012358887, 9009.144131307516, 9012.098790121001, 9012.77468063297, 9016.77458063547, 8924.062973387765, 9036.27709783219, 9037.051109633492, 9041.95479022604, 9054.728358149267, 8945.507997060158, 8953.910460895373, 9005.14451127142, 9021.09789021096, 9022.909770902272, 8908.8663670045, 8928.73213803587, 8930.821383572356, 8964.68623598171, 8987.191152796215, 32332.515012274835, 40853.0, 41325.173496529904, 41368.79315603433, 41473.0, 3413.9146521336916, 3590.407582748843, 3645.76302540334, 3709.7403181777286, 3761.981190094032, 31285.217869553217, 31339.529907051412, 31461.483081353435, 32845.0, 33958.32083358319, 4499.415076040126, 4533.478649955265, 4574.268117101248, 4713.434387873443, 4741.2651039089, 352103.0, 357223.0, 357832.0, 359366.9999999974, 359465.0, 34406.13984650404, 35458.0, 35522.46716299257, 62408.37591624026, 62507.37492625107, 36941.26117477635, 37031.074223144635, 37178.8141059293, 37306.626933730855, 37335.81332093377, 15146.545603631908, 15326.0, 15347.309371078329, 15376.538703838904, 15379.231038448257, 13605.115667481581, 13629.25039122838, 13661.726765464635, 13677.658058548417, 13768.93115534436, 8368.3305335573, 8460.323174146053, 8496.915030849736, 8545.359098067669, 8551.871721924175, 3292.4732042873025, 3362.899113026613, 3376.5272861798876, 3380.864765409405, 3386.204242003127, 980.367662857453, 996.0537489385113, 1013.2704452793977, 1073.6188653028219, 1082.3884505254507, 33130.70516601838, 33455.33089338248, 33501.66498335034, 33663.66336336654, 34151.48772768411, 1169.7952858249773, 1170.9473073711704, 1179.598936361624, 1184.2420850655587, 1190.2263528706237, 17386.826131738522, 17520.38678646241, 17622.735658965124, 17690.469285921445, 17814.554636134202, 566547.0, 572515.0, 576606.0, 579151.0, 580257.0, 57891.0, 58040.41959580435, 58334.0, 58458.707706461195, 58561.0, 1305.451710281684, 1348.042889548412, 1371.9519816806364, 1380.8412032616377, 1390.193687661134, 30134.0, 31002.0, 31383.529247061768, 31567.526487103172, 31624.525632115077, 51099.0, 55590.607080186295, 57416.1387579195, 57534.0, 61713.69143154255, 502776.0, 503638.0, 503879.0, 505900.0, 508870.0, 43742.78128609336, 44501.554984449744, 44569.0, 44970.10059798851, 45502.0, 48669.756651216514, 48786.26820597623, 49089.0, 50275.49724502708, 50558.74720626373, 41131.0, 41268.38097428601, 42216.59259111746, 42969.785151075295, 43064.569354306055, 41715.37426938538, 41735.0, 42586.78706606447, 42785.34605135307, 43225.56774432216, 35872.0, 41010.589894100674, 41018.28289746598, 41476.377854332815, 41986.37020444757, 34940.30119397547, 37099.25801483901, 37387.62612373842, 37542.43686344652, 37583.43624845575, 28283.717162828107, 28518.714812851606, 28754.856225718737, 28961.275968100123, 29139.271518211368], "value": 19408.538220646296, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.3216722484813, 384.5366333568049, 385.1624476389246, 394.7197489782254, 409.0612045355908, 14402.639934001656, 19123.52191195219, 20126.0, 20316.288929887458, 20379.796202037975, 19190.328338508156, 19454.902725486387, 19656.312029078985, 20213.696794548094, 20225.089870955806, 5722.713864306789, 5855.882882342351, 5919.88160236795, 5925.585209035369, 5938.8218353449465, 5443.346798384199, 5757.798477053304, 5812.215350927634, 5813.331466881299, 5824.941750582503, 5759.654420734749, 5778.942210577882, 5787.305523337205, 5816.738246778905, 5828.18405423239, 5942.673152976585, 6197.256329240475, 6227.564070515065, 6347.39699728525, 6356.555041147121, 5401.918971215435, 5612.438756124355, 5634.0703783875615, 5648.293963254593, 5649.6327738696855, 14063.64840878976, 14176.503822366167, 14280.714385712228, 14537.127772333693, 14547.636309092251, 2302.5855346037706, 2338.6608941703357, 2401.807855371566, 2450.779429851304, 2474.8391354561895, 10251.538680759384, 10488.265821392506, 10548.94725526375, 10583.10043646291, 10677.305975111592, 1896.421591414618, 1944.3389247655723, 1957.0, 2009.3067891577382, 2029.2796057399705, 77390.0, 79756.0, 80720.0, 81853.0, 86583.56708216418, 10415.583376664848, 10523.473826308655, 10558.419286939292, 10839.241253112365, 11123.443827808576, 14678.0, 14726.410943562138, 14768.556943291718, 14855.777163342558, 15102.320395582225, 8084.8383032339025, 8273.627686754111, 8324.417290789586, 8415.45299555527, 8423.0, 8224.506529608243, 8229.917700822914, 8258.545779982158, 8395.076541580422, 8409.4022135794, 4442.311441726538, 4620.653450991189, 4694.953050469451, 4730.455997560324, 4762.880927976759, 1871.5414723392855, 1959.549303660166, 1963.2441510018746, 1989.5225145965153, 2004.8696834705697, 900.6622516556291, 914.3919293669768, 982.1798798003604, 1020.8974307747615, 1101.8787933327328, 20153.29463468801, 20486.38540843777, 20553.075111619713, 20964.47588810292, 21221.469463263235, 989.4508547756064, 1028.5937054863286, 1055.9809783558749, 1078.9730256743644, 1098.8956049175315, 9179.770505737277, 11315.15136364776, 11420.828687569694, 11452.255603385753, 11557.942210288895, 368137.0, 374212.0, 376747.0, 485319.0, 488851.0, 94660.0, 100732.0, 101514.49242753739, 102205.48897255467, 103738.0, 1046.0951277145214, 1087.8251488392516, 1088.711491454765, 1092.7377429417043, 1096.8409580610767, 18330.633387331913, 18397.448076557725, 19127.713084304025, 19294.13176407037, 19439.805601944365, 41388.586114138474, 41790.582094178666, 43006.0, 44630.0, 45271.54728452805, 55374.0, 56566.151507726594, 59526.70236648789, 59974.0, 61101.38898610957, 7711.922880771345, 7988.241117093867, 8714.38999270045, 8963.551822408985, 9405.717828465156, 14514.709705806035, 14676.633084172981, 14726.63183420423, 14839.183844888203, 14958.626034349229, 12393.318367489876, 12650.873491264969, 12828.486860525847, 12884.226946383247, 12941.09412341127, 11658.475368608602, 11757.412129393668, 12769.489220431078, 12801.423935923092, 12902.612921612366, 5610.905873354656, 12140.575079872162, 12170.330631815335, 12608.243505389706, 12762.106652534234, 8126.228008339198, 8250.628721707417, 8305.750827475185, 8348.081711011662, 8416.915830841857, 10984.505697243803, 11236.83144752813, 11649.242799218024, 12571.30857802793, 12740.490380385052], "value": 9260.47143021137, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1454.8108745863037, 1509.6075020494673, 1634.811996620389, 1774.618457031738, 1814.2652225848535, 7942.722004729836, 8638.611262493187, 8641.092685268042, 9179.357444978854, 9211.58547865346, 8874.689385871496, 8899.599518021689, 8942.061083586228, 8944.150305720947, 8945.686900958468, 2329.9883500582473, 2355.857409156558, 2357.210334537932, 2360.1031607989025, 2361.988190059047, 2391.354334329739, 2419.6854408926815, 2420.394901274681, 2431.0397393029743, 2439.1097249503982, 2324.7094113235844, 2346.554154710608, 2352.8353015288935, 2353.62342025276, 2361.055577768898, 2294.9885250573807, 2303.79265866072, 2314.0975019742314, 2315.8494697844585, 2316.907323707058, 2282.349530383849, 2284.6230371988604, 2290.393045842853, 2298.321995011459, 2298.954020919589, 9072.591733372014, 9120.908790912072, 9161.358704890661, 9211.861822072675, 9234.722958311262, 5079.111155547765, 5154.226865970097, 5182.0, 5276.155815069609, 5280.656757310762, 3382.797032178077, 3432.262063656301, 3446.7931924084637, 3497.4928635347733, 3559.519464872235, 1117.2570240789864, 1136.1705954653066, 1166.3177041430772, 1177.9057675385948, 1181.5037684172669, 12425.62723118308, 12473.126881118325, 12491.500339986389, 12561.309127997865, 12585.874141258653, 4501.077279157765, 4649.976750116228, 4695.272232803921, 4820.758962051884, 4831.51684831514, 10591.94704026475, 10605.946970265253, 10663.89336106629, 10708.78582428347, 10726.624568140234, 5323.467653234646, 5331.040412725669, 5331.4401987790725, 5346.91979620306, 5354.839354819362, 4262.0, 4754.429468463806, 4901.828436004723, 4911.656184067152, 4923.532264434873, 3917.334053210961, 3982.8605998789903, 4054.553999060101, 4088.6320231178743, 4133.958660413417, 1234.6542967968983, 1272.033254726396, 1275.0819410024767, 1278.367208231931, 1279.4242590834162, 969.9078587534173, 975.775401870662, 976.5947131940308, 985.8619793228954, 1001.3741411617739, 5989.0, 6013.6993150342305, 6014.6391216527145, 6062.424069713458, 6225.564210505221, 459.21245064714174, 459.6185166311953, 462.7293033575396, 470.30864628995323, 473.9549742774431, 3957.584453632385, 4067.2678917794487, 4077.6941729369823, 4089.6523795477124, 4107.938380924288, 11005.17461190398, 11312.490937907814, 11344.716382090348, 11415.543378264776, 11462.713432164262, 10480.895191048145, 11206.38364889939, 11265.831012534654, 11284.43577821122, 11285.717857053474, 8134.633941472648, 8186.386021048445, 8207.589620518951, 8238.09380968093, 8255.215754503433, 6136.140940268455, 6437.130987316839, 6437.839054023687, 6477.4494167996245, 6486.286508484157, 10298.485075746034, 10349.275550711378, 10403.063724264852, 10439.321444106108, 10456.111230545488, 9849.507524623883, 10344.586216551254, 10722.678319650424, 10867.728306792078, 10911.345319280868, 6997.895031574429, 7649.541027538366, 7669.079710434784, 7959.204079591995, 8024.39817013738, 8870.290376769972, 8896.911030889867, 8903.821923561622, 8944.597493112955, 8965.327600430124, 7358.521696089737, 7623.771286861403, 7636.121845987783, 7666.080070391588, 7744.612769361622, 7660.616969151632, 7710.306072453506, 7771.145174030965, 7775.650095745592, 7815.25755053269, 7499.062617172854, 7500.549967001997, 7502.737404190827, 7553.660085296285, 7574.810629734301, 5060.696358218372, 5292.841214763564, 5390.27231323782, 5395.946040539701, 5404.243405923253, 5081.71322904687, 5156.587473002076, 5237.057329680694, 5269.789208431773, 5471.50756431923], "value": 4636.020488322443, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [323.25328491185365, 334.41644330643027, 336.23338787564364, 339.73500669477806, 340.1343580587405, 5518.227448157261, 5621.437856214377, 5637.66174029558, 5713.257276554047, 5714.77140914364, 5526.640768350055, 5655.717214139287, 5679.744411501482, 5686.232358631583, 5699.943000570003, 4395.296752519597, 4398.868033958986, 4404.713693609921, 4419.491758447787, 4423.159599676067, 4134.917301653965, 4337.0, 4363.650907927358, 4419.933700994472, 4456.8885777855485, 4295.613394794468, 4301.26878430666, 4314.288142456491, 4327.706315652709, 4338.891527711817, 4344.522102568715, 4353.521112677603, 4358.237308471021, 4394.0, 4402.7798610069685, 3766.773993560395, 3808.8857334280015, 3842.692584593226, 3858.421236814472, 3871.3031654302213, 5442.755076021588, 5475.863103422406, 5477.808276710336, 5487.862803429906, 5497.642653227527, 4948.579370753454, 4972.83138462461, 4983.259207435895, 5001.274815151783, 5028.547430731252, 5710.030039636319, 5869.354371019184, 5895.852603684899, 5898.498627616657, 5919.526437884959, 4140.482439695038, 4147.875563733062, 4164.708470407073, 4175.895602609929, 4194.748315101104, 6169.784057557964, 6178.331850400366, 6205.503559715212, 6209.813705588885, 6211.19254496917, 4123.175364927027, 4220.514640816284, 4235.661147108224, 4240.830366785356, 4316.827326906889, 4286.2284788738325, 4288.31386978082, 4295.8281668733525, 4314.69797114199, 4339.305711086211, 4975.875603109879, 4981.850544483671, 4983.878627308826, 4991.725455099931, 5007.599392048627, 5714.285714285715, 5916.201312822714, 6013.30846952606, 6019.819405417757, 6033.336333003366, 1485.6731519065788, 1486.9330880110422, 1494.4993427201791, 1494.9535325272136, 1502.2864139533854, 935.4655822955526, 942.5617088054088, 947.8199142162968, 955.159459675495, 962.9229661627193, 5058.0, 5058.54473097423, 5087.389513258433, 5097.541221290027, 5154.5103215194495, 5333.0, 5338.97330513345, 5358.866028349323, 5365.907296154503, 5420.24116623673, 5080.974595127001, 5107.821226257063, 5162.432132465426, 5349.973250133802, 5779.450952159538, 3214.6659136458106, 3227.951580726291, 3256.055743834309, 3261.951070733941, 3272.6563710810497, 6054.636721796706, 6313.390085528161, 6319.620822750558, 6334.968325158345, 6355.459785918249, 6200.131981522591, 6204.689765511706, 6215.440610345091, 6266.467350275278, 6278.497720182374, 6333.429991300713, 6335.936640633627, 6342.207224096988, 6362.618242905441, 6370.394812492806, 5865.912011319749, 6081.939180608138, 6100.298465676504, 6122.7244773984385, 6170.845728856635, 6044.395560443921, 6066.484348830399, 6074.511744622596, 6078.027515597483, 6110.602810817282, 6048.637081775108, 6303.747850085945, 6321.399467050623, 6327.588706734047, 6408.93591064102, 4273.508546517191, 4308.870733877989, 4321.13577284538, 4325.437693100002, 4329.870103896888, 6091.573589848668, 6152.477039451696, 6219.253689557282, 6221.671405797876, 6231.626102433868, 5700.543956483389, 5948.940510594839, 5982.192404025401, 5983.474214075557, 5993.741314324041, 5942.049272116441, 5968.850778730392, 6015.646479542068, 6018.666560076737, 6047.879042419215, 5728.369879313355, 5896.55775816824, 5926.644401335933, 5940.970295148497, 5966.463018328198, 6002.969985150046, 6007.639541627516, 6021.578489505868, 6042.912275790224, 6046.667433291212, 5869.388122285542, 5914.4381283777975, 5918.674472903859, 5948.2862056553495, 5949.423402798176], "value": 4466.58251186422, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [753.5328096580117, 760.9201033891442, 773.4237992695442, 800.8558459477293, 830.1822704635932, 15572.221388930551, 16425.42511012115, 16524.669506609862, 16630.75053874193, 16666.166691665414, 15178.31697573609, 15344.079355238693, 15365.92317038416, 15384.923075384608, 15400.537983860475, 670.1154476091549, 803.6905791270374, 826.9503829770233, 828.9295409890167, 830.2154464031493, 818.3984771193168, 818.5293456262643, 822.6462621072936, 824.3858325547476, 824.8391563645091, 877.0352612126674, 877.8507653698855, 877.9912200877974, 879.1560102301798, 879.7844528090627, 858.6651206029622, 867.0549101479355, 867.4968518259394, 867.8784970104191, 869.2958703450194, 633.0567454492818, 635.3106879036251, 635.5011316116872, 637.3276193615734, 637.91069250305, 15769.68460630781, 15814.683706325925, 15829.60425989348, 15853.60365990848, 15855.524334269874, 15724.0, 15759.95957714532, 15807.841921580866, 15949.760753588705, 16078.5980350491, 12065.698357541043, 12089.395530223454, 12128.151029427943, 12218.144729868913, 12247.387630618523, 3823.6941044716355, 3847.634474724897, 3893.1435084281698, 3917.764934103963, 3988.74073185242, 71227.64386178037, 73700.6314968427, 78170.6091469539, 80439.59780201061, 80599.0, 12519.681140763589, 12534.0, 12738.235705857678, 12814.67963300925, 12852.614421567368, 24002.039918403418, 24117.276481705576, 24184.395390115387, 24275.150369736974, 24285.7571424287, 9409.106134917172, 9587.280953928483, 9889.50552472388, 9964.0, 9967.850482242773, 4921.458639549646, 5039.21892106724, 5043.5965122790085, 5149.665271757323, 5355.598330125178, 3687.5574931007914, 3799.8290076946605, 3809.961900381016, 3814.0274230071154, 3819.4843696101225, 682.474494639125, 688.4905170174035, 688.6935313785317, 706.9540479868792, 708.7200555780438, 714.2250658036089, 750.3097150621442, 762.7414765636744, 763.6334559411403, 771.4946709905021, 10365.740856478498, 10429.895701043044, 10451.634192803367, 10650.520726567323, 10836.500004986834, 755.3956834532352, 774.972875949339, 781.2773184804033, 795.2326005404697, 808.9635966381527, 4894.412670479565, 5144.768485418165, 5153.149730294459, 5173.922391164136, 5177.249298851721, 90230.54884725534, 113967.43016285032, 120090.0, 123500.0, 124063.37968310101, 103338.0, 105361.0, 106480.0, 106522.46738766256, 106691.46654266835, 92641.0, 93335.53332233295, 93514.0, 94299.0, 96038.51980740052, 9881.0, 9960.601575936882, 10012.249081319076, 10052.547635356574, 10068.295219334575, 53148.40554783363, 53561.46438535565, 53806.0, 53935.19097213623, 55759.721201395354, 76461.23538764541, 77293.0, 78689.60655196688, 80038.59980700059, 82073.58963205146, 12576.182548134342, 12686.175398599062, 13107.213567186, 13132.955311471767, 13231.470741170246, 14552.345144468312, 14581.416743330148, 14585.854141458449, 14660.85339146595, 14704.485343012942, 13540.661483462993, 13546.79679804784, 13563.31903800011, 13670.453181873012, 13928.164310141425, 13229.404676789374, 13245.139065960682, 13268.867311326763, 13291.933540332237, 13396.351674048394, 12795.104342696295, 12810.67973300675, 13005.21968681882, 13122.737545249232, 13417.974478408027, 10823.242373034127, 11075.778484430428, 11086.223964322742, 11390.943045284721, 11423.428828558704, 11485.196036277715, 11601.0, 11628.418579071182, 11639.243449175776, 11659.883401166218], "value": 7897.6716145104665, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1524.0000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 112.0, 108.0, 110.0, 113.0, 111.0, 111.0, 113.0, 111.0, 113.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 116.0, 148.0, 179.0, 119.0, 151.0, 144.0, 120.0, 174.0, 122.0], "value": 143.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 163.0, 164.0, 162.0, 166.0, 176.0, 163.0, 162.0, 163.0], "value": 164.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 75.0, 76.0, 136.0, 78.0, 75.0, 83.0, 76.0, 170.0, 76.0], "value": 91.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 157.0, 83.0, 83.0, 86.0, 137.0, 83.0, 83.0, 162.0], "value": 104.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 121.0, 118.0], "value": 118.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 148.0, 147.0, 146.0, 147.0, 146.0, 147.0, 148.0], "value": 147.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 97.0, 95.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0], "value": 95.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 54.0, 55.0, 54.0, 57.0, 56.0, 53.0, 55.0, 56.0, 55.0], "value": 54.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 62.0, 61.0, 61.0, 60.0, 61.0, 62.0, 64.0, 62.0], "value": 61.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 76.0, 79.0, 78.0, 76.0, 75.0, 84.0, 76.0], "value": 77.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 132.0, 128.0, 126.0, 129.0, 144.0, 125.0, 132.0, 171.0, 132.0], "value": 134.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 156.0, 155.0, 161.0, 160.0, 157.0, 158.0, 158.0, 160.0, 163.0], "value": 158.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 63.0, 64.0, 62.0, 63.0, 63.0, 63.0, 63.0, 61.0], "value": 62.7, "unit": "score"}]}]} 04:44:04 INFO - Return code: 0 04:44:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:44:04 ERROR - # TBPL SUCCESS # 04:44:04 INFO - Running post-action listener: _resource_record_post_action 04:44:04 INFO - ##### 04:44:04 INFO - ##### Finished run-tests step (success) 04:44:04 INFO - ##### 04:44:04 INFO - Running post-run listener: _resource_record_post_run 04:44:04 INFO - Total resource usage - Wall time: 1191s; CPU: 13.0%; Read bytes: 4096; Write bytes: 568672256; Read time: 16; Write time: 605660 04:44:04 INFO - TinderboxPrint: CPU usage
13.3% 04:44:04 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 04:44:04 INFO - TinderboxPrint: I/O write bytes / time
568,672,256 / 605,660 04:44:04 INFO - TinderboxPrint: CPU idle
8,235.1 (86.7%) 04:44:04 INFO - TinderboxPrint: CPU user
1,212.0 (12.8%) 04:44:04 INFO - TinderboxPrint: Swap in / out
0 / 0 04:44:04 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 273285120; Read time: 0; Write time: 324956 04:44:04 INFO - run-tests - Wall time: 1174s; CPU: 13.0%; Read bytes: 0; Write bytes: 295194624; Read time: 0; Write time: 280676 04:44:04 INFO - Running post-run listener: _upload_blobber_files 04:44:04 INFO - Blob upload gear active. 04:44:04 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:44:04 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 04:44:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:44:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:44:05 INFO - (blobuploader) - INFO - Open directory for files ... 04:44:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:44:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:06 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:44:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:06 INFO - (blobuploader) - INFO - Done attempting. 04:44:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:44:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:44:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:07 INFO - (blobuploader) - INFO - Done attempting. 04:44:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:44:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:44:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:44:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:44:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:44:10 INFO - (blobuploader) - INFO - Done attempting. 04:44:10 INFO - (blobuploader) - INFO - Iteration through files over. 04:44:10 INFO - Return code: 0 04:44:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:44:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:44:10 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0948b69214bfb8f321fb781c8e3f26ea8d9fec5ec29bec44640c78ae98b6d0141c595b618fa54dfe4f2055069e584b6320d95cc09fa5b618ec85745d0e46ae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc10ddaba4730e2a7d80d7bc7603d3e122df24f060c1658d3ea68556fae3a292cba3ab7cdab535ae975b5de4b189285957f3b86c330b05f52261f291bc1cab1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e4fb4f4076a157cadf54384786f39f4c72d74bd6564702e041120a60e3f092cfcdb828560c2464c456fae6323259c0feaa62544145c32001a314b1c50a8c5ef"} 04:44:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:44:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:44:10 INFO - Contents: 04:44:10 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0948b69214bfb8f321fb781c8e3f26ea8d9fec5ec29bec44640c78ae98b6d0141c595b618fa54dfe4f2055069e584b6320d95cc09fa5b618ec85745d0e46ae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc10ddaba4730e2a7d80d7bc7603d3e122df24f060c1658d3ea68556fae3a292cba3ab7cdab535ae975b5de4b189285957f3b86c330b05f52261f291bc1cab1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e4fb4f4076a157cadf54384786f39f4c72d74bd6564702e041120a60e3f092cfcdb828560c2464c456fae6323259c0feaa62544145c32001a314b1c50a8c5ef"} 04:44:10 INFO - Running post-run listener: copy_logs_to_upload_dir 04:44:10 INFO - Copying logs to upload dir... 04:44:10 INFO - mkdir: /builds/slave/test/build/upload/logs 04:44:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1229.857090 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 29 secs) (at 2016-07-13 04:44:09.875335) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 04:44:09.878425) ========= 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=920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0948b69214bfb8f321fb781c8e3f26ea8d9fec5ec29bec44640c78ae98b6d0141c595b618fa54dfe4f2055069e584b6320d95cc09fa5b618ec85745d0e46ae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc10ddaba4730e2a7d80d7bc7603d3e122df24f060c1658d3ea68556fae3a292cba3ab7cdab535ae975b5de4b189285957f3b86c330b05f52261f291bc1cab1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e4fb4f4076a157cadf54384786f39f4c72d74bd6564702e041120a60e3f092cfcdb828560c2464c456fae6323259c0feaa62544145c32001a314b1c50a8c5ef"} build_url:https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011421 build_url: 'https://queue.taskcluster.net/v1/task/R0N9GwGHSG63UWLjQVPpzw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/d0948b69214bfb8f321fb781c8e3f26ea8d9fec5ec29bec44640c78ae98b6d0141c595b618fa54dfe4f2055069e584b6320d95cc09fa5b618ec85745d0e46ae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/fc10ddaba4730e2a7d80d7bc7603d3e122df24f060c1658d3ea68556fae3a292cba3ab7cdab535ae975b5de4b189285957f3b86c330b05f52261f291bc1cab1b", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/4e4fb4f4076a157cadf54384786f39f4c72d74bd6564702e041120a60e3f092cfcdb828560c2464c456fae6323259c0feaa62544145c32001a314b1c50a8c5ef"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-13 04:44:09.903273) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:44:09.903584) ========= 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=920470bf432669ad7e3a5387000001ca-1468409018.445285-1663999032 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004550 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-13 04:44:09.986486) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 04:44:09.986775) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-13 04:44:09.987043) ========= ========= Total master_lag: 0.15 =========