builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-031 starttime: 1472164279.64 results: success (0) buildid: 20160825135616 builduid: dfe1a73052ec45b6828d3763bf6d2938 revision: e0ae32fee1553090d7a85cdb756de4ee7ebb274c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:19.640569) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:19.641567) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:19.642298) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:19.658198) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:19.658804) ========= 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=db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-25 15:31:19-- 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% 45.8M=0s 2016-08-25 15:31:20 (45.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.154072 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:19.831510) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:19.832227) ========= 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=db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017002 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:19.884578) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:19.885378) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev e0ae32fee1553090d7a85cdb756de4ee7ebb274c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev e0ae32fee1553090d7a85cdb756de4ee7ebb274c --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=db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-25 15:31:20,208 truncating revision to first 12 chars 2016-08-25 15:31:20,208 Setting DEBUG logging. 2016-08-25 15:31:20,209 attempt 1/10 2016-08-25 15:31:20,209 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/e0ae32fee155?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-25 15:31:20,845 unpacking tar archive at: autoland-e0ae32fee155/testing/mozharness/ program finished with exit code 0 elapsedTime=0.933512 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:20.834481) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:20.834865) ========= script_repo_revision: e0ae32fee1553090d7a85cdb756de4ee7ebb274c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:20.835350) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:20.835658) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-25 15:31:20.844808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-25 15:31:20.845242) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:31:21 INFO - MultiFileLogger online at 20160825 15:31:21 in /builds/slave/test 15:31:21 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 15:31:21 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:31:21 INFO - {'append_to_log': False, 15:31:21 INFO - 'base_work_dir': '/builds/slave/test', 15:31:21 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 15:31:21 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:31:21 INFO - 'branch': 'Autoland-Non-PGO', 15:31:21 INFO - 'buildbot_json_path': 'buildprops.json', 15:31:21 INFO - 'config_files': ('talos/linux_config.py',), 15:31:21 INFO - 'default_actions': ('clobber', 15:31:21 INFO - 'read-buildbot-config', 15:31:21 INFO - 'download-and-extract', 15:31:21 INFO - 'populate-webroot', 15:31:21 INFO - 'create-virtualenv', 15:31:21 INFO - 'install', 15:31:21 INFO - 'run-tests'), 15:31:21 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:31:21 INFO - 'download_minidump_stackwalk': True, 15:31:21 INFO - 'download_symbols': 'ondemand', 15:31:21 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:31:21 INFO - 'tooltool.py': '/tools/tooltool.py', 15:31:21 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:31:21 INFO - '/tools/misc-python/virtualenv.py')}, 15:31:21 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:31:21 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:31:21 INFO - 'installer_path': 'installer.exe', 15:31:21 INFO - 'log_level': 'info', 15:31:21 INFO - 'log_name': 'talos', 15:31:21 INFO - 'log_to_console': True, 15:31:21 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:31:21 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:31:21 INFO - 'opt_config_files': (), 15:31:21 INFO - 'pip_index': False, 15:31:21 INFO - 'sps_profile': False, 15:31:21 INFO - 'sps_profile_interval': 0, 15:31:21 INFO - 'suite': 'dromaeojs', 15:31:21 INFO - 'system_bits': '32', 15:31:21 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:31:21 INFO - 'title': 'talos-linux64-ix-031', 15:31:21 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:31:21 INFO - 'use_talos_json': True, 15:31:21 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:31:21 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:31:21 INFO - 'work_dir': 'build'} 15:31:21 INFO - [mozharness: 2016-08-25 22:31:21.262556Z] Running clobber step. 15:31:21 INFO - Running pre-action listener: _resource_record_pre_action 15:31:21 INFO - Running main action method: clobber 15:31:21 INFO - rmtree: /builds/slave/test/build 15:31:21 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:31:22 INFO - Running post-action listener: _resource_record_post_action 15:31:22 INFO - [mozharness: 2016-08-25 22:31:22.217735Z] Finished clobber step (success) 15:31:22 INFO - [mozharness: 2016-08-25 22:31:22.217835Z] Running read-buildbot-config step. 15:31:22 INFO - Running pre-action listener: _resource_record_pre_action 15:31:22 INFO - Running main action method: read_buildbot_config 15:31:22 INFO - Using buildbot properties: 15:31:22 INFO - { 15:31:22 INFO - "project": "", 15:31:22 INFO - "product": "firefox", 15:31:22 INFO - "script_repo_revision": "production", 15:31:22 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 15:31:22 INFO - "repository": "", 15:31:22 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 15:31:22 INFO - "buildid": "20160825135616", 15:31:22 INFO - "pgo_build": "False", 15:31:22 INFO - "basedir": "/builds/slave/test", 15:31:22 INFO - "buildnumber": 510, 15:31:22 INFO - "slavename": "talos-linux64-ix-031", 15:31:22 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 15:31:22 INFO - "platform": "ubuntu64_hw", 15:31:22 INFO - "scheduler": "tests-autoland-linux64-talos", 15:31:22 INFO - "branch": "autoland", 15:31:22 INFO - "repo_path": "integration/autoland", 15:31:22 INFO - "revision": "e0ae32fee1553090d7a85cdb756de4ee7ebb274c", 15:31:22 INFO - "stage_platform": "linux64", 15:31:22 INFO - "builduid": "dfe1a73052ec45b6828d3763bf6d2938", 15:31:22 INFO - "slavebuilddir": "test" 15:31:22 INFO - } 15:31:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 15:31:22 INFO - Running post-action listener: _resource_record_post_action 15:31:22 INFO - [mozharness: 2016-08-25 22:31:22.220264Z] Finished read-buildbot-config step (success) 15:31:22 INFO - [mozharness: 2016-08-25 22:31:22.220353Z] Running download-and-extract step. 15:31:22 INFO - Running pre-action listener: _resource_record_pre_action 15:31:22 INFO - Running main action method: download_and_extract 15:31:22 INFO - mkdir: /builds/slave/test/build/tests 15:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:22 INFO - trying https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:31:22 INFO - Downloading https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 15:31:22 INFO - Downloaded 1361 bytes. 15:31:22 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 15:31:22 INFO - Using the following test package requirements: 15:31:22 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:31:22 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:31:22 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:31:22 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:22 INFO - u'jsshell-linux-x86_64.zip'], 15:31:22 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:31:22 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 15:31:22 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:31:22 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:31:22 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:31:22 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 15:31:22 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:31:22 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:31:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:22 INFO - trying https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:31:22 INFO - Downloading https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:31:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:31:23 INFO - Downloaded 20326926 bytes. 15:31:23 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 15:31:27 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 15:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:27 INFO - trying https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:31:27 INFO - Downloading https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 15:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 15:31:28 INFO - Downloaded 20326926 bytes. 15:31:28 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/tests 15:31:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:33 INFO - trying https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:31:33 INFO - Downloading https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 15:31:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 15:31:34 INFO - Downloaded 14413998 bytes. 15:31:34 INFO - Using ZipFile to extract /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/tests 15:31:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:34 INFO - trying https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:31:34 INFO - Downloading https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:31:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 15:31:35 INFO - Downloaded 55754742 bytes. 15:31:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:31:35 INFO - mkdir: /builds/slave/test/properties 15:31:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:31:35 INFO - Writing to file /builds/slave/test/properties/build_url 15:31:35 INFO - Contents: 15:31:35 INFO - build_url:https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 15:31:36 INFO - Running post-action listener: _resource_record_post_action 15:31:36 INFO - Running post-action listener: set_extra_try_arguments 15:31:36 INFO - [mozharness: 2016-08-25 22:31:36.183587Z] Finished download-and-extract step (success) 15:31:36 INFO - [mozharness: 2016-08-25 22:31:36.183882Z] Running populate-webroot step. 15:31:36 INFO - Running pre-action listener: _resource_record_pre_action 15:31:36 INFO - Running main action method: populate_webroot 15:31:36 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:31:36 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:31:36 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:31:36 INFO - '--tppagecycles', 15:31:36 INFO - '7'], 15:31:36 INFO - 'tests': ['tsvgm']}}, 15:31:36 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:31:36 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:31:36 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:31:36 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:31:36 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:31:36 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:31:36 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'talos_options': ['--disable-e10s'], 15:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:36 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:31:36 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'talos_options': ['--disable-e10s'], 15:31:36 INFO - 'tests': ['damp', 'tps']}, 15:31:36 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'tests': ['damp', 'tps']}, 15:31:36 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:31:36 INFO - 'tests': ['dromaeo_dom']}, 15:31:36 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:31:36 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:31:36 INFO - 'tests': ['basic_compositor_video']}, 15:31:36 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:31:36 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:31:36 INFO - 'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore', 15:31:36 INFO - 'tabpaint']}, 15:31:36 INFO - 'other-e10s': {'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore', 15:31:36 INFO - 'tabpaint']}, 15:31:36 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore', 15:31:36 INFO - 'tabpaint']}, 15:31:36 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore', 15:31:36 INFO - 'tabpaint']}, 15:31:36 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:31:36 INFO - 'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore', 15:31:36 INFO - 'tabpaint']}, 15:31:36 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:31:36 INFO - 'tests': ['a11yr', 15:31:36 INFO - 'ts_paint', 15:31:36 INFO - 'tpaint', 15:31:36 INFO - 'sessionrestore', 15:31:36 INFO - 'sessionrestore_no_auto_restore', 15:31:36 INFO - 'tabpaint']}, 15:31:36 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:31:36 INFO - 'tests': ['tsvgx', 15:31:36 INFO - 'tsvgr_opacity', 15:31:36 INFO - 'tart', 15:31:36 INFO - 'tscrollx', 15:31:36 INFO - 'cart']}, 15:31:36 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:31:36 INFO - 'tsvgr_opacity', 15:31:36 INFO - 'tart', 15:31:36 INFO - 'tscrollx', 15:31:36 INFO - 'cart']}, 15:31:36 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'talos_options': ['--disable-e10s'], 15:31:36 INFO - 'tests': ['tp5o']}, 15:31:36 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'tests': ['tp5o']}, 15:31:36 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'talos_options': ['--disable-e10s', 15:31:36 INFO - '--xperf_path', 15:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:36 INFO - 'tests': ['tp5n']}, 15:31:36 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:31:36 INFO - 'talos_options': ['--xperf_path', 15:31:36 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:31:36 INFO - 'tests': ['tp5n']}}, 15:31:36 INFO - 'talos.zip': {'path': '', 15:31:36 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:31:36 INFO - Running post-action listener: _resource_record_post_action 15:31:36 INFO - [mozharness: 2016-08-25 22:31:36.205323Z] Finished populate-webroot step (success) 15:31:36 INFO - [mozharness: 2016-08-25 22:31:36.205416Z] Running create-virtualenv step. 15:31:36 INFO - Running pre-action listener: _resource_record_pre_action 15:31:36 INFO - Running main action method: create_virtualenv 15:31:36 INFO - Creating virtualenv /builds/slave/test/build/venv 15:31:36 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 15:31:36 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:31:36 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:31:36 INFO - Using real prefix '/usr' 15:31:36 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:31:36 INFO - Installing distribute.............................................................................................................................................................................................done. 15:31:38 INFO - Installing pip.................done. 15:31:38 INFO - Return code: 0 15:31:38 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:38 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 0x7f6ba678ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9090>, '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 0xedc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedce40>, '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': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', '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 15:31:38 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 15:31:38 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 15:31:38 INFO - Using env: {'DISPLAY': ':0', 15:31:38 INFO - 'HOME': '/home/cltbld', 15:31:38 INFO - 'LANG': 'en_US.UTF-8', 15:31:38 INFO - 'LANGUAGE': 'en_US:en', 15:31:38 INFO - 'LOGNAME': 'cltbld', 15:31:38 INFO - 'MAIL': '/var/mail/cltbld', 15:31:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:38 INFO - 'MOZ_NO_REMOTE': '1', 15:31:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:38 INFO - 'NO_EM_RESTART': '1', 15:31:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:38 INFO - 'PWD': '/builds/slave/test', 15:31:38 INFO - 'SHELL': '/bin/bash', 15:31:38 INFO - 'SHLVL': '1', 15:31:38 INFO - 'TERM': 'linux', 15:31:38 INFO - 'TMOUT': '86400', 15:31:38 INFO - 'USER': 'cltbld', 15:31:38 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', 15:31:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:38 INFO - '_': '/tools/buildbot/bin/python'} 15:31:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:38 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 15:31:38 INFO - Cleaning up... 15:31:38 INFO - Return code: 0 15:31:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:38 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 0x7f6ba678ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9090>, '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 0xedc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedce40>, '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': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', '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 15:31:38 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 15:31:38 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 15:31:39 INFO - Using env: {'DISPLAY': ':0', 15:31:39 INFO - 'HOME': '/home/cltbld', 15:31:39 INFO - 'LANG': 'en_US.UTF-8', 15:31:39 INFO - 'LANGUAGE': 'en_US:en', 15:31:39 INFO - 'LOGNAME': 'cltbld', 15:31:39 INFO - 'MAIL': '/var/mail/cltbld', 15:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:39 INFO - 'MOZ_NO_REMOTE': '1', 15:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:39 INFO - 'NO_EM_RESTART': '1', 15:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:39 INFO - 'PWD': '/builds/slave/test', 15:31:39 INFO - 'SHELL': '/bin/bash', 15:31:39 INFO - 'SHLVL': '1', 15:31:39 INFO - 'TERM': 'linux', 15:31:39 INFO - 'TMOUT': '86400', 15:31:39 INFO - 'USER': 'cltbld', 15:31:39 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', 15:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:39 INFO - '_': '/tools/buildbot/bin/python'} 15:31:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:39 INFO - Downloading/unpacking psutil>=3.1.1 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:39 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 15:31:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:41 INFO - Installing collected packages: psutil 15:31:41 INFO - Running setup.py install for psutil 15:31:41 INFO - building 'psutil._psutil_linux' extension 15:31:41 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 15:31:41 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 15:31:41 INFO - building 'psutil._psutil_posix' extension 15:31:41 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 15:31:41 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 15:31:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:31:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:31:41 INFO - Successfully installed psutil 15:31:41 INFO - Cleaning up... 15:31:41 INFO - Return code: 0 15:31:41 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:41 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 0x7f6ba678ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9090>, '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 0xedc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedce40>, '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': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', '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 15:31:41 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 15:31:41 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 15:31:41 INFO - Using env: {'DISPLAY': ':0', 15:31:41 INFO - 'HOME': '/home/cltbld', 15:31:41 INFO - 'LANG': 'en_US.UTF-8', 15:31:41 INFO - 'LANGUAGE': 'en_US:en', 15:31:41 INFO - 'LOGNAME': 'cltbld', 15:31:41 INFO - 'MAIL': '/var/mail/cltbld', 15:31:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:41 INFO - 'MOZ_NO_REMOTE': '1', 15:31:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:41 INFO - 'NO_EM_RESTART': '1', 15:31:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:41 INFO - 'PWD': '/builds/slave/test', 15:31:41 INFO - 'SHELL': '/bin/bash', 15:31:41 INFO - 'SHLVL': '1', 15:31:41 INFO - 'TERM': 'linux', 15:31:41 INFO - 'TMOUT': '86400', 15:31:41 INFO - 'USER': 'cltbld', 15:31:41 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', 15:31:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:41 INFO - '_': '/tools/buildbot/bin/python'} 15:31:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:31:41 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 15:31:41 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 15:31:41 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 15:31:41 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 15:31:41 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 15:31:41 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 15:31:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:31:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:31:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:31:43 INFO - Installing collected packages: mozsystemmonitor 15:31:43 INFO - Running setup.py install for mozsystemmonitor 15:31:43 INFO - Successfully installed mozsystemmonitor 15:31:43 INFO - Cleaning up... 15:31:44 INFO - Return code: 0 15:31:44 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:44 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6ba678ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9090>, '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 0xedc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedce40>, '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': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', '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 15:31:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:31:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:31:44 INFO - Using env: {'DISPLAY': ':0', 15:31:44 INFO - 'HOME': '/home/cltbld', 15:31:44 INFO - 'LANG': 'en_US.UTF-8', 15:31:44 INFO - 'LANGUAGE': 'en_US:en', 15:31:44 INFO - 'LOGNAME': 'cltbld', 15:31:44 INFO - 'MAIL': '/var/mail/cltbld', 15:31:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:44 INFO - 'MOZ_NO_REMOTE': '1', 15:31:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:44 INFO - 'NO_EM_RESTART': '1', 15:31:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:44 INFO - 'PWD': '/builds/slave/test', 15:31:44 INFO - 'SHELL': '/bin/bash', 15:31:44 INFO - 'SHLVL': '1', 15:31:44 INFO - 'TERM': 'linux', 15:31:44 INFO - 'TMOUT': '86400', 15:31:44 INFO - 'USER': 'cltbld', 15:31:44 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', 15:31:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:44 INFO - '_': '/tools/buildbot/bin/python'} 15:31:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:44 INFO - Downloading/unpacking jsonschema==2.5.1 15:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:31:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:31:46 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 15:31:46 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 15:31:46 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 15:31:46 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 15:31:46 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 15:31:46 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 15:31:46 INFO - Downloading functools32-3.2.3-2.tar.gz 15:31:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:31:46 INFO - warning: no files found matching '*.txt' 15:31:46 INFO - no previously-included directories found matching 'build' 15:31:46 INFO - no previously-included directories found matching 'dist' 15:31:46 INFO - no previously-included directories found matching '.git*' 15:31:46 INFO - Installing collected packages: jsonschema, functools32 15:31:46 INFO - Running setup.py install for functools32 15:31:46 INFO - warning: no files found matching '*.txt' 15:31:46 INFO - no previously-included directories found matching 'build' 15:31:46 INFO - no previously-included directories found matching 'dist' 15:31:46 INFO - no previously-included directories found matching '.git*' 15:31:46 INFO - Successfully installed jsonschema functools32 15:31:46 INFO - Cleaning up... 15:31:46 INFO - Return code: 0 15:31:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 15:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f6ba678ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9090>, '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 0xedc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedce40>, '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': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', '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 15:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 15:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 15:31:46 INFO - Using env: {'DISPLAY': ':0', 15:31:46 INFO - 'HOME': '/home/cltbld', 15:31:46 INFO - 'LANG': 'en_US.UTF-8', 15:31:46 INFO - 'LANGUAGE': 'en_US:en', 15:31:46 INFO - 'LOGNAME': 'cltbld', 15:31:46 INFO - 'MAIL': '/var/mail/cltbld', 15:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:46 INFO - 'MOZ_NO_REMOTE': '1', 15:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:46 INFO - 'NO_EM_RESTART': '1', 15:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:46 INFO - 'PWD': '/builds/slave/test', 15:31:46 INFO - 'SHELL': '/bin/bash', 15:31:46 INFO - 'SHLVL': '1', 15:31:46 INFO - 'TERM': 'linux', 15:31:46 INFO - 'TMOUT': '86400', 15:31:46 INFO - 'USER': 'cltbld', 15:31:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', 15:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:46 INFO - '_': '/tools/buildbot/bin/python'} 15:31:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 15:31:46 INFO - Cleaning up... 15:31:46 INFO - Return code: 0 15:31:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f6ba678ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9090>, '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 0xedc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedce40>, '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': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', '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 15:31:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 15:31:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 15:31:46 INFO - Using env: {'DISPLAY': ':0', 15:31:46 INFO - 'HOME': '/home/cltbld', 15:31:46 INFO - 'LANG': 'en_US.UTF-8', 15:31:46 INFO - 'LANGUAGE': 'en_US:en', 15:31:46 INFO - 'LOGNAME': 'cltbld', 15:31:46 INFO - 'MAIL': '/var/mail/cltbld', 15:31:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:46 INFO - 'MOZ_NO_REMOTE': '1', 15:31:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:46 INFO - 'NO_EM_RESTART': '1', 15:31:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:46 INFO - 'PWD': '/builds/slave/test', 15:31:46 INFO - 'SHELL': '/bin/bash', 15:31:46 INFO - 'SHLVL': '1', 15:31:46 INFO - 'TERM': 'linux', 15:31:46 INFO - 'TMOUT': '86400', 15:31:46 INFO - 'USER': 'cltbld', 15:31:46 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', 15:31:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:46 INFO - '_': '/tools/buildbot/bin/python'} 15:31:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:47 INFO - Downloading/unpacking blobuploader==1.2.4 15:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:48 INFO - Downloading blobuploader-1.2.4.tar.gz 15:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:31:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:31:48 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 15:31:48 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 15:31:48 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 15:31:48 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 15:31:48 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 15:31:48 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 15:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:31:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:31:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:31:49 INFO - Downloading docopt-0.6.1.tar.gz 15:31:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:31:49 INFO - Installing collected packages: blobuploader, requests, docopt 15:31:49 INFO - Running setup.py install for blobuploader 15:31:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:31:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:31:49 INFO - Running setup.py install for requests 15:31:50 INFO - Running setup.py install for docopt 15:31:50 INFO - Successfully installed blobuploader requests docopt 15:31:50 INFO - Cleaning up... 15:31:50 INFO - Return code: 0 15:31:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:50 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 0x7f6ba678ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9090>, '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 0xedc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedce40>, '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': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', '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 15:31:50 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 15:31:50 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 15:31:50 INFO - Using env: {'DISPLAY': ':0', 15:31:50 INFO - 'HOME': '/home/cltbld', 15:31:50 INFO - 'LANG': 'en_US.UTF-8', 15:31:50 INFO - 'LANGUAGE': 'en_US:en', 15:31:50 INFO - 'LOGNAME': 'cltbld', 15:31:50 INFO - 'MAIL': '/var/mail/cltbld', 15:31:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:50 INFO - 'MOZ_NO_REMOTE': '1', 15:31:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:50 INFO - 'NO_EM_RESTART': '1', 15:31:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:50 INFO - 'PWD': '/builds/slave/test', 15:31:50 INFO - 'SHELL': '/bin/bash', 15:31:50 INFO - 'SHLVL': '1', 15:31:50 INFO - 'TERM': 'linux', 15:31:50 INFO - 'TMOUT': '86400', 15:31:50 INFO - 'USER': 'cltbld', 15:31:50 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', 15:31:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:50 INFO - '_': '/tools/buildbot/bin/python'} 15:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:50 INFO - Running setup.py (path:/tmp/pip-CJ2cPo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:50 INFO - Running setup.py (path:/tmp/pip-DDVmmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:50 INFO - Running setup.py (path:/tmp/pip-i8rWC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:50 INFO - Running setup.py (path:/tmp/pip-WS6CId-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:50 INFO - Running setup.py (path:/tmp/pip-ttSbU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:50 INFO - Running setup.py (path:/tmp/pip-uCfKtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:50 INFO - Running setup.py (path:/tmp/pip-CjXYtS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:50 INFO - Running setup.py (path:/tmp/pip-V4syl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:51 INFO - Running setup.py (path:/tmp/pip-Obca5V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:51 INFO - Running setup.py (path:/tmp/pip-4yZEEa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:51 INFO - Running setup.py (path:/tmp/pip-WuZ5eL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:51 INFO - Running setup.py (path:/tmp/pip-bQCA2q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:51 INFO - Running setup.py (path:/tmp/pip-lwDkaK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:51 INFO - Running setup.py (path:/tmp/pip-f1QE_g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:51 INFO - Running setup.py (path:/tmp/pip-TiQcMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:51 INFO - Running setup.py (path:/tmp/pip-6zYc9E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:51 INFO - Running setup.py (path:/tmp/pip-ydftgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:31:51 INFO - Running setup.py install for manifestparser 15:31:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:31:51 INFO - Running setup.py install for mozcrash 15:31:51 INFO - Running setup.py install for mozdebug 15:31:51 INFO - Running setup.py install for mozdevice 15:31:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:31:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:31:52 INFO - Running setup.py install for mozfile 15:31:52 INFO - Running setup.py install for mozhttpd 15:31:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:31:52 INFO - Running setup.py install for mozinfo 15:31:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:31:52 INFO - Running setup.py install for mozInstall 15:31:52 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:31:52 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:31:52 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:31:52 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:31:52 INFO - Running setup.py install for mozleak 15:31:52 INFO - Running setup.py install for mozlog 15:31:52 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:31:52 INFO - Running setup.py install for moznetwork 15:31:52 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:31:52 INFO - Running setup.py install for mozprocess 15:31:52 INFO - Running setup.py install for mozprofile 15:31:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:31:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:31:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:31:53 INFO - Running setup.py install for mozrunner 15:31:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:31:53 INFO - Running setup.py install for mozscreenshot 15:31:53 INFO - Running setup.py install for moztest 15:31:53 INFO - Running setup.py install for mozversion 15:31:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:31:53 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:31:53 INFO - Cleaning up... 15:31:53 INFO - Return code: 0 15:31:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:53 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 0x7f6ba678ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9090>, '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 0xedc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedce40>, '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': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', '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 15:31:53 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 15:31:53 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 15:31:53 INFO - Using env: {'DISPLAY': ':0', 15:31:53 INFO - 'HOME': '/home/cltbld', 15:31:53 INFO - 'LANG': 'en_US.UTF-8', 15:31:53 INFO - 'LANGUAGE': 'en_US:en', 15:31:53 INFO - 'LOGNAME': 'cltbld', 15:31:53 INFO - 'MAIL': '/var/mail/cltbld', 15:31:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:53 INFO - 'MOZ_NO_REMOTE': '1', 15:31:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:53 INFO - 'NO_EM_RESTART': '1', 15:31:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:53 INFO - 'PWD': '/builds/slave/test', 15:31:53 INFO - 'SHELL': '/bin/bash', 15:31:53 INFO - 'SHLVL': '1', 15:31:53 INFO - 'TERM': 'linux', 15:31:53 INFO - 'TMOUT': '86400', 15:31:53 INFO - 'USER': 'cltbld', 15:31:53 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', 15:31:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:53 INFO - '_': '/tools/buildbot/bin/python'} 15:31:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:31:53 INFO - Running setup.py (path:/tmp/pip-bfyyzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:31:53 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)) 15:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:31:53 INFO - Running setup.py (path:/tmp/pip-fUTenv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:31:53 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)) 15:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:31:53 INFO - Running setup.py (path:/tmp/pip-uJ892d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:31:53 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)) 15:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:31:53 INFO - Running setup.py (path:/tmp/pip-ff1gwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:31:53 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)) 15:31:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:31:53 INFO - Running setup.py (path:/tmp/pip-d3rRMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:31:54 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)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:31:54 INFO - Running setup.py (path:/tmp/pip-jWxab6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:31:54 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)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:31:54 INFO - Running setup.py (path:/tmp/pip-3ivRbW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:31:54 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)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:31:54 INFO - Running setup.py (path:/tmp/pip-AOW0gK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:31:54 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)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:31:54 INFO - Running setup.py (path:/tmp/pip-U5pTdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:31:54 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)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:31:54 INFO - Running setup.py (path:/tmp/pip-IQTusI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:31:54 INFO - Running setup.py (path:/tmp/pip-8yixVL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:31:54 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)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:31:54 INFO - Running setup.py (path:/tmp/pip-TFsShj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:31:54 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)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:31:54 INFO - Running setup.py (path:/tmp/pip-8PRlcd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:31:54 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)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:31:54 INFO - Running setup.py (path:/tmp/pip-efTSdg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:31:54 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)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:54 INFO - Running setup.py (path:/tmp/pip-sDaZ21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:31:54 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)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:31:54 INFO - Running setup.py (path:/tmp/pip-z5eArR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:31:54 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)) 15:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:31:54 INFO - Running setup.py (path:/tmp/pip-jN_i0y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:31:54 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)) 15:31:54 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)) 15:31:54 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)) 15:31:54 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)) 15:31:54 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)) 15:31:54 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)) 15:31:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31: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 15:31:56 INFO - Downloading blessings-1.6.tar.gz 15:31:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:31:56 INFO - Installing collected packages: blessings 15:31:56 INFO - Running setup.py install for blessings 15:31:57 INFO - Successfully installed blessings 15:31:57 INFO - Cleaning up... 15:31:57 INFO - Return code: 0 15:31:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:57 INFO - Reading from file tmpfile_stdout 15:31:57 INFO - Current package versions: 15:31:57 INFO - argparse == 1.2.1 15:31:57 INFO - blessings == 1.6 15:31:57 INFO - blobuploader == 1.2.4 15:31:57 INFO - docopt == 0.6.1 15:31:57 INFO - functools32 == 3.2.3-2 15:31:57 INFO - jsonschema == 2.5.1 15:31:57 INFO - manifestparser == 1.1 15:31:57 INFO - mozInstall == 1.12 15:31:57 INFO - mozcrash == 0.17 15:31:57 INFO - mozdebug == 0.1 15:31:57 INFO - mozdevice == 0.48 15:31:57 INFO - mozfile == 1.2 15:31:57 INFO - mozhttpd == 0.7 15:31:57 INFO - mozinfo == 0.9 15:31:57 INFO - mozleak == 0.1 15:31:57 INFO - mozlog == 3.3 15:31:57 INFO - moznetwork == 0.27 15:31:57 INFO - mozprocess == 0.23 15:31:57 INFO - mozprofile == 0.28 15:31:57 INFO - mozrunner == 6.12 15:31:57 INFO - mozscreenshot == 0.1 15:31:57 INFO - mozsystemmonitor == 0.3 15:31:57 INFO - moztest == 0.7 15:31:57 INFO - mozversion == 1.4 15:31:57 INFO - psutil == 3.1.1 15:31:57 INFO - requests == 1.2.3 15:31:57 INFO - wsgiref == 0.1.2 15:31:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:57 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 0x7f6ba678ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9090>, '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 0xedc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedce40>, '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': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', '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 15:31:57 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 15:31:57 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 15:31:57 INFO - Using env: {'DISPLAY': ':0', 15:31:57 INFO - 'HOME': '/home/cltbld', 15:31:57 INFO - 'LANG': 'en_US.UTF-8', 15:31:57 INFO - 'LANGUAGE': 'en_US:en', 15:31:57 INFO - 'LOGNAME': 'cltbld', 15:31:57 INFO - 'MAIL': '/var/mail/cltbld', 15:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:57 INFO - 'MOZ_NO_REMOTE': '1', 15:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:57 INFO - 'NO_EM_RESTART': '1', 15:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:57 INFO - 'PWD': '/builds/slave/test', 15:31:57 INFO - 'SHELL': '/bin/bash', 15:31:57 INFO - 'SHLVL': '1', 15:31:57 INFO - 'TERM': 'linux', 15:31:57 INFO - 'TMOUT': '86400', 15:31:57 INFO - 'USER': 'cltbld', 15:31:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', 15:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:57 INFO - '_': '/tools/buildbot/bin/python'} 15:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:57 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)) 15:31:57 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)) 15:31:57 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)) 15:31:57 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)) 15:31:57 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)) 15:31:57 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)) 15:31:57 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)) 15:31:57 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)) 15:31:57 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)) 15:31:57 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)) 15:31:57 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)) 15:31:57 INFO - Cleaning up... 15:31:57 INFO - Return code: 0 15:31:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:31:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:31:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:31:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:31:57 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 0x7f6ba678ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe108a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xedf230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xed9090>, '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 0xedc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedce40>, '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': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', '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 15:31:57 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 15:31:57 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 15:31:57 INFO - Using env: {'DISPLAY': ':0', 15:31:57 INFO - 'HOME': '/home/cltbld', 15:31:57 INFO - 'LANG': 'en_US.UTF-8', 15:31:57 INFO - 'LANGUAGE': 'en_US:en', 15:31:57 INFO - 'LOGNAME': 'cltbld', 15:31:57 INFO - 'MAIL': '/var/mail/cltbld', 15:31:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:31:57 INFO - 'MOZ_NO_REMOTE': '1', 15:31:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:31:57 INFO - 'NO_EM_RESTART': '1', 15:31:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:31:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:31:57 INFO - 'PWD': '/builds/slave/test', 15:31:57 INFO - 'SHELL': '/bin/bash', 15:31:57 INFO - 'SHLVL': '1', 15:31:57 INFO - 'TERM': 'linux', 15:31:57 INFO - 'TMOUT': '86400', 15:31:57 INFO - 'USER': 'cltbld', 15:31:57 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', 15:31:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:31:57 INFO - '_': '/tools/buildbot/bin/python'} 15:31:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:31:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:31:57 INFO - Cleaning up... 15:31:57 INFO - Return code: 0 15:31:57 INFO - Running post-action listener: _resource_record_post_action 15:31:57 INFO - Running post-action listener: _start_resource_monitoring 15:31:57 INFO - Starting resource monitoring. 15:31:57 INFO - [mozharness: 2016-08-25 22:31:57.764976Z] Finished create-virtualenv step (success) 15:31:57 INFO - [mozharness: 2016-08-25 22:31:57.765475Z] Running install step. 15:31:57 INFO - Running pre-action listener: _resource_record_pre_action 15:31:57 INFO - Running main action method: install 15:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:31:57 INFO - Reading from file tmpfile_stdout 15:31:57 INFO - Detecting whether we're running mozinstall >=1.0... 15:31:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:31:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:31:58 INFO - Reading from file tmpfile_stdout 15:31:58 INFO - Output received: 15:31:58 INFO - Usage: mozinstall [options] installer 15:31:58 INFO - Options: 15:31:58 INFO - -h, --help show this help message and exit 15:31:58 INFO - -d DEST, --destination=DEST 15:31:58 INFO - Directory to install application into. [default: 15:31:58 INFO - "/builds/slave/test"] 15:31:58 INFO - --app=APP Application being installed. [default: firefox] 15:31:58 INFO - mkdir: /builds/slave/test/build/application 15:31:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 15:31:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 15:32:14 INFO - Reading from file tmpfile_stdout 15:32:14 INFO - Output received: 15:32:14 INFO - /builds/slave/test/build/application/firefox/firefox 15:32:14 INFO - Running post-action listener: _resource_record_post_action 15:32:14 INFO - [mozharness: 2016-08-25 22:32:14.296879Z] Finished install step (success) 15:32:14 INFO - [mozharness: 2016-08-25 22:32:14.297129Z] Running run-tests step. 15:32:14 INFO - Running pre-action listener: _resource_record_pre_action 15:32:14 INFO - Running main action method: run_tests 15:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:32:14 INFO - Python 2.7.3 15:32:14 INFO - Return code: 0 15:32:14 INFO - grabbing minidump binary from tooltool 15:32:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 15:32:14 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 0xed9090>, '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 0xedc9b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xedce40>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:32:14 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 15:32:14 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 15:32:14 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 15:32:14 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:32:14 INFO - Return code: 0 15:32:14 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:32:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:32:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:32:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:32:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:32:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 15:32:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-031 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 15:32:14 INFO - Using env: {'DISPLAY': ':0', 15:32:14 INFO - 'HOME': '/home/cltbld', 15:32:14 INFO - 'LANG': 'en_US.UTF-8', 15:32:14 INFO - 'LANGUAGE': 'en_US:en', 15:32:14 INFO - 'LOGNAME': 'cltbld', 15:32:14 INFO - 'MAIL': '/var/mail/cltbld', 15:32:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:32:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:32:14 INFO - 'MOZ_NO_REMOTE': '1', 15:32:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:32:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:32:14 INFO - 'NO_EM_RESTART': '1', 15:32:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:32:14 INFO - 'PWD': '/builds/slave/test', 15:32:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:32:14 INFO - 'SHELL': '/bin/bash', 15:32:14 INFO - 'SHLVL': '1', 15:32:14 INFO - 'TERM': 'linux', 15:32:14 INFO - 'TMOUT': '86400', 15:32:14 INFO - 'USER': 'cltbld', 15:32:14 INFO - 'XDG_SESSION_COOKIE': 'db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866', 15:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:32:14 INFO - '_': '/tools/buildbot/bin/python'} 15:32:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-031', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 15:32:14 INFO - mozversion application_buildid: 20160825135616 15:32:14 INFO - mozversion application_changeset: e0ae32fee1553090d7a85cdb756de4ee7ebb274c 15:32:14 INFO - mozversion application_display_name: Nightly 15:32:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:32:14 INFO - mozversion application_name: Firefox 15:32:14 INFO - mozversion application_remotingname: firefox 15:32:14 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 15:32:14 INFO - mozversion application_vendor: Mozilla 15:32:14 INFO - mozversion application_version: 51.0a1 15:32:14 INFO - mozversion platform_buildid: 20160825135616 15:32:14 INFO - mozversion platform_changeset: e0ae32fee1553090d7a85cdb756de4ee7ebb274c 15:32:14 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 15:32:14 INFO - mozversion platform_version: 51.0a1 15:32:14 INFO - using testdate: 1472164334 15:32:14 INFO - actual date: 1472164334 15:32:14 INFO - starting webserver on 'localhost:51039' 15:32:14 INFO - SUITE-START | Running 2 tests 15:32:14 INFO - TEST-START | dromaeo_css 15:32:14 INFO - operating with platform_type : linux_ 15:32:14 INFO - Initialising browser for dromaeo_css test... 15:32:14 INFO - TEST-INFO | started process 29079 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdr1pUl/profile http://localhost:51039/getInfo.html) 15:32:19 INFO - PROCESS | 29079 | __metrics Screen width/height:1600/1200 15:32:19 INFO - PROCESS | 29079 | colorDepth:24 15:32:19 INFO - PROCESS | 29079 | Browser inner width/height: 1024/697 15:32:19 INFO - PROCESS | 29079 | __metrics 15:32:19 INFO - PROCESS | 29079 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:32:19 INFO - PROCESS | 29079 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:32:20 INFO - PROCESS | 29079 | console.error: PushService: 15:32:20 INFO - PROCESS | 29079 | stateChangeProcessEnqueue: Error transitioning state 15:32:20 INFO - PROCESS | 29079 | UnknownError 15:32:21 INFO - TEST-INFO | 29079: exit 0 15:32:21 INFO - Browser initialized. 15:32:21 INFO - Running cycle 1/1 for dromaeo_css test... 15:32:21 INFO - TEST-INFO | started process 29163 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdr1pUl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:32:33 INFO - PROCESS | 29163 | RSS: Main: 179556352 15:32:33 INFO - PROCESS | 29163 | 15:33:24 INFO - PROCESS | 29163 | 1472164404652 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] 15:35:38 INFO - PROCESS | 29163 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51039/tests/dromaeo/cssquery-ext.html) 15:35:39 INFO - PROCESS | 29163 | RSS: Main: 288219136 15:35:39 INFO - PROCESS | 29163 | 15:38:41 INFO - PROCESS | 29163 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-ext.html (next: http://localhost:51039/tests/dromaeo/cssquery-jquery.html) 15:38:42 INFO - PROCESS | 29163 | RSS: Main: 266719232 15:38:42 INFO - PROCESS | 29163 | 15:41:44 INFO - PROCESS | 29163 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51039/tests/dromaeo/cssquery-mootools.html) 15:41:45 INFO - PROCESS | 29163 | RSS: Main: 218447872 15:41:45 INFO - PROCESS | 29163 | 15:44:47 INFO - PROCESS | 29163 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51039/tests/dromaeo/cssquery-prototype.html) 15:44:48 INFO - PROCESS | 29163 | RSS: Main: 220233728 15:44:48 INFO - PROCESS | 29163 | 15:47:51 INFO - PROCESS | 29163 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51039/tests/dromaeo/cssquery-yui.html) 15:47:51 INFO - PROCESS | 29163 | RSS: Main: 222048256 15:47:51 INFO - PROCESS | 29163 | 15:50:54 INFO - PROCESS | 29163 | Cycle 1(1): loaded http://localhost:51039/tests/dromaeo/cssquery-yui.html (next: http://localhost:51039/tests/dromaeo/cssquery-dojo.html) 15:50:55 INFO - PROCESS | 29163 | RSS: Main: 303980544 15:50:55 INFO - PROCESS | 29163 | 15:50:55 INFO - PROCESS | 29163 | __start_tp_report 15:50:55 INFO - PROCESS | 29163 | _x_x_mozilla_page_load 15:50:55 INFO - PROCESS | 29163 | _x_x_mozilla_page_load_details 15:50:55 INFO - PROCESS | 29163 | |i|pagename|runs| 15:50:55 INFO - PROCESS | 29163 | |0;dojo.html;2581.1930365060084;2585.5992321190224;2588.7799537039355;2626.120249716345;2647.4308023774897;4597.908041839165;4619.122366750315;4673.813047478106;4698.929516057257;4740.099381117585;4727.8818029549275;4733.786979585919;4734.313524538939;4747;4756.9286460703115;4335.34969754537;4407.382966384709;4426.29179331307;4476.664250181233;4514.548545145492;4342.109867477176;4373.147236288925;4420.447444069491;4443;4514.142312960544;4334.739915605058;4472.396226509429;4502.144592527409;4511.503734589192;4518.254488009475;4396.538363471821;4443.266860967937;4475;4507.166174257773;4528.977355113237;4162.521310049323;4215.030542975102;4219.789010549491;4246.830126794925;4310.978445107786;4565.657575681837;4652.464966528859;4672.3925889634465;4730.787114579852;4733.124371991193;4939.135651261051;4969.503049695038;4985.326980857611;5058.772355244023;5076.213186956028;5090.541851233407;5093.465186155475;5103.108710169315;5107.642465027449;5162.948370516285;4560.247559152769;4681.438227412732;4686.859394218145;4696.506866779007;4697.859064228079;5141.074606570854;5181.171012637959;5183.688978661293;5185.585153187736;5250.18622113573;4937.432195297515;4958.851234462972;4984.102861484967;4984.526469985346;5038.5969122470115;4867.780949857265;5026.723530205801;5066.138756411346;5068.594512438996;5069.5944324454695;5058.671186372874;5073.543381095719;5075.162598171334;5116.590672746246;5126.5898728101665;5021.623378246646;5036.521530454601;5043.621728370387;5055.823046193439;5119.206522988943;4266.168097221012;4275.786210689515;4317.007088369693;4357.455318085239;4414.690971631955;3756.286305601927;3759.6052414496085;3808.7524310919703;3816.5229346331707;3826.559945606235;4379.430674012358;4388.758618276025;4389.341598760211;4391.407160033418;4440.045390241114;4928.236123400879;4982.850514484571;5099.23511473282;5119.846404607868;5176.50823171798;4300.311950087971;4326.913461730811;4346.369776382407;4389.188000219906;4397.142557201379;4532.6827122101795;4533.591976722111;4537.3647689323525;4577.22187228172;4585.12882552314;4663.370444989883;4761.35721677576;4772.5227477252;4775.164346239325;4786.377770889762;5111.233315002779;5116.360454943132;5144.742762861917;5204.479552044765;5208.140656791587;4836.806527738851;4844.394450693663;4850.248211527219;4853.878653033702;4905.950940490549;4834.661573689808;4965.8013679452415;5022.84931452057;5025.422076461254;5094.439611642642;5077.568406685473;5115.437301896863;5117.795288188579;5162.9483705162465;5172.224166374924;4960.528749768766;4967.081089998217;4971.850844474671;4974.801007959641;5000.299958005955;4775.5224477551965;4927.901441971068;4946.258061290835;4959.256111583291;5017.598592112695;4839.782209800638;4892.143874821821;4912.8771780705765;4945.876353091057;4980.203167493184;4996.375453068366;5028.34631497903;5033.471485494117;5038.874028149326;5108.489151084862;4742.715437073786;4785.473597904297;4913.336699545658;4936.7284799336385;4988.650794444354 15:50:55 INFO - PROCESS | 29163 | |1;ext.html;573.9655620662761;575.2406822993651;582.4670426559699;586.1383765864178;589.5578316262803;28597.142085737436;31568.210794730116;42613.14773704524;43306.56693433065;43445;39416.408753868716;39731.40402893959;39843.60156398435;39931.60068399315;39940.80029599848;7483.887741683892;7622.733204337849;7668.194839541851;7669.961650191742;7672.5012874163;7731.690732370726;7765.029371328584;7770.728024519143;7796.298333150015;7819.765407037798;7773.961130194341;7811.531308121503;7816.570088645122;7869.449138560303;7875.173106823787;7771.106322772869;7788.337991270749;7791.805204869867;7796.80507987302;7799.37604991605;7675.232476752336;7735.922640773577;7737.961310193469;7742.032245969254;7745.961270193613;37359.25281494382;37579.624203757885;37636.81181594102;37717.81141094277;37739.62260377389;2520.0675749972443;2548.8980440782348;2549.247971848309;2668.83986960781;2801.215659615311;25487.362815929566;25780.613290800655;25986.610200847;26078;26691.332716682045;3396.745244106702;3478.3565040467593;3535.063208249816;3557.3063252665743;3583.62371950944;253661;253795;253965;254337;254488;52707;52867.47132528702;52944.73527632337;52995;53061.2040819388;32395.676043239266;33491.162720932174;55929.44070559324;56171.71914140403;56268.43731562632;13243.404046817916;13486.527971520949;13493.527726529524;13512.797308040388;13530.391132399065;9980.650677226407;9981.151602113756;9984.900150998397;9992.10071093605;9992.950035249924;18270.634587308446;18301.816981830278;18314.542136446697;18323.90838045828;18391;6683.331666833375;6830.829229269209;6915.89626155608;6952.168243071017;7128.501004929605;782;897.8832751742232;912.1653686876434;942.783159873233;953.3469573342283;27523;27886.442271154465;28221.43557128887;28838.567421488693;28960.27599309992;895.3821862914568;940.6002448959165;976.2336565795816;995.4127065031666;1046.9895301046893;14593.92703036478;14778.408863645334;14966.401343946338;15275.388984440498;15308.234588270765;415825;424295;424902;644570;645085;49806.750966245665;50396.748016259684;50476;50548.24177637338;50574.49425505772;1168.6318809574957;1183.6034928299116;1187.2876274235389;1189.232944750631;1193.451012534244;27427.177184684493;28735.281617959718;29028.564571531868;29485;29596;43964.56035439733;44636.55363446454;44651.330230045925;44673.55326446694;44728.55271447374;334985;335131;336075;336509;336886;24890.377740556632;25489;25861.224163275132;25881.22356329313;25976.22071337863;41368.79315603403;42069.36895946624;42866.57133428626;43088.13823723445;43577.12845743131;36106.65817012278;36216.63783362238;36821.26357472889;37678;37870;35957;36038.639613603526;36238.27523449569;36254;36831.263374732895;35213.47179792254;35525.28949421049;35688.82155589309;35974.28051439009;36661.81669091638;30427.695723042485;32986.17534561655;33470.330593388484;33512.32975340528;33832.49251261282;24659.63010554879;25611.871940640176;25655.743442566083;25776.61335080013;25896.98596717512 15:50:55 INFO - PROCESS | 29163 | |2;jquery.html;349.13066464503396;372.25548902195607;375.68817881158634;376.09924231465635;388.6230356554143;12898.419571119299;16206.837931620681;16257.593560160987;16547.66904661906;17589.29642814289;16706.331746730117;17034.82965170351;17275.82724172758;17368.913155434206;17429.477115686517;4932.704037757728;4985.6759310644875;5059.721715305656;5080.415752188509;5085.567726743213;3616.529851119351;5054.469280725526;5130.743462826862;5738.856528586777;6089.725962331683;6150.784722534712;6167.5065994720535;6173.444390004899;6174.9073763893575;6175.475084617813;5757.107648314539;5803.88392232153;5820;5828.0966450200285;5950.780090081523;4982.77577509013;5043.293938848564;5050.924236136461;5052.242163675442;5055.7219352935945;20349.18603255868;20360.69458958117;20369.79630203694;20549.97250137502;20592.794072059238;1803.4950213940117;1806.1872157529165;1815.8365747082826;2003.6593779057596;2442.0353960185803;12534.435950382254;13030.153040052366;13034.608961731163;13685.931570342085;13698.794518082237;1668.5995361113246;1698.3546252424123;1777.2269062957655;1782.3049010885766;1785.3394244129624;70273.64863175702;70894.29105708929;71188.28811711869;72906;74376;9274.21169200612;9334.533273336307;9365.906340936639;9738.367006144577;9766.9023309766;12897.48410063587;12952.870471295166;12969.740605187844;12970.675733106558;12986.35068246584;6993.440524758007;7084.681189346492;7253.455990800711;7481.925180748123;7492.887606685904;6950.200726916368;7046.6828992695455;7068.5758854468895;7212.927870721331;7218.747343843045;5988.742364103587;5998.850028749316;6021.307549631761;6042.939570604238;6051.334353221142;1642.2363600925628;1731.714267145932;1751.7212434922324;1825.7443957845912;1839.5493104189559;826.7354446577037;887.729242581019;909.4134283387178;918.5223683684446;952.3333666433524;15914.76127858083;16651.084190369646;16656.58358541022;17584;17960.9101954492;802.1176705623884;808.4502538273913;851.7657644147909;876.3646356391565;938.5870217104452;9160.046478458915;9796.461194634221;9810.117089461983;9844.753881152885;9994.300398972002;395658;402884;404672;408394;408714;81961.59019204984;85178.5741071303;85917.5704121488;86012.5699371499;86247.82513049238;914.3096961793804;943.3726571829793;963.7638778499313;966.1353088985319;966.2366730282997;15110.773338400153;15118.848811511743;15438.9228053859;15923.52229433119;16016.599585010468;39202.80398597989;39357.832809953536;39478.802605986784;39778.60221397749;41274.38088428736;53730.73134634458;54125.18812217899;55688.72155639196;56332.43667563436;56709.71645141748;7380.114386273682;7415;7464.477486575887;7568.924310756822;7825.765227043198;8013.519188848688;8044.798880028046;8464.111268316738;8560.614772335135;8626.266767324847;7133.322334378433;7337.853242935218;7370.336669699753;7536.8492630148185;8140.796480088045;7382.52013619113;7385.187629360874;7446.888296675445;7772;7786.338161256356;7488.850222995618;7573.659185336563;7618.352440042659;7702.653380597774;8149.959250203949;11058.170637202404;11130.554777808797;11472.311661300015;11615.85106755253;11805.822912656145;10452.163826893982;10586.311889727143;10713.94643026811;11243.156763242952;11690.357030363071 15:50:55 INFO - PROCESS | 29163 | |3;mootools.html;1110.1618278199958;1326.9999999999998;1370.451819272291;1406.6272437803984;1692.3399874049123;6812.863742725149;7354.338109570144;7553.093628764556;7566.848663026736;7801.843963120734;7645.350145237648;7701;7716.845663086735;7716.845663086749;7742.419318551103;2222.1333679864865;2226.955460890781;2237.59723249815;2241.0251540579898;2245.4498647831306;2184.530325979914;2222.944426389337;2259.89830457629;2270.0692715986447;2270.6594010898334;2211.237123192496;2225.187806450642;2232.6427771556555;2233.8994745236423;2245.348848833836;2128.8616239944354;2172.6197915364746;2175.793299636548;2175.923842665507;2176.673498975151;2157.546915147821;2163.870167789922;2165.339571430713;2171.1532502324108;2172;7583;7888.1323054463965;7918.762437126896;7934.642941067666;8034.598270086472;4464.6428285737065;4637.721736695809;4638.420197475316;4639.976800116012;4656.8602941911795;2851.9429611407863;2981.970180298191;3017.321102751885;3018.0794857568435;3021.9546706799415;903.8192361527721;908.5729707037682;924.6717415317532;939.0609390609391;952.0336858089045;10928.508217130247;11005.724856878562;11035.83446248307;11046.779064418746;11070;4218.683598730107;4286.764227967429;4315.244832154361;4347.543507931621;4510.548945105464;8441.95779021101;8559.614817333235;8589.570521473901;8599.95700021496;8611.052784193733;4564.863054108382;4571.588557029883;4573.153966516205;4575.084983003413;4581.083783243364;3523;4024.1348110156455;4183.958160418418;4213.97893010533;4221.176870510282;3497.755157139027;3500.334936362083;3638.4178531434845;3642.34437801193;3662.6154253802965;1052.9052385285208;1067.3702515515727;1070.432670684523;1071.052118874786;1087.276960821061;676.9458443324522;701.1656129206228;809.1625167951142;809.8461292354551;847.3729440214197;4969.701817890938;4973.278874563168;5027.321311622884;5201.115810312256;5311.442298558673;825.3850881093504;858.3004851046377;868.3877866104508;888.7511496780912;912.452528482905;3496.790192588453;3533.8056406897867;3552.2007548301426;3582.355176068281;3659.4144936810517;9396.154346108882;9916.702498925044;9925.900740992498;9956.203503719686;10036;9725.951370243103;9929.304948653526;9952.353097048668;9960.153386962189;10054;6895.138107736533;7003.6848341823725;7024.789256322319;7033.226345102034;7050;4868.294097355934;4899.363082799213;5030.874228144326;5049.596032317332;5053.545180933734;8460.11168827289;8704.78238044054;8726.694565690424;8819.118088191386;8874.778130546789;8928.821423571622;9006.819863602823;9015.774605634911;9020.59407326685;9111.635534578807;5629.493345598916;5660.264165658438;6512.5766825156215;6646.534742567974;6646.9335306648245;7333.963330183528;7790.065192176975;7836.804079898048;7841.803954901173;7842.333401660922;6696.5647232929705;6719.798406047827;6735.6968936397;6784.694688739118;7012.403945664676;6644.90032649501;6796.93203067963;6835.658217089225;7038.964805175941;7116.715331386894;6312.400321969406;6358.090278297385;6422.42198202164;6423.100765892686;6426.903596446151;4576.8626941191815;4593.563611456906;4600.792964316681;4650.348951146774;4674.065186962689;4358.585934336233;4570.131674981742;4624.815007399667;4637.837675681335;4850.7574621269505 15:50:55 INFO - PROCESS | 29163 | |4;prototype.html;293.136712382035;303.2388704352076;308.7221500649415;310.8337039683768;312.04669733962737;4706.458757242918;4783.517109695997;4825.469198388175;4877.317175595415;4886.36477257956;4667.346571479996;4743.976280118594;4780.952190478094;4782.665213435061;4808.831690890819;3797.4873392092127;3804.353259945802;3810.3522401191863;3835.750676206045;3837.366834472323;3603.8017909014993;3630.5824830144606;3810.971037819787;3814.980925095371;3835.252125835463;3794.146317078649;3801.2967600993907;3811.6950643948417;3818.179091495328;3835.6931445484433;3794.3359912015426;3797.164623782791;3812.779910428664;3826.1391186982983;3832.9041773955596;3377.3583019226267;3380.138064793462;3381.306832099414;3383.154211447138;3388.1868351595685;4485.977570112129;4680.812767489297;4690.209325451351;4705.200115980291;4707.293905914106;4317.222899878021;4326.307790753464;4334.523202447728;4347.174036933005;4382.276924307485;5018.447970723254;5022.372203474566;5029.5724863386295;5041.462353982034;5043.571296439807;3483.9477407838904;3522.7005704515145;3646.21606354635;3692.649198326155;3717.1636381813873;5215.139501982168;5220.634555581111;5223.817166399196;5248.900439824025;5270.39390470097;3657.4580666437105;3660.6638576919763;3664.157243833933;3664.3770559005034;3665.651763082556;3695.981520092382;3703.574088979748;3705.6294370562728;3723.4600982857332;3726.8509259629855;4168.333066709312;4246.5116511600945;4262.786860656955;4278.871633850989;4292.613664770123;4945.258211268267;4991.251312303111;4995.350604421402;5005.099082165172;5012.874678133076;1251.386820457969;1284.07546566472;1302.6678197059878;1315.6184706435026;1318.8813006829432;908.3006085314403;930.3441074042784;931.29221791439;935.6853620662979;943.6461327002374;4507.57178068083;4515.209838278288;4528.230200865861;4531.728096314232;4532.818687252473;5191.740412979336;5205.505476979681;5230.92153617696;5239.899621079616;5247.422783493813;4376.3654270130655;4448.822047118144;4466.754328511963;4500.369948207253;4507.233770259064;2415.97584024161;2441.8779061046876;2462.372095115734;2463.2117722328685;2464.3099932019063;4341.34879768031;4345.153309843367;4360.171567402247;4388.670849686287;4393.538678438782;4361.887718631729;4634.83778067766;4662.533746625379;4679.976600116977;4701.576858082789;4347.282698354736;4361.3676016978;4364.454443194601;4381.15991283668;4384.4519435070615;4561.384213131185;4592.966582518907;4623.791929363254;4631.351610774562;4638.466576343763;4518.231900576976;4526.615237704832;4746.976265118652;5071;5093.974530127326;4930.802767889244;4936.8765780855765;4945.184044632595;4963.230699241623;4979.178435558092;3713.405855063177;3730.3844865597957;3738.27103714773;3741.214344987583;3747.68144707692;5152.9178872437205;5167.974160129325;5226.902350506284;5233.790648374174;5292.867678308073;5034.14419548685;5049.671771334852;5050.949490505048;5066.03745288394;5067.822626208213;5056.696598204119;5058.165402708659;5076.0863044652315;5079.238114282739;5114;4910.901781964412;4976.377952755905;5000.749962501933;5020.196768517019;5068.974655126701;5066.771995260148;5088;5093;5098.439171691185;5100.38795344561;4976.850694479172;5024.773885175103;5025.547700706954;5026.346574945233;5034.558239254032 15:50:55 INFO - PROCESS | 29163 | |5;yui.html;613.5674349583543;660.8413980644647;682.9248782633913;716.3338095571119;720.0818955831314;12037.157398982064;13117.753813387724;13117.803232951514;13132.212067275947;13138.277394743285;13046.804297935514;13185.538506152287;13186.604401867959;13188.142770719896;13189.472421103168;620.8975519039353;735.4998600951351;746.891700703399;761.1171041591755;762.1045271805606;769.2768797330491;769.5575044349494;772.0966469231013;772.5557804262571;772.9304362607364;805.04602046575;813.8738495533202;814.0313027497289;814.1980149552686;814.8573999550055;651.5146216069012;672.8553361027354;676.0737789228788;677.052127022168;802.7110240313483;575.8099827057061;589.375262222046;591.7189335065852;591.9171316015718;592.7836339736009;12191.756164876742;12217.022638188924;12300.753984920251;12307.753844923142;12315.322657253848;12340.382980850922;12710.682232944158;12905.419256133497;13030.290976351933;13285.402156902963;11142;11300.208985371028;11499;11544.826827597593;11827.94086029573;3825.2540754552874;3840.443135745329;3841.5966323536186;3878.9806050969564;3894.493715816954;51897.48102518964;67279;68951;69580.6520967397;70432.647836761;9239.815203695889;9386.530673466299;9443.622255109718;9981.600735970625;10062.69811905644;17807.19867605961;18116.184771685304;18123.36568220106;18128.546786330182;18137.818621813876;6704;6824.522283440211;6873.518853680194;7047.295270473014;7067.116610423697;3813;3820.7898565578603;3832.6742226911024;3837.6737977271687;3842.634949679776;2520.1557478244627;2607.087519368244;2615.5422801009745;2617.8952841886494;2621.619865119585;495.95784358329223;502.29929248697863;509.6559822120054;510.57112025898425;514.4469695077731;447.3401732444618;482.2982560374646;509.04553961322523;545.3673738463364;550.4797965922165;7413.59225242606;7516.436267279976;7532.267578456986;7674.424418168548;7864.724734634375;487.9947308544339;496.8658462215254;556.1657513729406;567.1096378685424;578.6528083150076;3425.5546778918583;3757.28611563802;3796.0889386547583;3811.4473401357204;3811.7712937223855;52000.95998080017;61804.38195617986;69177.65411173012;95527.52236238914;96280.51859740796;79734.20265797384;80411.19588804155;80719.59640201762;81274.18725812784;84343.23993301147;44027;48290.75854620775;52045;69807.30192698109;70660.64669676825;7206.675699593636;7298.416126709744;7308.04995350601;7355.742549010759;7424.639904964652;38038.429423559224;38219;38241.4263786049;40296.798516007235;41625.79187104045;36241;36990.815045924595;37170;37819.243615126994;38025.239495210495;10773.622923197963;10819.67540973772;11096.500657470595;11298.94350528275;11960.76078478408;12786.36068196605;13120.212787232414;13223.140495867738;13402.262875541548;14273.072250304112;10352.275340726077;10392.792144156923;10677.14582833356;11117.11063114965;11159.944200279271;10975.945120274348;11047.116230701364;11065.170112241452;11508.424578771195;11644.184907056764;10876.564937402416;10881.292715973437;11207.215494915277;11241.213115081866;11601.361925094201;9524.904750952403;9743.56153973087;10098.949505252427;10147.137493312855;10152.187824973837;9268.258539316974;9462.479563623792;9711.223102151953;9857.753556161153;9899.307048506535 15:50:55 INFO - PROCESS | 29163 | __end_tp_report 15:50:55 INFO - PROCESS | 29163 | __start_cc_report 15:50:55 INFO - PROCESS | 29163 | _x_x_mozilla_cycle_collect,1003 15:50:55 INFO - PROCESS | 29163 | __end_cc_report 15:50:55 INFO - PROCESS | 29163 | __startTimestamp1472165455245__endTimestamp 15:50:55 INFO - PROCESS | 29163 | 15:50:55 INFO - PROCESS | 29163 | ------- Summary: start ------- 15:50:55 INFO - PROCESS | 29163 | Number of tests: 6 15:50:55 INFO - PROCESS | 29163 | 15:50:55 INFO - PROCESS | 29163 | [#0] dojo.html Cycles:165 Average:4694.43 Median:4786.38 stddev:495.83 (10.4%) stddev-sans-first:468.82 15:50:55 INFO - PROCESS | 29163 | Values: 2581.2 2585.6 2588.8 2626.1 2647.4 4597.9 4619.1 4673.8 4698.9 4740.1 4727.9 4733.8 4734.3 4747.0 4756.9 4335.3 4407.4 4426.3 4476.7 4514.5 4342.1 4373.1 4420.4 4443.0 4514.1 4334.7 4472.4 4502.1 4511.5 4518.3 4396.5 4443.3 4475.0 4507.2 4529.0 4162.5 4215.0 4219.8 4246.8 4311.0 4565.7 4652.5 4672.4 4730.8 4733.1 4939.1 4969.5 4985.3 5058.8 5076.2 5090.5 5093.5 5103.1 5107.6 5162.9 4560.2 4681.4 4686.9 4696.5 4697.9 5141.1 5181.2 5183.7 5185.6 5250.2 4937.4 4958.9 4984.1 4984.5 5038.6 4867.8 5026.7 5066.1 5068.6 5069.6 5058.7 5073.5 5075.2 5116.6 5126.6 5021.6 5036.5 5043.6 5055.8 5119.2 4266.2 4275.8 4317.0 4357.5 4414.7 3756.3 3759.6 3808.8 3816.5 3826.6 4379.4 4388.8 4389.3 4391.4 4440.0 4928.2 4982.9 5099.2 5119.8 5176.5 4300.3 4326.9 4346.4 4389.2 4397.1 4532.7 4533.6 4537.4 4577.2 4585.1 4663.4 4761.4 4772.5 4775.2 4786.4 5111.2 5116.4 5144.7 5204.5 5208.1 4836.8 4844.4 4850.2 4853.9 4906.0 4834.7 4965.8 5022.8 5025.4 5094.4 5077.6 5115.4 5117.8 5162.9 5172.2 4960.5 4967.1 4971.9 4974.8 5000.3 4775.5 4927.9 4946.3 4959.3 5017.6 4839.8 4892.1 4912.9 4945.9 4980.2 4996.4 5028.3 5033.5 5038.9 5108.5 4742.7 4785.5 4913.3 4936.7 4988.7 15:50:55 INFO - PROCESS | 29163 | 15:50:55 INFO - PROCESS | 29163 | [#1] ext.html Cycles:180 Average:51159.45 Median:37657.41 stddev:103295.21 (274.3%) stddev-sans-first:103515.15 15:50:55 INFO - PROCESS | 29163 | Values: 574.0 575.2 582.5 586.1 589.6 28597.1 31568.2 42613.1 43306.6 43445.0 39416.4 39731.4 39843.6 39931.6 39940.8 7483.9 7622.7 7668.2 7670.0 7672.5 7731.7 7765.0 7770.7 7796.3 7819.8 7774.0 7811.5 7816.6 7869.4 7875.2 7771.1 7788.3 7791.8 7796.8 7799.4 7675.2 7735.9 7738.0 7742.0 7746.0 37359.3 37579.6 37636.8 37717.8 37739.6 2520.1 2548.9 2549.2 2668.8 2801.2 25487.4 25780.6 25986.6 26078.0 26691.3 3396.7 3478.4 3535.1 3557.3 3583.6 253661.0 253795.0 253965.0 254337.0 254488.0 52707.0 52867.5 52944.7 52995.0 53061.2 32395.7 33491.2 55929.4 56171.7 56268.4 13243.4 13486.5 13493.5 13512.8 13530.4 9980.7 9981.2 9984.9 9992.1 9993.0 18270.6 18301.8 18314.5 18323.9 18391.0 6683.3 6830.8 6915.9 6952.2 7128.5 782.0 897.9 912.2 942.8 953.3 27523.0 27886.4 28221.4 28838.6 28960.3 895.4 940.6 976.2 995.4 1047.0 14593.9 14778.4 14966.4 15275.4 15308.2 415825.0 424295.0 424902.0 644570.0 645085.0 49806.8 50396.7 50476.0 50548.2 50574.5 1168.6 1183.6 1187.3 1189.2 1193.5 27427.2 28735.3 29028.6 29485.0 29596.0 43964.6 44636.6 44651.3 44673.6 44728.6 334985.0 335131.0 336075.0 336509.0 336886.0 24890.4 25489.0 25861.2 25881.2 25976.2 41368.8 42069.4 42866.6 43088.1 43577.1 36106.7 36216.6 36821.3 37678.0 37870.0 35957.0 36038.6 36238.3 36254.0 36831.3 35213.5 35525.3 35688.8 35974.3 36661.8 30427.7 32986.2 33470.3 33512.3 33832.5 24659.6 25611.9 25655.7 25776.6 25897.0 15:50:55 INFO - PROCESS | 29163 | 15:50:55 INFO - PROCESS | 29163 | [#2] jquery.html Cycles:180 Average:25129.47 Median:56010.58 stddev:66955.76 (119.5%) stddev-sans-first:67117.74 15:50:55 INFO - PROCESS | 29163 | Values: 349.1 372.3 375.7 376.1 388.6 12898.4 16206.8 16257.6 16547.7 17589.3 16706.3 17034.8 17275.8 17368.9 17429.5 4932.7 4985.7 5059.7 5080.4 5085.6 3616.5 5054.5 5130.7 5738.9 6089.7 6150.8 6167.5 6173.4 6174.9 6175.5 5757.1 5803.9 5820.0 5828.1 5950.8 4982.8 5043.3 5050.9 5052.2 5055.7 20349.2 20360.7 20369.8 20550.0 20592.8 1803.5 1806.2 1815.8 2003.7 2442.0 12534.4 13030.2 13034.6 13685.9 13698.8 1668.6 1698.4 1777.2 1782.3 1785.3 70273.6 70894.3 71188.3 72906.0 74376.0 9274.2 9334.5 9365.9 9738.4 9766.9 12897.5 12952.9 12969.7 12970.7 12986.4 6993.4 7084.7 7253.5 7481.9 7492.9 6950.2 7046.7 7068.6 7212.9 7218.7 5988.7 5998.9 6021.3 6042.9 6051.3 1642.2 1731.7 1751.7 1825.7 1839.5 826.7 887.7 909.4 918.5 952.3 15914.8 16651.1 16656.6 17584.0 17960.9 802.1 808.5 851.8 876.4 938.6 9160.0 9796.5 9810.1 9844.8 9994.3 395658.0 402884.0 404672.0 408394.0 408714.0 81961.6 85178.6 85917.6 86012.6 86247.8 914.3 943.4 963.8 966.1 966.2 15110.8 15118.8 15438.9 15923.5 16016.6 39202.8 39357.8 39478.8 39778.6 41274.4 53730.7 54125.2 55688.7 56332.4 56709.7 7380.1 7415.0 7464.5 7568.9 7825.8 8013.5 8044.8 8464.1 8560.6 8626.3 7133.3 7337.9 7370.3 7536.8 8140.8 7382.5 7385.2 7446.9 7772.0 7786.3 7488.9 7573.7 7618.4 7702.7 8150.0 11058.2 11130.6 11472.3 11615.9 11805.8 10452.2 10586.3 10713.9 11243.2 11690.4 15:50:55 INFO - PROCESS | 29163 | 15:50:55 INFO - PROCESS | 29163 | [#3] mootools.html Cycles:180 Average:5114.74 Median:5000.30 stddev:2890.53 (57.8%) stddev-sans-first:2882.97 15:50:55 INFO - PROCESS | 29163 | Values: 1110.2 1327.0 1370.5 1406.6 1692.3 6812.9 7354.3 7553.1 7566.8 7801.8 7645.4 7701.0 7716.8 7716.8 7742.4 2222.1 2227.0 2237.6 2241.0 2245.4 2184.5 2222.9 2259.9 2270.1 2270.7 2211.2 2225.2 2232.6 2233.9 2245.3 2128.9 2172.6 2175.8 2175.9 2176.7 2157.5 2163.9 2165.3 2171.2 2172.0 7583.0 7888.1 7918.8 7934.6 8034.6 4464.6 4637.7 4638.4 4640.0 4656.9 2851.9 2982.0 3017.3 3018.1 3022.0 903.8 908.6 924.7 939.1 952.0 10928.5 11005.7 11035.8 11046.8 11070.0 4218.7 4286.8 4315.2 4347.5 4510.5 8442.0 8559.6 8589.6 8600.0 8611.1 4564.9 4571.6 4573.2 4575.1 4581.1 3523.0 4024.1 4184.0 4214.0 4221.2 3497.8 3500.3 3638.4 3642.3 3662.6 1052.9 1067.4 1070.4 1071.1 1087.3 676.9 701.2 809.2 809.8 847.4 4969.7 4973.3 5027.3 5201.1 5311.4 825.4 858.3 868.4 888.8 912.5 3496.8 3533.8 3552.2 3582.4 3659.4 9396.2 9916.7 9925.9 9956.2 10036.0 9726.0 9929.3 9952.4 9960.2 10054.0 6895.1 7003.7 7024.8 7033.2 7050.0 4868.3 4899.4 5030.9 5049.6 5053.5 8460.1 8704.8 8726.7 8819.1 8874.8 8928.8 9006.8 9015.8 9020.6 9111.6 5629.5 5660.3 6512.6 6646.5 6646.9 7334.0 7790.1 7836.8 7841.8 7842.3 6696.6 6719.8 6735.7 6784.7 7012.4 6644.9 6796.9 6835.7 7039.0 7116.7 6312.4 6358.1 6422.4 6423.1 6426.9 4576.9 4593.6 4600.8 4650.3 4674.1 4358.6 4570.1 4624.8 4637.8 4850.8 15:50:55 INFO - PROCESS | 29163 | 15:50:55 INFO - PROCESS | 29163 | [#4] prototype.html Cycles:180 Average:4130.14 Median:4527.42 stddev:1183.98 (26.2%) stddev-sans-first:1151.74 15:50:55 INFO - PROCESS | 29163 | Values: 293.1 303.2 308.7 310.8 312.0 4706.5 4783.5 4825.5 4877.3 4886.4 4667.3 4744.0 4781.0 4782.7 4808.8 3797.5 3804.4 3810.4 3835.8 3837.4 3603.8 3630.6 3811.0 3815.0 3835.3 3794.1 3801.3 3811.7 3818.2 3835.7 3794.3 3797.2 3812.8 3826.1 3832.9 3377.4 3380.1 3381.3 3383.2 3388.2 4486.0 4680.8 4690.2 4705.2 4707.3 4317.2 4326.3 4334.5 4347.2 4382.3 5018.4 5022.4 5029.6 5041.5 5043.6 3483.9 3522.7 3646.2 3692.6 3717.2 5215.1 5220.6 5223.8 5248.9 5270.4 3657.5 3660.7 3664.2 3664.4 3665.7 3696.0 3703.6 3705.6 3723.5 3726.9 4168.3 4246.5 4262.8 4278.9 4292.6 4945.3 4991.3 4995.4 5005.1 5012.9 1251.4 1284.1 1302.7 1315.6 1318.9 908.3 930.3 931.3 935.7 943.6 4507.6 4515.2 4528.2 4531.7 4532.8 5191.7 5205.5 5230.9 5239.9 5247.4 4376.4 4448.8 4466.8 4500.4 4507.2 2416.0 2441.9 2462.4 2463.2 2464.3 4341.3 4345.2 4360.2 4388.7 4393.5 4361.9 4634.8 4662.5 4680.0 4701.6 4347.3 4361.4 4364.5 4381.2 4384.5 4561.4 4593.0 4623.8 4631.4 4638.5 4518.2 4526.6 4747.0 5071.0 5094.0 4930.8 4936.9 4945.2 4963.2 4979.2 3713.4 3730.4 3738.3 3741.2 3747.7 5152.9 5168.0 5226.9 5233.8 5292.9 5034.1 5049.7 5050.9 5066.0 5067.8 5056.7 5058.2 5076.1 5079.2 5114.0 4910.9 4976.4 5000.7 5020.2 5069.0 5066.8 5088.0 5093.0 5098.4 5100.4 4976.9 5024.8 5025.5 5026.3 5034.6 15:50:55 INFO - PROCESS | 29163 | 15:50:55 INFO - PROCESS | 29163 | [#5] yui.html Cycles:180 Average:15684.47 Median:464.82 stddev:21556.70 (4637.7%) stddev-sans-first:21587.46 15:50:55 INFO - PROCESS | 29163 | Values: 613.6 660.8 682.9 716.3 720.1 12037.2 13117.8 13117.8 13132.2 13138.3 13046.8 13185.5 13186.6 13188.1 13189.5 620.9 735.5 746.9 761.1 762.1 769.3 769.6 772.1 772.6 772.9 805.0 813.9 814.0 814.2 814.9 651.5 672.9 676.1 677.1 802.7 575.8 589.4 591.7 591.9 592.8 12191.8 12217.0 12300.8 12307.8 12315.3 12340.4 12710.7 12905.4 13030.3 13285.4 11142.0 11300.2 11499.0 11544.8 11827.9 3825.3 3840.4 3841.6 3879.0 3894.5 51897.5 67279.0 68951.0 69580.7 70432.6 9239.8 9386.5 9443.6 9981.6 10062.7 17807.2 18116.2 18123.4 18128.5 18137.8 6704.0 6824.5 6873.5 7047.3 7067.1 3813.0 3820.8 3832.7 3837.7 3842.6 2520.2 2607.1 2615.5 2617.9 2621.6 496.0 502.3 509.7 510.6 514.4 447.3 482.3 509.0 545.4 550.5 7413.6 7516.4 7532.3 7674.4 7864.7 488.0 496.9 556.2 567.1 578.7 3425.6 3757.3 3796.1 3811.4 3811.8 52001.0 61804.4 69177.7 95527.5 96280.5 79734.2 80411.2 80719.6 81274.2 84343.2 44027.0 48290.8 52045.0 69807.3 70660.6 7206.7 7298.4 7308.0 7355.7 7424.6 38038.4 38219.0 38241.4 40296.8 41625.8 36241.0 36990.8 37170.0 37819.2 38025.2 10773.6 10819.7 11096.5 11298.9 11960.8 12786.4 13120.2 13223.1 13402.3 14273.1 10352.3 10392.8 10677.1 11117.1 11159.9 10975.9 11047.1 11065.2 11508.4 11644.2 10876.6 10881.3 11207.2 11241.2 11601.4 9524.9 9743.6 10098.9 10147.1 10152.2 9268.3 9462.5 9711.2 9857.8 9899.3 15:50:55 INFO - PROCESS | 29163 | -------- Summary: end -------- 15:50:55 INFO - PROCESS | 29163 | 15:50:56 INFO - TEST-INFO | 29163: exit 0 15:50:56 INFO - TEST-OK | dromaeo_css | took 1121672ms 15:50:56 INFO - TEST-START | kraken 15:50:56 INFO - operating with platform_type : linux_ 15:50:56 INFO - Initialising browser for kraken test... 15:50:56 INFO - TEST-INFO | started process 29465 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUyzEwW/profile http://localhost:51039/getInfo.html) 15:51:01 INFO - PROCESS | 29465 | __metrics Screen width/height:1600/1200 15:51:01 INFO - PROCESS | 29465 | colorDepth:24 15:51:01 INFO - PROCESS | 29465 | Browser inner width/height: 1024/697 15:51:01 INFO - PROCESS | 29465 | __metrics 15:51:01 INFO - PROCESS | 29465 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 15:51:01 INFO - PROCESS | 29465 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 155: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:51:02 INFO - TEST-INFO | 29465: exit 0 15:51:02 INFO - Browser initialized. 15:51:02 INFO - Running cycle 1/1 for kraken test... 15:51:02 INFO - TEST-INFO | started process 29543 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUyzEwW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 15:51:14 INFO - PROCESS | 29543 | RSS: Main: 180146176 15:51:14 INFO - PROCESS | 29543 | 15:51:17 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51039/tests/kraken/driver.html?testName=audio-beat-detection) 15:51:18 INFO - PROCESS | 29543 | RSS: Main: 233091072 15:51:18 INFO - PROCESS | 29543 | 15:51:21 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51039/tests/kraken/driver.html?testName=audio-dft) 15:51:21 INFO - PROCESS | 29543 | RSS: Main: 223576064 15:51:21 INFO - PROCESS | 29543 | 15:51:25 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51039/tests/kraken/driver.html?testName=audio-fft) 15:51:25 INFO - PROCESS | 29543 | RSS: Main: 302858240 15:51:25 INFO - PROCESS | 29543 | 15:51:28 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51039/tests/kraken/driver.html?testName=audio-oscillator) 15:51:28 INFO - PROCESS | 29543 | RSS: Main: 212615168 15:51:28 INFO - PROCESS | 29543 | 15:51:30 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51039/tests/kraken/driver.html?testName=imaging-gaussian-blur) 15:51:31 INFO - PROCESS | 29543 | RSS: Main: 213291008 15:51:31 INFO - PROCESS | 29543 | 15:51:34 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51039/tests/kraken/driver.html?testName=imaging-darkroom) 15:51:35 INFO - PROCESS | 29543 | RSS: Main: 251867136 15:51:35 INFO - PROCESS | 29543 | 15:51:38 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51039/tests/kraken/driver.html?testName=imaging-desaturate) 15:51:39 INFO - PROCESS | 29543 | RSS: Main: 245837824 15:51:39 INFO - PROCESS | 29543 | 15:51:42 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51039/tests/kraken/driver.html?testName=json-parse-financial) 15:51:42 INFO - PROCESS | 29543 | RSS: Main: 249024512 15:51:42 INFO - PROCESS | 29543 | 15:51:44 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51039/tests/kraken/driver.html?testName=json-stringify-tinderbox) 15:51:45 INFO - PROCESS | 29543 | RSS: Main: 212668416 15:51:45 INFO - PROCESS | 29543 | 15:51:47 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-aes) 15:51:47 INFO - PROCESS | 29543 | RSS: Main: 219582464 15:51:47 INFO - PROCESS | 29543 | 15:51:49 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-ccm) 15:51:50 INFO - PROCESS | 29543 | RSS: Main: 221016064 15:51:50 INFO - PROCESS | 29543 | 15:51:53 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 15:51:54 INFO - PROCESS | 29543 | RSS: Main: 222920704 15:51:54 INFO - PROCESS | 29543 | 15:51:57 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 15:51:57 INFO - PROCESS | 29543 | RSS: Main: 219930624 15:51:57 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | Cycle 1(1): loaded http://localhost:51039/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51039/tests/kraken/driver.html?testName=ai-astar) 15:51:59 INFO - PROCESS | 29543 | RSS: Main: 270454784 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | __start_tp_report 15:51:59 INFO - PROCESS | 29543 | _x_x_mozilla_page_load 15:51:59 INFO - PROCESS | 29543 | _x_x_mozilla_page_load_details 15:51:59 INFO - PROCESS | 29543 | |i|pagename|runs| 15:51:59 INFO - PROCESS | 29543 | |0;ai-astar;114;115;127;113;114;113;113;113;115;112 15:51:59 INFO - PROCESS | 29543 | |1;audio-beat-detection;149;124;147;184;131;153;148;125;205;133 15:51:59 INFO - PROCESS | 29543 | |2;audio-dft;161;162;163;161;161;160;162;162;163;165 15:51:59 INFO - PROCESS | 29543 | |3;audio-fft;77;76;77;175;76;77;76;76;158;76 15:51:59 INFO - PROCESS | 29543 | |4;audio-oscillator;87;92;144;87;87;86;142;85;87;147 15:51:59 INFO - PROCESS | 29543 | |5;imaging-gaussian-blur;116;117;117;117;116;117;117;116;117;116 15:51:59 INFO - PROCESS | 29543 | |6;imaging-darkroom;146;147;147;148;147;146;146;147;147;146 15:51:59 INFO - PROCESS | 29543 | |7;imaging-desaturate;95;95;95;95;95;95;94;95;95;94 15:51:59 INFO - PROCESS | 29543 | |8;json-parse-financial;64;64;65;67;66;77;66;65;65;65 15:51:59 INFO - PROCESS | 29543 | |9;json-stringify-tinderbox;65;65;65;65;67;65;67;66;66;66 15:51:59 INFO - PROCESS | 29543 | |10;stanford-crypto-aes;83;84;81;83;86;82;82;82;81;90 15:51:59 INFO - PROCESS | 29543 | |11;stanford-crypto-ccm;132;132;130;135;132;135;132;135;166;135 15:51:59 INFO - PROCESS | 29543 | |12;stanford-crypto-pbkdf2;174;174;171;184;174;170;170;177;174;171 15:51:59 INFO - PROCESS | 29543 | |13;stanford-crypto-sha256-iterative;67;71;69;69;68;68;68;71;68;71 15:51:59 INFO - PROCESS | 29543 | __end_tp_report 15:51:59 INFO - PROCESS | 29543 | __start_cc_report 15:51:59 INFO - PROCESS | 29543 | _x_x_mozilla_cycle_collect,2002 15:51:59 INFO - PROCESS | 29543 | __end_cc_report 15:51:59 INFO - PROCESS | 29543 | __startTimestamp1472165519729__endTimestamp 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | ------- Summary: start ------- 15:51:59 INFO - PROCESS | 29543 | Number of tests: 14 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#0] ai-astar Cycles:10 Average:114.90 Median:114.00 stddev:4.36 (3.8%) stddev-sans-first:4.61 15:51:59 INFO - PROCESS | 29543 | Values: 114.0 115.0 127.0 113.0 114.0 113.0 113.0 113.0 115.0 112.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#1] audio-beat-detection Cycles:10 Average:149.90 Median:148.50 stddev:26.15 (17.6%) stddev-sans-first:27.74 15:51:59 INFO - PROCESS | 29543 | Values: 149.0 124.0 147.0 184.0 131.0 153.0 148.0 125.0 205.0 133.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:1.41 (0.9%) stddev-sans-first:1.45 15:51:59 INFO - PROCESS | 29543 | Values: 161.0 162.0 163.0 161.0 161.0 160.0 162.0 162.0 163.0 165.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#3] audio-fft Cycles:10 Average:94.40 Median:76.00 stddev:38.21 (50.3%) stddev-sans-first:40.01 15:51:59 INFO - PROCESS | 29543 | Values: 77.0 76.0 77.0 175.0 76.0 77.0 76.0 76.0 158.0 76.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#4] audio-oscillator Cycles:10 Average:104.40 Median:87.00 stddev:27.64 (31.8%) stddev-sans-first:28.59 15:51:59 INFO - PROCESS | 29543 | Values: 87.0 92.0 144.0 87.0 87.0 86.0 142.0 85.0 87.0 147.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#5] imaging-gaussian-blur Cycles:10 Average:116.60 Median:117.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 15:51:59 INFO - PROCESS | 29543 | Values: 116.0 117.0 117.0 117.0 116.0 117.0 117.0 116.0 117.0 116.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 15:51:59 INFO - PROCESS | 29543 | Values: 146.0 147.0 147.0 148.0 147.0 146.0 146.0 147.0 147.0 146.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 15:51:59 INFO - PROCESS | 29543 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 94.0 95.0 95.0 94.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#8] json-parse-financial Cycles:10 Average:66.40 Median:65.50 stddev:3.84 (5.9%) stddev-sans-first:3.97 15:51:59 INFO - PROCESS | 29543 | Values: 64.0 64.0 65.0 67.0 66.0 77.0 66.0 65.0 65.0 65.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.82 (1.2%) stddev-sans-first:0.83 15:51:59 INFO - PROCESS | 29543 | Values: 65.0 65.0 65.0 65.0 67.0 65.0 67.0 66.0 66.0 66.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#10] stanford-crypto-aes Cycles:10 Average:83.40 Median:83.00 stddev:2.76 (3.3%) stddev-sans-first:2.92 15:51:59 INFO - PROCESS | 29543 | Values: 83.0 84.0 81.0 83.0 86.0 82.0 82.0 82.0 81.0 90.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#11] stanford-crypto-ccm Cycles:10 Average:136.40 Median:135.00 stddev:10.55 (7.8%) stddev-sans-first:11.07 15:51:59 INFO - PROCESS | 29543 | Values: 132.0 132.0 130.0 135.0 132.0 135.0 132.0 135.0 166.0 135.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:174.00 stddev:4.20 (2.4%) stddev-sans-first:4.46 15:51:59 INFO - PROCESS | 29543 | Values: 174.0 174.0 171.0 184.0 174.0 170.0 170.0 177.0 174.0 171.0 15:51:59 INFO - PROCESS | 29543 | 15:51:59 INFO - PROCESS | 29543 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.00 Median:69.00 stddev:1.49 (2.2%) stddev-sans-first:1.39 15:51:59 INFO - PROCESS | 29543 | Values: 67.0 71.0 69.0 69.0 68.0 68.0 68.0 71.0 68.0 71.0 15:51:59 INFO - PROCESS | 29543 | -------- Summary: end -------- 15:51:59 INFO - PROCESS | 29543 | 15:52:01 INFO - TEST-INFO | 29543: exit 0 15:52:01 INFO - TEST-OK | kraken | took 64823ms 15:52:01 INFO - SUITE-END | took 1186s 15:52:01 INFO - Completed test suite (00:19:46) 15:52:01 INFO - javascript benchmark 15:52:01 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2581.1930365060084, 2585.5992321190224, 2588.7799537039355, 2626.120249716345, 2647.4308023774897, 4597.908041839165, 4619.122366750315, 4673.813047478106, 4698.929516057257, 4740.099381117585, 4727.8818029549275, 4733.786979585919, 4734.313524538939, 4747.0, 4756.9286460703115, 4335.34969754537, 4407.382966384709, 4426.29179331307, 4476.664250181233, 4514.548545145492, 4342.109867477176, 4373.147236288925, 4420.447444069491, 4443.0, 4514.142312960544, 4334.739915605058, 4472.396226509429, 4502.144592527409, 4511.503734589192, 4518.254488009475, 4396.538363471821, 4443.266860967937, 4475.0, 4507.166174257773, 4528.977355113237, 4162.521310049323, 4215.030542975102, 4219.789010549491, 4246.830126794925, 4310.978445107786, 4565.657575681837, 4652.464966528859, 4672.3925889634465, 4730.787114579852, 4733.124371991193, 4939.135651261051, 4969.503049695038, 4985.326980857611, 5058.772355244023, 5076.213186956028, 5090.541851233407, 5093.465186155475, 5103.108710169315, 5107.642465027449, 5162.948370516285, 4560.247559152769, 4681.438227412732, 4686.859394218145, 4696.506866779007, 4697.859064228079, 5141.074606570854, 5181.171012637959, 5183.688978661293, 5185.585153187736, 5250.18622113573, 4937.432195297515, 4958.851234462972, 4984.102861484967, 4984.526469985346, 5038.5969122470115, 4867.780949857265, 5026.723530205801, 5066.138756411346, 5068.594512438996, 5069.5944324454695, 5058.671186372874, 5073.543381095719, 5075.162598171334, 5116.590672746246, 5126.5898728101665, 5021.623378246646, 5036.521530454601, 5043.621728370387, 5055.823046193439, 5119.206522988943, 4266.168097221012, 4275.786210689515, 4317.007088369693, 4357.455318085239, 4414.690971631955, 3756.286305601927, 3759.6052414496085, 3808.7524310919703, 3816.5229346331707, 3826.559945606235, 4379.430674012358, 4388.758618276025, 4389.341598760211, 4391.407160033418, 4440.045390241114, 4928.236123400879, 4982.850514484571, 5099.23511473282, 5119.846404607868, 5176.50823171798, 4300.311950087971, 4326.913461730811, 4346.369776382407, 4389.188000219906, 4397.142557201379, 4532.6827122101795, 4533.591976722111, 4537.3647689323525, 4577.22187228172, 4585.12882552314, 4663.370444989883, 4761.35721677576, 4772.5227477252, 4775.164346239325, 4786.377770889762, 5111.233315002779, 5116.360454943132, 5144.742762861917, 5204.479552044765, 5208.140656791587, 4836.806527738851, 4844.394450693663, 4850.248211527219, 4853.878653033702, 4905.950940490549, 4834.661573689808, 4965.8013679452415, 5022.84931452057, 5025.422076461254, 5094.439611642642, 5077.568406685473, 5115.437301896863, 5117.795288188579, 5162.9483705162465, 5172.224166374924, 4960.528749768766, 4967.081089998217, 4971.850844474671, 4974.801007959641, 5000.299958005955, 4775.5224477551965, 4927.901441971068, 4946.258061290835, 4959.256111583291, 5017.598592112695, 4839.782209800638, 4892.143874821821, 4912.8771780705765, 4945.876353091057, 4980.203167493184, 4996.375453068366, 5028.34631497903, 5033.471485494117, 5038.874028149326, 5108.489151084862, 4742.715437073786, 4785.473597904297, 4913.336699545658, 4936.7284799336385, 4988.650794444354], "value": 4662.2356339470625, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.9655620662761, 575.2406822993651, 582.4670426559699, 586.1383765864178, 589.5578316262803, 28597.142085737436, 31568.210794730116, 42613.14773704524, 43306.56693433065, 43445.0, 39416.408753868716, 39731.40402893959, 39843.60156398435, 39931.60068399315, 39940.80029599848, 7483.887741683892, 7622.733204337849, 7668.194839541851, 7669.961650191742, 7672.5012874163, 7731.690732370726, 7765.029371328584, 7770.728024519143, 7796.298333150015, 7819.765407037798, 7773.961130194341, 7811.531308121503, 7816.570088645122, 7869.449138560303, 7875.173106823787, 7771.106322772869, 7788.337991270749, 7791.805204869867, 7796.80507987302, 7799.37604991605, 7675.232476752336, 7735.922640773577, 7737.961310193469, 7742.032245969254, 7745.961270193613, 37359.25281494382, 37579.624203757885, 37636.81181594102, 37717.81141094277, 37739.62260377389, 2520.0675749972443, 2548.8980440782348, 2549.247971848309, 2668.83986960781, 2801.215659615311, 25487.362815929566, 25780.613290800655, 25986.610200847, 26078.0, 26691.332716682045, 3396.745244106702, 3478.3565040467593, 3535.063208249816, 3557.3063252665743, 3583.62371950944, 253661.0, 253795.0, 253965.0, 254337.0, 254488.0, 52707.0, 52867.47132528702, 52944.73527632337, 52995.0, 53061.2040819388, 32395.676043239266, 33491.162720932174, 55929.44070559324, 56171.71914140403, 56268.43731562632, 13243.404046817916, 13486.527971520949, 13493.527726529524, 13512.797308040388, 13530.391132399065, 9980.650677226407, 9981.151602113756, 9984.900150998397, 9992.10071093605, 9992.950035249924, 18270.634587308446, 18301.816981830278, 18314.542136446697, 18323.90838045828, 18391.0, 6683.331666833375, 6830.829229269209, 6915.89626155608, 6952.168243071017, 7128.501004929605, 782.0, 897.8832751742232, 912.1653686876434, 942.783159873233, 953.3469573342283, 27523.0, 27886.442271154465, 28221.43557128887, 28838.567421488693, 28960.27599309992, 895.3821862914568, 940.6002448959165, 976.2336565795816, 995.4127065031666, 1046.9895301046893, 14593.92703036478, 14778.408863645334, 14966.401343946338, 15275.388984440498, 15308.234588270765, 415825.0, 424295.0, 424902.0, 644570.0, 645085.0, 49806.750966245665, 50396.748016259684, 50476.0, 50548.24177637338, 50574.49425505772, 1168.6318809574957, 1183.6034928299116, 1187.2876274235389, 1189.232944750631, 1193.451012534244, 27427.177184684493, 28735.281617959718, 29028.564571531868, 29485.0, 29596.0, 43964.56035439733, 44636.55363446454, 44651.330230045925, 44673.55326446694, 44728.55271447374, 334985.0, 335131.0, 336075.0, 336509.0, 336886.0, 24890.377740556632, 25489.0, 25861.224163275132, 25881.22356329313, 25976.22071337863, 41368.79315603403, 42069.36895946624, 42866.57133428626, 43088.13823723445, 43577.12845743131, 36106.65817012278, 36216.63783362238, 36821.26357472889, 37678.0, 37870.0, 35957.0, 36038.639613603526, 36238.27523449569, 36254.0, 36831.263374732895, 35213.47179792254, 35525.28949421049, 35688.82155589309, 35974.28051439009, 36661.81669091638, 30427.695723042485, 32986.17534561655, 33470.330593388484, 33512.32975340528, 33832.49251261282, 24659.63010554879, 25611.871940640176, 25655.743442566083, 25776.61335080013, 25896.98596717512], "value": 17448.11648494059, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [349.13066464503396, 372.25548902195607, 375.68817881158634, 376.09924231465635, 388.6230356554143, 12898.419571119299, 16206.837931620681, 16257.593560160987, 16547.66904661906, 17589.29642814289, 16706.331746730117, 17034.82965170351, 17275.82724172758, 17368.913155434206, 17429.477115686517, 4932.704037757728, 4985.6759310644875, 5059.721715305656, 5080.415752188509, 5085.567726743213, 3616.529851119351, 5054.469280725526, 5130.743462826862, 5738.856528586777, 6089.725962331683, 6150.784722534712, 6167.5065994720535, 6173.444390004899, 6174.9073763893575, 6175.475084617813, 5757.107648314539, 5803.88392232153, 5820.0, 5828.0966450200285, 5950.780090081523, 4982.77577509013, 5043.293938848564, 5050.924236136461, 5052.242163675442, 5055.7219352935945, 20349.18603255868, 20360.69458958117, 20369.79630203694, 20549.97250137502, 20592.794072059238, 1803.4950213940117, 1806.1872157529165, 1815.8365747082826, 2003.6593779057596, 2442.0353960185803, 12534.435950382254, 13030.153040052366, 13034.608961731163, 13685.931570342085, 13698.794518082237, 1668.5995361113246, 1698.3546252424123, 1777.2269062957655, 1782.3049010885766, 1785.3394244129624, 70273.64863175702, 70894.29105708929, 71188.28811711869, 72906.0, 74376.0, 9274.21169200612, 9334.533273336307, 9365.906340936639, 9738.367006144577, 9766.9023309766, 12897.48410063587, 12952.870471295166, 12969.740605187844, 12970.675733106558, 12986.35068246584, 6993.440524758007, 7084.681189346492, 7253.455990800711, 7481.925180748123, 7492.887606685904, 6950.200726916368, 7046.6828992695455, 7068.5758854468895, 7212.927870721331, 7218.747343843045, 5988.742364103587, 5998.850028749316, 6021.307549631761, 6042.939570604238, 6051.334353221142, 1642.2363600925628, 1731.714267145932, 1751.7212434922324, 1825.7443957845912, 1839.5493104189559, 826.7354446577037, 887.729242581019, 909.4134283387178, 918.5223683684446, 952.3333666433524, 15914.76127858083, 16651.084190369646, 16656.58358541022, 17584.0, 17960.9101954492, 802.1176705623884, 808.4502538273913, 851.7657644147909, 876.3646356391565, 938.5870217104452, 9160.046478458915, 9796.461194634221, 9810.117089461983, 9844.753881152885, 9994.300398972002, 395658.0, 402884.0, 404672.0, 408394.0, 408714.0, 81961.59019204984, 85178.5741071303, 85917.5704121488, 86012.5699371499, 86247.82513049238, 914.3096961793804, 943.3726571829793, 963.7638778499313, 966.1353088985319, 966.2366730282997, 15110.773338400153, 15118.848811511743, 15438.9228053859, 15923.52229433119, 16016.599585010468, 39202.80398597989, 39357.832809953536, 39478.802605986784, 39778.60221397749, 41274.38088428736, 53730.73134634458, 54125.18812217899, 55688.72155639196, 56332.43667563436, 56709.71645141748, 7380.114386273682, 7415.0, 7464.477486575887, 7568.924310756822, 7825.765227043198, 8013.519188848688, 8044.798880028046, 8464.111268316738, 8560.614772335135, 8626.266767324847, 7133.322334378433, 7337.853242935218, 7370.336669699753, 7536.8492630148185, 8140.796480088045, 7382.52013619113, 7385.187629360874, 7446.888296675445, 7772.0, 7786.338161256356, 7488.850222995618, 7573.659185336563, 7618.352440042659, 7702.653380597774, 8149.959250203949, 11058.170637202404, 11130.554777808797, 11472.311661300015, 11615.85106755253, 11805.822912656145, 10452.163826893982, 10586.311889727143, 10713.94643026811, 11243.156763242952, 11690.357030363071], "value": 8262.734704763105, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1110.1618278199958, 1326.9999999999998, 1370.451819272291, 1406.6272437803984, 1692.3399874049123, 6812.863742725149, 7354.338109570144, 7553.093628764556, 7566.848663026736, 7801.843963120734, 7645.350145237648, 7701.0, 7716.845663086735, 7716.845663086749, 7742.419318551103, 2222.1333679864865, 2226.955460890781, 2237.59723249815, 2241.0251540579898, 2245.4498647831306, 2184.530325979914, 2222.944426389337, 2259.89830457629, 2270.0692715986447, 2270.6594010898334, 2211.237123192496, 2225.187806450642, 2232.6427771556555, 2233.8994745236423, 2245.348848833836, 2128.8616239944354, 2172.6197915364746, 2175.793299636548, 2175.923842665507, 2176.673498975151, 2157.546915147821, 2163.870167789922, 2165.339571430713, 2171.1532502324108, 2172.0, 7583.0, 7888.1323054463965, 7918.762437126896, 7934.642941067666, 8034.598270086472, 4464.6428285737065, 4637.721736695809, 4638.420197475316, 4639.976800116012, 4656.8602941911795, 2851.9429611407863, 2981.970180298191, 3017.321102751885, 3018.0794857568435, 3021.9546706799415, 903.8192361527721, 908.5729707037682, 924.6717415317532, 939.0609390609391, 952.0336858089045, 10928.508217130247, 11005.724856878562, 11035.83446248307, 11046.779064418746, 11070.0, 4218.683598730107, 4286.764227967429, 4315.244832154361, 4347.543507931621, 4510.548945105464, 8441.95779021101, 8559.614817333235, 8589.570521473901, 8599.95700021496, 8611.052784193733, 4564.863054108382, 4571.588557029883, 4573.153966516205, 4575.084983003413, 4581.083783243364, 3523.0, 4024.1348110156455, 4183.958160418418, 4213.97893010533, 4221.176870510282, 3497.755157139027, 3500.334936362083, 3638.4178531434845, 3642.34437801193, 3662.6154253802965, 1052.9052385285208, 1067.3702515515727, 1070.432670684523, 1071.052118874786, 1087.276960821061, 676.9458443324522, 701.1656129206228, 809.1625167951142, 809.8461292354551, 847.3729440214197, 4969.701817890938, 4973.278874563168, 5027.321311622884, 5201.115810312256, 5311.442298558673, 825.3850881093504, 858.3004851046377, 868.3877866104508, 888.7511496780912, 912.452528482905, 3496.790192588453, 3533.8056406897867, 3552.2007548301426, 3582.355176068281, 3659.4144936810517, 9396.154346108882, 9916.702498925044, 9925.900740992498, 9956.203503719686, 10036.0, 9725.951370243103, 9929.304948653526, 9952.353097048668, 9960.153386962189, 10054.0, 6895.138107736533, 7003.6848341823725, 7024.789256322319, 7033.226345102034, 7050.0, 4868.294097355934, 4899.363082799213, 5030.874228144326, 5049.596032317332, 5053.545180933734, 8460.11168827289, 8704.78238044054, 8726.694565690424, 8819.118088191386, 8874.778130546789, 8928.821423571622, 9006.819863602823, 9015.774605634911, 9020.59407326685, 9111.635534578807, 5629.493345598916, 5660.264165658438, 6512.5766825156215, 6646.534742567974, 6646.9335306648245, 7333.963330183528, 7790.065192176975, 7836.804079898048, 7841.803954901173, 7842.333401660922, 6696.5647232929705, 6719.798406047827, 6735.6968936397, 6784.694688739118, 7012.403945664676, 6644.90032649501, 6796.93203067963, 6835.658217089225, 7038.964805175941, 7116.715331386894, 6312.400321969406, 6358.090278297385, 6422.42198202164, 6423.100765892686, 6426.903596446151, 4576.8626941191815, 4593.563611456906, 4600.792964316681, 4650.348951146774, 4674.065186962689, 4358.585934336233, 4570.131674981742, 4624.815007399667, 4637.837675681335, 4850.7574621269505], "value": 4104.610254768209, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.136712382035, 303.2388704352076, 308.7221500649415, 310.8337039683768, 312.04669733962737, 4706.458757242918, 4783.517109695997, 4825.469198388175, 4877.317175595415, 4886.36477257956, 4667.346571479996, 4743.976280118594, 4780.952190478094, 4782.665213435061, 4808.831690890819, 3797.4873392092127, 3804.353259945802, 3810.3522401191863, 3835.750676206045, 3837.366834472323, 3603.8017909014993, 3630.5824830144606, 3810.971037819787, 3814.980925095371, 3835.252125835463, 3794.146317078649, 3801.2967600993907, 3811.6950643948417, 3818.179091495328, 3835.6931445484433, 3794.3359912015426, 3797.164623782791, 3812.779910428664, 3826.1391186982983, 3832.9041773955596, 3377.3583019226267, 3380.138064793462, 3381.306832099414, 3383.154211447138, 3388.1868351595685, 4485.977570112129, 4680.812767489297, 4690.209325451351, 4705.200115980291, 4707.293905914106, 4317.222899878021, 4326.307790753464, 4334.523202447728, 4347.174036933005, 4382.276924307485, 5018.447970723254, 5022.372203474566, 5029.5724863386295, 5041.462353982034, 5043.571296439807, 3483.9477407838904, 3522.7005704515145, 3646.21606354635, 3692.649198326155, 3717.1636381813873, 5215.139501982168, 5220.634555581111, 5223.817166399196, 5248.900439824025, 5270.39390470097, 3657.4580666437105, 3660.6638576919763, 3664.157243833933, 3664.3770559005034, 3665.651763082556, 3695.981520092382, 3703.574088979748, 3705.6294370562728, 3723.4600982857332, 3726.8509259629855, 4168.333066709312, 4246.5116511600945, 4262.786860656955, 4278.871633850989, 4292.613664770123, 4945.258211268267, 4991.251312303111, 4995.350604421402, 5005.099082165172, 5012.874678133076, 1251.386820457969, 1284.07546566472, 1302.6678197059878, 1315.6184706435026, 1318.8813006829432, 908.3006085314403, 930.3441074042784, 931.29221791439, 935.6853620662979, 943.6461327002374, 4507.57178068083, 4515.209838278288, 4528.230200865861, 4531.728096314232, 4532.818687252473, 5191.740412979336, 5205.505476979681, 5230.92153617696, 5239.899621079616, 5247.422783493813, 4376.3654270130655, 4448.822047118144, 4466.754328511963, 4500.369948207253, 4507.233770259064, 2415.97584024161, 2441.8779061046876, 2462.372095115734, 2463.2117722328685, 2464.3099932019063, 4341.34879768031, 4345.153309843367, 4360.171567402247, 4388.670849686287, 4393.538678438782, 4361.887718631729, 4634.83778067766, 4662.533746625379, 4679.976600116977, 4701.576858082789, 4347.282698354736, 4361.3676016978, 4364.454443194601, 4381.15991283668, 4384.4519435070615, 4561.384213131185, 4592.966582518907, 4623.791929363254, 4631.351610774562, 4638.466576343763, 4518.231900576976, 4526.615237704832, 4746.976265118652, 5071.0, 5093.974530127326, 4930.802767889244, 4936.8765780855765, 4945.184044632595, 4963.230699241623, 4979.178435558092, 3713.405855063177, 3730.3844865597957, 3738.27103714773, 3741.214344987583, 3747.68144707692, 5152.9178872437205, 5167.974160129325, 5226.902350506284, 5233.790648374174, 5292.867678308073, 5034.14419548685, 5049.671771334852, 5050.949490505048, 5066.03745288394, 5067.822626208213, 5056.696598204119, 5058.165402708659, 5076.0863044652315, 5079.238114282739, 5114.0, 4910.901781964412, 4976.377952755905, 5000.749962501933, 5020.196768517019, 5068.974655126701, 5066.771995260148, 5088.0, 5093.0, 5098.439171691185, 5100.38795344561, 4976.850694479172, 5024.773885175103, 5025.547700706954, 5026.346574945233, 5034.558239254032], "value": 3762.126182577636, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [613.5674349583543, 660.8413980644647, 682.9248782633913, 716.3338095571119, 720.0818955831314, 12037.157398982064, 13117.753813387724, 13117.803232951514, 13132.212067275947, 13138.277394743285, 13046.804297935514, 13185.538506152287, 13186.604401867959, 13188.142770719896, 13189.472421103168, 620.8975519039353, 735.4998600951351, 746.891700703399, 761.1171041591755, 762.1045271805606, 769.2768797330491, 769.5575044349494, 772.0966469231013, 772.5557804262571, 772.9304362607364, 805.04602046575, 813.8738495533202, 814.0313027497289, 814.1980149552686, 814.8573999550055, 651.5146216069012, 672.8553361027354, 676.0737789228788, 677.052127022168, 802.7110240313483, 575.8099827057061, 589.375262222046, 591.7189335065852, 591.9171316015718, 592.7836339736009, 12191.756164876742, 12217.022638188924, 12300.753984920251, 12307.753844923142, 12315.322657253848, 12340.382980850922, 12710.682232944158, 12905.419256133497, 13030.290976351933, 13285.402156902963, 11142.0, 11300.208985371028, 11499.0, 11544.826827597593, 11827.94086029573, 3825.2540754552874, 3840.443135745329, 3841.5966323536186, 3878.9806050969564, 3894.493715816954, 51897.48102518964, 67279.0, 68951.0, 69580.6520967397, 70432.647836761, 9239.815203695889, 9386.530673466299, 9443.622255109718, 9981.600735970625, 10062.69811905644, 17807.19867605961, 18116.184771685304, 18123.36568220106, 18128.546786330182, 18137.818621813876, 6704.0, 6824.522283440211, 6873.518853680194, 7047.295270473014, 7067.116610423697, 3813.0, 3820.7898565578603, 3832.6742226911024, 3837.6737977271687, 3842.634949679776, 2520.1557478244627, 2607.087519368244, 2615.5422801009745, 2617.8952841886494, 2621.619865119585, 495.95784358329223, 502.29929248697863, 509.6559822120054, 510.57112025898425, 514.4469695077731, 447.3401732444618, 482.2982560374646, 509.04553961322523, 545.3673738463364, 550.4797965922165, 7413.59225242606, 7516.436267279976, 7532.267578456986, 7674.424418168548, 7864.724734634375, 487.9947308544339, 496.8658462215254, 556.1657513729406, 567.1096378685424, 578.6528083150076, 3425.5546778918583, 3757.28611563802, 3796.0889386547583, 3811.4473401357204, 3811.7712937223855, 52000.95998080017, 61804.38195617986, 69177.65411173012, 95527.52236238914, 96280.51859740796, 79734.20265797384, 80411.19588804155, 80719.59640201762, 81274.18725812784, 84343.23993301147, 44027.0, 48290.75854620775, 52045.0, 69807.30192698109, 70660.64669676825, 7206.675699593636, 7298.416126709744, 7308.04995350601, 7355.742549010759, 7424.639904964652, 38038.429423559224, 38219.0, 38241.4263786049, 40296.798516007235, 41625.79187104045, 36241.0, 36990.815045924595, 37170.0, 37819.243615126994, 38025.239495210495, 10773.622923197963, 10819.67540973772, 11096.500657470595, 11298.94350528275, 11960.76078478408, 12786.36068196605, 13120.212787232414, 13223.140495867738, 13402.262875541548, 14273.072250304112, 10352.275340726077, 10392.792144156923, 10677.14582833356, 11117.11063114965, 11159.944200279271, 10975.945120274348, 11047.116230701364, 11065.170112241452, 11508.424578771195, 11644.184907056764, 10876.564937402416, 10881.292715973437, 11207.215494915277, 11241.213115081866, 11601.361925094201, 9524.904750952403, 9743.56153973087, 10098.949505252427, 10147.137493312855, 10152.187824973837, 9268.258539316974, 9462.479563623792, 9711.223102151953, 9857.753556161153, 9899.307048506535], "value": 6197.8448424102535, "unit": "score"}], "name": "dromaeo_css", "value": 6330.098532665011, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 127.0, 113.0, 114.0, 113.0, 113.0, 113.0, 115.0, 112.0], "value": 114.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 124.0, 147.0, 184.0, 131.0, 153.0, 148.0, 125.0, 205.0, 133.0], "value": 149.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 162.0, 163.0, 161.0, 161.0, 160.0, 162.0, 162.0, 163.0, 165.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 175.0, 76.0, 77.0, 76.0, 76.0, 158.0, 76.0], "value": 94.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 92.0, 144.0, 87.0, 87.0, 86.0, 142.0, 85.0, 87.0, 147.0], "value": 104.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 117.0, 117.0, 116.0, 117.0, 116.0], "value": 116.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 148.0, 147.0, 146.0, 146.0, 147.0, 147.0, 146.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 94.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 67.0, 66.0, 77.0, 66.0, 65.0, 65.0, 65.0], "value": 66.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 67.0, 65.0, 67.0, 66.0, 66.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 81.0, 83.0, 86.0, 82.0, 82.0, 82.0, 81.0, 90.0], "value": 83.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 132.0, 130.0, 135.0, 132.0, 135.0, 132.0, 135.0, 166.0, 135.0], "value": 136.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 174.0, 171.0, 184.0, 174.0, 170.0, 170.0, 177.0, 174.0, 171.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 71.0, 69.0, 69.0, 68.0, 68.0, 68.0, 71.0, 68.0, 71.0], "value": 69.0, "unit": "score"}], "name": "kraken", "value": 1578.5000000000005, "alertThreshold": 2.0}]} 15:52:01 INFO - Return code: 0 15:52:01 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 15:52:01 INFO - # TBPL SUCCESS # 15:52:01 INFO - Running post-action listener: _resource_record_post_action 15:52:01 INFO - [mozharness: 2016-08-25 22:52:01.532152Z] Finished run-tests step (success) 15:52:01 INFO - Running post-run listener: _resource_record_post_run 15:52:01 INFO - Total resource usage - Wall time: 1203s; CPU: 13.0%; Read bytes: 8192; Write bytes: 405389312; Read time: 292; Write time: 388864 15:52:01 INFO - TinderboxPrint: CPU usage
13.1% 15:52:01 INFO - TinderboxPrint: I/O read bytes / time
8,192 / 292 15:52:01 INFO - TinderboxPrint: I/O write bytes / time
405,389,312 / 388,864 15:52:01 INFO - TinderboxPrint: CPU idle
8,344.1 (86.9%) 15:52:01 INFO - TinderboxPrint: CPU user
1,204.0 (12.5%) 15:52:01 INFO - TinderboxPrint: Swap in / out
0 / 0 15:52:01 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 113471488; Read time: 0; Write time: 124976 15:52:01 INFO - run-tests - Wall time: 1187s; CPU: 13.0%; Read bytes: 4096; Write bytes: 289341440; Read time: 280; Write time: 263612 15:52:02 INFO - Running post-run listener: _upload_blobber_files 15:52:02 INFO - Blob upload gear active. 15:52:02 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 15:52:02 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 15:52:02 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', 'Autoland-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 15:52:02 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 Autoland-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 15:52:02 INFO - (blobuploader) - INFO - Open directory for files ... 15:52:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 15:52:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 15:52:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:06 INFO - (blobuploader) - INFO - Done attempting. 15:52:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 15:52:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 15:52:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:07 INFO - (blobuploader) - INFO - Done attempting. 15:52:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 15:52:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 15:52:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 15:52:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 15:52:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 15:52:07 INFO - (blobuploader) - INFO - Done attempting. 15:52:07 INFO - (blobuploader) - INFO - Iteration through files over. 15:52:07 INFO - Return code: 0 15:52:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 15:52:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 15:52:07 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fbb0168dd980ce387b9076f7c3dce0209e936c80b4ea2f86f407bd229deb9d4568af4b89d6b0252641e5fcf13150432a1243a5a91d7b7b469498413ab40c4eaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c49e5e889f9799c88c6646d4db44dc0d18b7cfde26ad1e25c1dd0ad0615f28a2180be152abec296a1a0b79d1b688dc55929f3a8351f895b8373a5c5cb6c52f16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e969b73e99321bb596943043b39f8a21864ee3aff571addbbb097fdd1aa6d7c3c81eff2ebb3fb69d4756cb6297a1e160db93bc46c67fb3dd3c9ddec11cfc18ab"} 15:52:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 15:52:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 15:52:07 INFO - Contents: 15:52:07 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fbb0168dd980ce387b9076f7c3dce0209e936c80b4ea2f86f407bd229deb9d4568af4b89d6b0252641e5fcf13150432a1243a5a91d7b7b469498413ab40c4eaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c49e5e889f9799c88c6646d4db44dc0d18b7cfde26ad1e25c1dd0ad0615f28a2180be152abec296a1a0b79d1b688dc55929f3a8351f895b8373a5c5cb6c52f16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e969b73e99321bb596943043b39f8a21864ee3aff571addbbb097fdd1aa6d7c3c81eff2ebb3fb69d4756cb6297a1e160db93bc46c67fb3dd3c9ddec11cfc18ab"} 15:52:07 INFO - Running post-run listener: copy_logs_to_upload_dir 15:52:07 INFO - Copying logs to upload dir... 15:52:07 INFO - mkdir: /builds/slave/test/build/upload/logs 15:52:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.820584 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-08-25 15:52:07.694302) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 15:52:07.697473) ========= 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=db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fbb0168dd980ce387b9076f7c3dce0209e936c80b4ea2f86f407bd229deb9d4568af4b89d6b0252641e5fcf13150432a1243a5a91d7b7b469498413ab40c4eaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c49e5e889f9799c88c6646d4db44dc0d18b7cfde26ad1e25c1dd0ad0615f28a2180be152abec296a1a0b79d1b688dc55929f3a8351f895b8373a5c5cb6c52f16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e969b73e99321bb596943043b39f8a21864ee3aff571addbbb097fdd1aa6d7c3c81eff2ebb3fb69d4756cb6297a1e160db93bc46c67fb3dd3c9ddec11cfc18ab"} build_url:https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011348 build_url: 'https://queue.taskcluster.net/v1/task/STC9HdmpTkeQhxw6vAiW4A/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/fbb0168dd980ce387b9076f7c3dce0209e936c80b4ea2f86f407bd229deb9d4568af4b89d6b0252641e5fcf13150432a1243a5a91d7b7b469498413ab40c4eaa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/c49e5e889f9799c88c6646d4db44dc0d18b7cfde26ad1e25c1dd0ad0615f28a2180be152abec296a1a0b79d1b688dc55929f3a8351f895b8373a5c5cb6c52f16", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/e969b73e99321bb596943043b39f8a21864ee3aff571addbbb097fdd1aa6d7c3c81eff2ebb3fb69d4756cb6297a1e160db93bc46c67fb3dd3c9ddec11cfc18ab"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-25 15:52:07.727338) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:52:07.728142) ========= 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=db0483c52d987ecb441a263b000001ad-1472164279.59032-922591866 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004411 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-25 15:52:07.810809) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 15:52:07.811141) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-25 15:52:07.811435) ========= ========= Total master_lag: 0.19 =========