builder: mozilla-central_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-023 starttime: 1470568542.57 results: success (0) buildid: 20160807013000 builduid: bacd88f428f941c8a33908f87f0f1e87 revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:42.568900) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:42.569285) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:42.569546) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:42.583585) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:42.583835) ========= 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=6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-08-07 04:15:43-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 21.3M=0.001s 2016-08-07 04:15:43 (21.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.121475 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:42.718702) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:42.719006) ========= 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=6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016486 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:42.767593) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 04:15:42.767913) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev d42aacfe34af25e2f5110e2ca3d24a210eabeb33 --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=6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-08-07 04:15:43,391 truncating revision to first 12 chars 2016-08-07 04:15:43,391 Setting DEBUG logging. 2016-08-07 04:15:43,391 attempt 1/10 2016-08-07 04:15:43,391 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d42aacfe34af?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-08-07 04:15:44,317 unpacking tar archive at: mozilla-central-d42aacfe34af/testing/mozharness/ program finished with exit code 0 elapsedTime=1.347591 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-08-07 04:15:44.129103) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:44.129438) ========= script_repo_revision: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:44.129833) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:44.130100) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-08-07 04:15:44.138678) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-07 04:15:44.138983) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:15:44 INFO - MultiFileLogger online at 20160807 04:15:44 in /builds/slave/test 04:15:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:15:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:15:44 INFO - {'append_to_log': False, 04:15:44 INFO - 'base_work_dir': '/builds/slave/test', 04:15:44 INFO - 'blob_upload_branch': 'Firefox', 04:15:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:15:44 INFO - 'branch': 'Firefox', 04:15:44 INFO - 'buildbot_json_path': 'buildprops.json', 04:15:44 INFO - 'config_files': ('talos/linux_config.py',), 04:15:44 INFO - 'default_actions': ('clobber', 04:15:44 INFO - 'read-buildbot-config', 04:15:44 INFO - 'download-and-extract', 04:15:44 INFO - 'populate-webroot', 04:15:44 INFO - 'create-virtualenv', 04:15:44 INFO - 'install', 04:15:44 INFO - 'run-tests'), 04:15:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:15:44 INFO - 'download_minidump_stackwalk': True, 04:15:44 INFO - 'download_symbols': 'ondemand', 04:15:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:15:44 INFO - 'tooltool.py': '/tools/tooltool.py', 04:15:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:15:44 INFO - '/tools/misc-python/virtualenv.py')}, 04:15:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:15:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:15:44 INFO - 'installer_path': 'installer.exe', 04:15:44 INFO - 'log_level': 'info', 04:15:44 INFO - 'log_name': 'talos', 04:15:44 INFO - 'log_to_console': True, 04:15:44 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:15:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:15:44 INFO - 'opt_config_files': (), 04:15:44 INFO - 'pip_index': False, 04:15:44 INFO - 'sps_profile': False, 04:15:44 INFO - 'sps_profile_interval': 0, 04:15:44 INFO - 'suite': 'dromaeojs', 04:15:44 INFO - 'system_bits': '32', 04:15:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:15:44 INFO - 'title': 'talos-linux64-ix-023', 04:15:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:15:44 INFO - 'use_talos_json': True, 04:15:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:15:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:15:44 INFO - 'work_dir': 'build'} 04:15:44 INFO - [mozharness: 2016-08-07 11:15:44.857426Z] Running clobber step. 04:15:44 INFO - Running pre-action listener: _resource_record_pre_action 04:15:44 INFO - Running main action method: clobber 04:15:44 INFO - rmtree: /builds/slave/test/build 04:15:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:15:45 INFO - Running post-action listener: _resource_record_post_action 04:15:45 INFO - [mozharness: 2016-08-07 11:15:45.838192Z] Finished clobber step (success) 04:15:45 INFO - [mozharness: 2016-08-07 11:15:45.838295Z] Running read-buildbot-config step. 04:15:45 INFO - Running pre-action listener: _resource_record_pre_action 04:15:45 INFO - Running main action method: read_buildbot_config 04:15:45 INFO - Using buildbot properties: 04:15:45 INFO - { 04:15:45 INFO - "project": "", 04:15:45 INFO - "product": "firefox", 04:15:45 INFO - "script_repo_revision": "production", 04:15:45 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:15:45 INFO - "repository": "", 04:15:45 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs", 04:15:45 INFO - "buildid": "20160807013000", 04:15:45 INFO - "pgo_build": "True", 04:15:45 INFO - "basedir": "/builds/slave/test", 04:15:45 INFO - "buildnumber": 518, 04:15:45 INFO - "slavename": "talos-linux64-ix-023", 04:15:45 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 04:15:45 INFO - "platform": "ubuntu64_hw", 04:15:45 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 04:15:45 INFO - "branch": "mozilla-central", 04:15:45 INFO - "repo_path": "mozilla-central", 04:15:45 INFO - "revision": "d42aacfe34af25e2f5110e2ca3d24a210eabeb33", 04:15:45 INFO - "stage_platform": "linux64-pgo", 04:15:45 INFO - "builduid": "bacd88f428f941c8a33908f87f0f1e87", 04:15:45 INFO - "slavebuilddir": "test" 04:15:45 INFO - } 04:15:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2. 04:15:45 INFO - Running post-action listener: _resource_record_post_action 04:15:45 INFO - [mozharness: 2016-08-07 11:15:45.840747Z] Finished read-buildbot-config step (success) 04:15:45 INFO - [mozharness: 2016-08-07 11:15:45.840837Z] Running download-and-extract step. 04:15:45 INFO - Running pre-action listener: _resource_record_pre_action 04:15:45 INFO - Running main action method: download_and_extract 04:15:45 INFO - mkdir: /builds/slave/test/build/tests 04:15:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:45 INFO - trying https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:15:45 INFO - Downloading https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/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 04:15:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/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 04:15:46 INFO - Downloaded 1361 bytes. 04:15:46 INFO - Reading from file /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.test_packages.json 04:15:46 INFO - Using the following test package requirements: 04:15:46 INFO - {u'common': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:46 INFO - u'cppunittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:15:46 INFO - u'gtest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:15:46 INFO - u'jittest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:46 INFO - u'jsshell-linux-x86_64.zip'], 04:15:46 INFO - u'mochitest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:15:46 INFO - u'mozbase': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:46 INFO - u'reftest': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:15:46 INFO - u'talos': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:15:46 INFO - u'web-platform': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:15:46 INFO - u'xpcshell': [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:46 INFO - u'firefox-51.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:15:46 INFO - Downloading packages: [u'firefox-51.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:15: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')]} 04:15:46 INFO - trying https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:15:46 INFO - Downloading https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/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 04:15:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/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 04:15:47 INFO - Downloaded 21829821 bytes. 04:15:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:15:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:15:48 INFO - Return code: 0 04:15:48 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 04:15:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:48 INFO - trying https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip 04:15:48 INFO - Downloading https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/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 04:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/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 04:15:49 INFO - Downloaded 21829821 bytes. 04:15:49 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:15:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:15:50 INFO - Return code: 0 04:15: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')]} 04:15:50 INFO - trying https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip 04:15:50 INFO - Downloading https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/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 04:15:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/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 04:15:51 INFO - Downloaded 14413723 bytes. 04:15:51 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:15:51 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-51.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:15:51 INFO - Return code: 0 04:15:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:51 INFO - trying https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:15:51 INFO - Downloading https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/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 04:15:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/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 04:15:53 INFO - Downloaded 59965077 bytes. 04:15:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:15:53 INFO - mkdir: /builds/slave/test/properties 04:15:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:15:53 INFO - Writing to file /builds/slave/test/properties/build_url 04:15:53 INFO - Contents: 04:15:53 INFO - build_url:https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 04:15:53 INFO - Running post-action listener: _resource_record_post_action 04:15:53 INFO - Running post-action listener: set_extra_try_arguments 04:15:53 INFO - [mozharness: 2016-08-07 11:15:53.879899Z] Finished download-and-extract step (success) 04:15:53 INFO - [mozharness: 2016-08-07 11:15:53.880134Z] Running populate-webroot step. 04:15:53 INFO - Running pre-action listener: _resource_record_pre_action 04:15:53 INFO - Running main action method: populate_webroot 04:15:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:15:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:15:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:15:53 INFO - '--tppagecycles', 04:15:53 INFO - '7'], 04:15:53 INFO - 'tests': ['tsvgm']}}, 04:15:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:15:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:15:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:15:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:15:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:15:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:15:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:53 INFO - 'talos_options': ['--disable-e10s'], 04:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:53 INFO - 'talos_options': ['--disable-e10s'], 04:15:53 INFO - 'tests': ['damp', 'tps']}, 04:15:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:53 INFO - 'tests': ['damp', 'tps']}, 04:15:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:15:53 INFO - 'tests': ['dromaeo_dom']}, 04:15:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:15:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:15:53 INFO - 'tests': ['basic_compositor_video']}, 04:15:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:15:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:15:53 INFO - 'tests': ['a11yr', 04:15:53 INFO - 'ts_paint', 04:15:53 INFO - 'tpaint', 04:15:53 INFO - 'sessionrestore', 04:15:53 INFO - 'sessionrestore_no_auto_restore', 04:15:53 INFO - 'tabpaint']}, 04:15:53 INFO - 'other-e10s': {'tests': ['a11yr', 04:15:53 INFO - 'ts_paint', 04:15:53 INFO - 'tpaint', 04:15:53 INFO - 'sessionrestore', 04:15:53 INFO - 'sessionrestore_no_auto_restore', 04:15:53 INFO - 'tabpaint']}, 04:15:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:15:53 INFO - 'ts_paint', 04:15:53 INFO - 'tpaint', 04:15:53 INFO - 'sessionrestore', 04:15:53 INFO - 'sessionrestore_no_auto_restore', 04:15:53 INFO - 'tabpaint']}, 04:15:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:15:53 INFO - 'ts_paint', 04:15:53 INFO - 'tpaint', 04:15:53 INFO - 'sessionrestore', 04:15:53 INFO - 'sessionrestore_no_auto_restore', 04:15:53 INFO - 'tabpaint']}, 04:15:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:15:53 INFO - 'tests': ['a11yr', 04:15:53 INFO - 'ts_paint', 04:15:53 INFO - 'tpaint', 04:15:53 INFO - 'sessionrestore', 04:15:53 INFO - 'sessionrestore_no_auto_restore', 04:15:53 INFO - 'tabpaint']}, 04:15:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:15:53 INFO - 'tests': ['a11yr', 04:15:53 INFO - 'ts_paint', 04:15:53 INFO - 'tpaint', 04:15:53 INFO - 'sessionrestore', 04:15:53 INFO - 'sessionrestore_no_auto_restore', 04:15:53 INFO - 'tabpaint']}, 04:15:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:15:53 INFO - 'tests': ['tsvgx', 04:15:53 INFO - 'tsvgr_opacity', 04:15:53 INFO - 'tart', 04:15:53 INFO - 'tscrollx', 04:15:53 INFO - 'cart']}, 04:15:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:15:53 INFO - 'tsvgr_opacity', 04:15:53 INFO - 'tart', 04:15:53 INFO - 'tscrollx', 04:15:53 INFO - 'cart']}, 04:15:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:53 INFO - 'talos_options': ['--disable-e10s'], 04:15:53 INFO - 'tests': ['tp5o']}, 04:15:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:53 INFO - 'tests': ['tp5o']}, 04:15:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:53 INFO - 'talos_options': ['--disable-e10s', 04:15:53 INFO - '--xperf_path', 04:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:53 INFO - 'tests': ['tp5n']}, 04:15:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:53 INFO - 'talos_options': ['--xperf_path', 04:15:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:53 INFO - 'tests': ['tp5n']}}, 04:15:53 INFO - 'talos.zip': {'path': '', 04:15:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:15:53 INFO - Running post-action listener: _resource_record_post_action 04:15:53 INFO - [mozharness: 2016-08-07 11:15:53.899633Z] Finished populate-webroot step (success) 04:15:53 INFO - [mozharness: 2016-08-07 11:15:53.899722Z] Running create-virtualenv step. 04:15:53 INFO - Running pre-action listener: _resource_record_pre_action 04:15:53 INFO - Running main action method: create_virtualenv 04:15:53 INFO - Creating virtualenv /builds/slave/test/build/venv 04:15:53 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:15:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:15:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:15:53 INFO - Using real prefix '/usr' 04:15:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:15:54 INFO - Installing distribute.............................................................................................................................................................................................done. 04:15:56 INFO - Installing pip.................done. 04:15:56 INFO - Return code: 0 04:15:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d093b0>, '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 0x1d0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:15:56 INFO - Using env: {'DISPLAY': ':0', 04:15:56 INFO - 'HOME': '/home/cltbld', 04:15:56 INFO - 'LANG': 'en_US.UTF-8', 04:15:56 INFO - 'LANGUAGE': 'en_US:en', 04:15:56 INFO - 'LOGNAME': 'cltbld', 04:15:56 INFO - 'MAIL': '/var/mail/cltbld', 04:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:56 INFO - 'MOZ_NO_REMOTE': '1', 04:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:56 INFO - 'NO_EM_RESTART': '1', 04:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:56 INFO - 'PWD': '/builds/slave/test', 04:15:56 INFO - 'SHELL': '/bin/bash', 04:15:56 INFO - 'SHLVL': '1', 04:15:56 INFO - 'TERM': 'linux', 04:15:56 INFO - 'TMOUT': '86400', 04:15:56 INFO - 'USER': 'cltbld', 04:15:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 04:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:56 INFO - '_': '/tools/buildbot/bin/python'} 04:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:56 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:15:56 INFO - Cleaning up... 04:15:56 INFO - Return code: 0 04:15:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d093b0>, '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 0x1d0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:15:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:15:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:15:56 INFO - Using env: {'DISPLAY': ':0', 04:15:56 INFO - 'HOME': '/home/cltbld', 04:15:56 INFO - 'LANG': 'en_US.UTF-8', 04:15:56 INFO - 'LANGUAGE': 'en_US:en', 04:15:56 INFO - 'LOGNAME': 'cltbld', 04:15:56 INFO - 'MAIL': '/var/mail/cltbld', 04:15:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:56 INFO - 'MOZ_NO_REMOTE': '1', 04:15:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:56 INFO - 'NO_EM_RESTART': '1', 04:15:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:56 INFO - 'PWD': '/builds/slave/test', 04:15:56 INFO - 'SHELL': '/bin/bash', 04:15:56 INFO - 'SHLVL': '1', 04:15:56 INFO - 'TERM': 'linux', 04:15:56 INFO - 'TMOUT': '86400', 04:15:56 INFO - 'USER': 'cltbld', 04:15:56 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 04:15:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:56 INFO - '_': '/tools/buildbot/bin/python'} 04:15:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:56 INFO - Downloading/unpacking psutil>=3.1.1 04:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:15:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:58 INFO - Installing collected packages: psutil 04:15:58 INFO - Running setup.py install for psutil 04:15:59 INFO - building 'psutil._psutil_linux' extension 04:15:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:15:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:15:59 INFO - building 'psutil._psutil_posix' extension 04:15:59 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:15:59 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:15:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:59 INFO - Successfully installed psutil 04:15:59 INFO - Cleaning up... 04:15:59 INFO - Return code: 0 04:15:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:15:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1a4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d093b0>, '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 0x1d0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:15:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:15:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:15:59 INFO - Using env: {'DISPLAY': ':0', 04:15:59 INFO - 'HOME': '/home/cltbld', 04:15:59 INFO - 'LANG': 'en_US.UTF-8', 04:15:59 INFO - 'LANGUAGE': 'en_US:en', 04:15:59 INFO - 'LOGNAME': 'cltbld', 04:15:59 INFO - 'MAIL': '/var/mail/cltbld', 04:15:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:59 INFO - 'MOZ_NO_REMOTE': '1', 04:15:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:59 INFO - 'NO_EM_RESTART': '1', 04:15:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:59 INFO - 'PWD': '/builds/slave/test', 04:15:59 INFO - 'SHELL': '/bin/bash', 04:15:59 INFO - 'SHLVL': '1', 04:15:59 INFO - 'TERM': 'linux', 04:15:59 INFO - 'TMOUT': '86400', 04:15:59 INFO - 'USER': 'cltbld', 04:15:59 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 04:15:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:59 INFO - '_': '/tools/buildbot/bin/python'} 04:15:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:16:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:16:01 INFO - Installing collected packages: mozsystemmonitor 04:16:01 INFO - Running setup.py install for mozsystemmonitor 04:16:01 INFO - Successfully installed mozsystemmonitor 04:16:01 INFO - Cleaning up... 04:16:01 INFO - Return code: 0 04:16:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1a4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d093b0>, '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 0x1d0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:16:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:16:01 INFO - Using env: {'DISPLAY': ':0', 04:16:01 INFO - 'HOME': '/home/cltbld', 04:16:01 INFO - 'LANG': 'en_US.UTF-8', 04:16:01 INFO - 'LANGUAGE': 'en_US:en', 04:16:01 INFO - 'LOGNAME': 'cltbld', 04:16:01 INFO - 'MAIL': '/var/mail/cltbld', 04:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:01 INFO - 'MOZ_NO_REMOTE': '1', 04:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:01 INFO - 'NO_EM_RESTART': '1', 04:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:01 INFO - 'PWD': '/builds/slave/test', 04:16:01 INFO - 'SHELL': '/bin/bash', 04:16:01 INFO - 'SHLVL': '1', 04:16:01 INFO - 'TERM': 'linux', 04:16:01 INFO - 'TMOUT': '86400', 04:16:01 INFO - 'USER': 'cltbld', 04:16:01 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 04:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:01 INFO - '_': '/tools/buildbot/bin/python'} 04:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:01 INFO - Downloading/unpacking jsonschema==2.5.1 04:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:16:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:16:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:16:04 INFO - warning: no files found matching '*.txt' 04:16:04 INFO - no previously-included directories found matching 'build' 04:16:04 INFO - no previously-included directories found matching 'dist' 04:16:04 INFO - no previously-included directories found matching '.git*' 04:16:04 INFO - Installing collected packages: jsonschema, functools32 04:16:04 INFO - Running setup.py install for functools32 04:16:04 INFO - warning: no files found matching '*.txt' 04:16:04 INFO - no previously-included directories found matching 'build' 04:16:04 INFO - no previously-included directories found matching 'dist' 04:16:04 INFO - no previously-included directories found matching '.git*' 04:16:04 INFO - Successfully installed jsonschema functools32 04:16:04 INFO - Cleaning up... 04:16:04 INFO - Return code: 0 04:16:04 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:16:04 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')]} 04:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:04 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')]} 04:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:04 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 0x1a4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d093b0>, '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 0x1d0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:04 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 04:16:04 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 04:16:04 INFO - Using env: {'DISPLAY': ':0', 04:16:04 INFO - 'HOME': '/home/cltbld', 04:16:04 INFO - 'LANG': 'en_US.UTF-8', 04:16:04 INFO - 'LANGUAGE': 'en_US:en', 04:16:04 INFO - 'LOGNAME': 'cltbld', 04:16:04 INFO - 'MAIL': '/var/mail/cltbld', 04:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:04 INFO - 'MOZ_NO_REMOTE': '1', 04:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:04 INFO - 'NO_EM_RESTART': '1', 04:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:04 INFO - 'PWD': '/builds/slave/test', 04:16:04 INFO - 'SHELL': '/bin/bash', 04:16:04 INFO - 'SHLVL': '1', 04:16:04 INFO - 'TERM': 'linux', 04:16:04 INFO - 'TMOUT': '86400', 04:16:04 INFO - 'USER': 'cltbld', 04:16:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 04:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:04 INFO - '_': '/tools/buildbot/bin/python'} 04:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:04 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:16:04 INFO - Cleaning up... 04:16:04 INFO - Return code: 0 04:16:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:16:04 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')]} 04:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:04 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')]} 04:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:04 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 0x1a4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d093b0>, '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 0x1d0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:16:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:16:04 INFO - Using env: {'DISPLAY': ':0', 04:16:04 INFO - 'HOME': '/home/cltbld', 04:16:04 INFO - 'LANG': 'en_US.UTF-8', 04:16:04 INFO - 'LANGUAGE': 'en_US:en', 04:16:04 INFO - 'LOGNAME': 'cltbld', 04:16:04 INFO - 'MAIL': '/var/mail/cltbld', 04:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:04 INFO - 'MOZ_NO_REMOTE': '1', 04:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:04 INFO - 'NO_EM_RESTART': '1', 04:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:04 INFO - 'PWD': '/builds/slave/test', 04:16:04 INFO - 'SHELL': '/bin/bash', 04:16:04 INFO - 'SHLVL': '1', 04:16:04 INFO - 'TERM': 'linux', 04:16:04 INFO - 'TMOUT': '86400', 04:16:04 INFO - 'USER': 'cltbld', 04:16:04 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 04:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:04 INFO - '_': '/tools/buildbot/bin/python'} 04:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:04 INFO - Downloading/unpacking blobuploader==1.2.4 04:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:06 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:16:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:07 INFO - Downloading docopt-0.6.1.tar.gz 04:16:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:07 INFO - Running setup.py install for blobuploader 04:16:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:16:07 INFO - Running setup.py install for requests 04:16:07 INFO - Running setup.py install for docopt 04:16:07 INFO - Successfully installed blobuploader requests docopt 04:16:07 INFO - Cleaning up... 04:16:07 INFO - Return code: 0 04:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:07 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')]} 04:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:07 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')]} 04:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:07 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 0x1a4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d093b0>, '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 0x1d0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:16:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:16:07 INFO - Using env: {'DISPLAY': ':0', 04:16:07 INFO - 'HOME': '/home/cltbld', 04:16:07 INFO - 'LANG': 'en_US.UTF-8', 04:16:07 INFO - 'LANGUAGE': 'en_US:en', 04:16:07 INFO - 'LOGNAME': 'cltbld', 04:16:07 INFO - 'MAIL': '/var/mail/cltbld', 04:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:07 INFO - 'MOZ_NO_REMOTE': '1', 04:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:07 INFO - 'NO_EM_RESTART': '1', 04:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:07 INFO - 'PWD': '/builds/slave/test', 04:16:07 INFO - 'SHELL': '/bin/bash', 04:16:07 INFO - 'SHLVL': '1', 04:16:07 INFO - 'TERM': 'linux', 04:16:07 INFO - 'TMOUT': '86400', 04:16:07 INFO - 'USER': 'cltbld', 04:16:07 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 04:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:07 INFO - '_': '/tools/buildbot/bin/python'} 04:16:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:08 INFO - Running setup.py (path:/tmp/pip-AJRaEC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:08 INFO - Running setup.py (path:/tmp/pip-SegdzY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:08 INFO - Running setup.py (path:/tmp/pip-KzVx7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:08 INFO - Running setup.py (path:/tmp/pip-bAA_T3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:08 INFO - Running setup.py (path:/tmp/pip-N2w0ti-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:08 INFO - Running setup.py (path:/tmp/pip-J1Ws7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:08 INFO - Running setup.py (path:/tmp/pip-_nlMXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:08 INFO - Running setup.py (path:/tmp/pip-OCTGTN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:08 INFO - Running setup.py (path:/tmp/pip-IqHBLG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:08 INFO - Running setup.py (path:/tmp/pip-cHm4I2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:08 INFO - Running setup.py (path:/tmp/pip-uGu8CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:08 INFO - Running setup.py (path:/tmp/pip-0vR8Hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:09 INFO - Running setup.py (path:/tmp/pip-DTjZWT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:09 INFO - Running setup.py (path:/tmp/pip-ZbQ89F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:09 INFO - Running setup.py (path:/tmp/pip-4eQwuJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:09 INFO - Running setup.py (path:/tmp/pip-g1UYDJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:09 INFO - Running setup.py (path:/tmp/pip-Pxd8CE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:09 INFO - Running setup.py install for manifestparser 04:16:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:16:09 INFO - Running setup.py install for mozcrash 04:16:09 INFO - Running setup.py install for mozdebug 04:16:09 INFO - Running setup.py install for mozdevice 04:16:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:16:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:16:09 INFO - Running setup.py install for mozfile 04:16:09 INFO - Running setup.py install for mozhttpd 04:16:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Running setup.py install for mozinfo 04:16:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Running setup.py install for mozInstall 04:16:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Running setup.py install for mozleak 04:16:10 INFO - Running setup.py install for mozlog 04:16:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Running setup.py install for moznetwork 04:16:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Running setup.py install for mozprocess 04:16:10 INFO - Running setup.py install for mozprofile 04:16:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Running setup.py install for mozrunner 04:16:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:16:10 INFO - Running setup.py install for mozscreenshot 04:16:10 INFO - Running setup.py install for moztest 04:16:11 INFO - Running setup.py install for mozversion 04:16:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:16:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:16:11 INFO - Cleaning up... 04:16:11 INFO - Return code: 0 04:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:11 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 0x1a4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d093b0>, '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 0x1d0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:16:11 INFO - Using env: {'DISPLAY': ':0', 04:16:11 INFO - 'HOME': '/home/cltbld', 04:16:11 INFO - 'LANG': 'en_US.UTF-8', 04:16:11 INFO - 'LANGUAGE': 'en_US:en', 04:16:11 INFO - 'LOGNAME': 'cltbld', 04:16:11 INFO - 'MAIL': '/var/mail/cltbld', 04:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:11 INFO - 'MOZ_NO_REMOTE': '1', 04:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:11 INFO - 'NO_EM_RESTART': '1', 04:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:11 INFO - 'PWD': '/builds/slave/test', 04:16:11 INFO - 'SHELL': '/bin/bash', 04:16:11 INFO - 'SHLVL': '1', 04:16:11 INFO - 'TERM': 'linux', 04:16:11 INFO - 'TMOUT': '86400', 04:16:11 INFO - 'USER': 'cltbld', 04:16:11 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 04:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:11 INFO - '_': '/tools/buildbot/bin/python'} 04:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:11 INFO - Running setup.py (path:/tmp/pip-Zfygd0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:11 INFO - Running setup.py (path:/tmp/pip-_yYZk6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:11 INFO - Running setup.py (path:/tmp/pip-52x_6n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:11 INFO - Running setup.py (path:/tmp/pip-iYiHIc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:11 INFO - Running setup.py (path:/tmp/pip-oB_utj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:11 INFO - Running setup.py (path:/tmp/pip-MqkZ3a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:11 INFO - Running setup.py (path:/tmp/pip-dOvB5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:16:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:11 INFO - Running setup.py (path:/tmp/pip-myJ9TW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:12 INFO - Running setup.py (path:/tmp/pip-8euqzD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:12 INFO - Running setup.py (path:/tmp/pip-l_3VOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:12 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)) 04:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:12 INFO - Running setup.py (path:/tmp/pip-MfuYmz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:12 INFO - Running setup.py (path:/tmp/pip-kuHYes-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:12 INFO - Running setup.py (path:/tmp/pip-pFuzqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:12 INFO - Running setup.py (path:/tmp/pip-pN2BwF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:12 INFO - Running setup.py (path:/tmp/pip-Xt8BUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:12 INFO - Running setup.py (path:/tmp/pip-eTXWxr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:16:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:12 INFO - Running setup.py (path:/tmp/pip-WKpMM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:16:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:14 INFO - Downloading blessings-1.6.tar.gz 04:16:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:16:14 INFO - Installing collected packages: blessings 04:16:14 INFO - Running setup.py install for blessings 04:16:14 INFO - Successfully installed blessings 04:16:14 INFO - Cleaning up... 04:16:14 INFO - Return code: 0 04:16:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:16:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:14 INFO - Reading from file tmpfile_stdout 04:16:14 INFO - Current package versions: 04:16:14 INFO - argparse == 1.2.1 04:16:14 INFO - blessings == 1.6 04:16:14 INFO - blobuploader == 1.2.4 04:16:14 INFO - docopt == 0.6.1 04:16:14 INFO - functools32 == 3.2.3-2 04:16:14 INFO - jsonschema == 2.5.1 04:16:14 INFO - manifestparser == 1.1 04:16:14 INFO - mozInstall == 1.12 04:16:14 INFO - mozcrash == 0.17 04:16:14 INFO - mozdebug == 0.1 04:16:14 INFO - mozdevice == 0.48 04:16:14 INFO - mozfile == 1.2 04:16:14 INFO - mozhttpd == 0.7 04:16:14 INFO - mozinfo == 0.9 04:16:14 INFO - mozleak == 0.1 04:16:14 INFO - mozlog == 3.3 04:16:14 INFO - moznetwork == 0.27 04:16:14 INFO - mozprocess == 0.23 04:16:14 INFO - mozprofile == 0.28 04:16:14 INFO - mozrunner == 6.12 04:16:14 INFO - mozscreenshot == 0.1 04:16:14 INFO - mozsystemmonitor == 0.3 04:16:14 INFO - moztest == 0.7 04:16:14 INFO - mozversion == 1.4 04:16:14 INFO - psutil == 3.1.1 04:16:14 INFO - requests == 1.2.3 04:16:14 INFO - wsgiref == 0.1.2 04:16:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16: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')]} 04:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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')]} 04:16:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:14 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 0x1a4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d093b0>, '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 0x1d0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:16:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:16:14 INFO - Using env: {'DISPLAY': ':0', 04:16:14 INFO - 'HOME': '/home/cltbld', 04:16:14 INFO - 'LANG': 'en_US.UTF-8', 04:16:14 INFO - 'LANGUAGE': 'en_US:en', 04:16:15 INFO - 'LOGNAME': 'cltbld', 04:16:15 INFO - 'MAIL': '/var/mail/cltbld', 04:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:15 INFO - 'MOZ_NO_REMOTE': '1', 04:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:15 INFO - 'NO_EM_RESTART': '1', 04:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:15 INFO - 'PWD': '/builds/slave/test', 04:16:15 INFO - 'SHELL': '/bin/bash', 04:16:15 INFO - 'SHLVL': '1', 04:16:15 INFO - 'TERM': 'linux', 04:16:15 INFO - 'TMOUT': '86400', 04:16:15 INFO - 'USER': 'cltbld', 04:16:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 04:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:15 INFO - '_': '/tools/buildbot/bin/python'} 04:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:16:15 INFO - Cleaning up... 04:16:15 INFO - Return code: 0 04:16:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:16:15 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')]} 04:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:15 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')]} 04:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:15 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 0x1a4a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bad8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1d0b180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d093b0>, '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 0x1d0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a740>, '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': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:16:15 INFO - Using env: {'DISPLAY': ':0', 04:16:15 INFO - 'HOME': '/home/cltbld', 04:16:15 INFO - 'LANG': 'en_US.UTF-8', 04:16:15 INFO - 'LANGUAGE': 'en_US:en', 04:16:15 INFO - 'LOGNAME': 'cltbld', 04:16:15 INFO - 'MAIL': '/var/mail/cltbld', 04:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:15 INFO - 'MOZ_NO_REMOTE': '1', 04:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:15 INFO - 'NO_EM_RESTART': '1', 04:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:15 INFO - 'PWD': '/builds/slave/test', 04:16:15 INFO - 'SHELL': '/bin/bash', 04:16:15 INFO - 'SHLVL': '1', 04:16:15 INFO - 'TERM': 'linux', 04:16:15 INFO - 'TMOUT': '86400', 04:16:15 INFO - 'USER': 'cltbld', 04:16:15 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 04:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:15 INFO - '_': '/tools/buildbot/bin/python'} 04:16:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:16:15 INFO - Cleaning up... 04:16:15 INFO - Return code: 0 04:16:15 INFO - Running post-action listener: _resource_record_post_action 04:16:15 INFO - Running post-action listener: _start_resource_monitoring 04:16:15 INFO - Starting resource monitoring. 04:16:15 INFO - [mozharness: 2016-08-07 11:16:15.446942Z] Finished create-virtualenv step (success) 04:16:15 INFO - [mozharness: 2016-08-07 11:16:15.447419Z] Running install step. 04:16:15 INFO - Running pre-action listener: _resource_record_pre_action 04:16:15 INFO - Running main action method: install 04:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:15 INFO - Reading from file tmpfile_stdout 04:16:15 INFO - Detecting whether we're running mozinstall >=1.0... 04:16:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:16:15 INFO - Reading from file tmpfile_stdout 04:16:15 INFO - Output received: 04:16:15 INFO - Usage: mozinstall [options] installer 04:16:15 INFO - Options: 04:16:15 INFO - -h, --help show this help message and exit 04:16:15 INFO - -d DEST, --destination=DEST 04:16:15 INFO - Directory to install application into. [default: 04:16:15 INFO - "/builds/slave/test"] 04:16:15 INFO - --app=APP Application being installed. [default: firefox] 04:16:15 INFO - mkdir: /builds/slave/test/build/application 04:16:15 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'] 04:16:15 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 04:16:32 INFO - Reading from file tmpfile_stdout 04:16:32 INFO - Output received: 04:16:32 INFO - /builds/slave/test/build/application/firefox/firefox 04:16:32 INFO - Running post-action listener: _resource_record_post_action 04:16:32 INFO - [mozharness: 2016-08-07 11:16:32.830841Z] Finished install step (success) 04:16:32 INFO - [mozharness: 2016-08-07 11:16:32.831091Z] Running run-tests step. 04:16:32 INFO - Running pre-action listener: _resource_record_pre_action 04:16:32 INFO - Running main action method: run_tests 04:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:16:32 INFO - Python 2.7.3 04:16:32 INFO - Return code: 0 04:16:32 INFO - grabbing minidump binary from tooltool 04:16:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:16:32 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 0x1d093b0>, '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 0x1d0a2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1d0a740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:16:32 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:16:32 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:16:32 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:16:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:16:32 INFO - Return code: 0 04:16:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:16:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:16:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:16:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:16:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:16:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 04:16:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --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 04:16:32 INFO - Using env: {'DISPLAY': ':0', 04:16:32 INFO - 'HOME': '/home/cltbld', 04:16:32 INFO - 'LANG': 'en_US.UTF-8', 04:16:32 INFO - 'LANGUAGE': 'en_US:en', 04:16:32 INFO - 'LOGNAME': 'cltbld', 04:16:32 INFO - 'MAIL': '/var/mail/cltbld', 04:16:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:16:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:32 INFO - 'MOZ_NO_REMOTE': '1', 04:16:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:32 INFO - 'NO_EM_RESTART': '1', 04:16:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:32 INFO - 'PWD': '/builds/slave/test', 04:16:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:16:32 INFO - 'SHELL': '/bin/bash', 04:16:32 INFO - 'SHLVL': '1', 04:16:32 INFO - 'TERM': 'linux', 04:16:32 INFO - 'TMOUT': '86400', 04:16:32 INFO - 'USER': 'cltbld', 04:16:32 INFO - 'XDG_SESSION_COOKIE': '6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025', 04:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:32 INFO - '_': '/tools/buildbot/bin/python'} 04:16:32 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--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 04:16:33 INFO - mozversion application_buildid: 20160807013000 04:16:33 INFO - mozversion application_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 04:16:33 INFO - mozversion application_display_name: Nightly 04:16:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:16:33 INFO - mozversion application_name: Firefox 04:16:33 INFO - mozversion application_remotingname: firefox 04:16:33 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:16:33 INFO - mozversion application_vendor: Mozilla 04:16:33 INFO - mozversion application_version: 51.0a1 04:16:33 INFO - mozversion platform_buildid: 20160807013000 04:16:33 INFO - mozversion platform_changeset: d42aacfe34af25e2f5110e2ca3d24a210eabeb33 04:16:33 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:16:33 INFO - mozversion platform_version: 51.0a1 04:16:33 INFO - using testdate: 1470568593 04:16:33 INFO - actual date: 1470568593 04:16:33 INFO - starting webserver on 'localhost:48749' 04:16:33 INFO - SUITE-START | Running 2 tests 04:16:33 INFO - TEST-START | dromaeo_css 04:16:33 INFO - operating with platform_type : linux_ 04:16:33 INFO - Initialising browser for dromaeo_css test... 04:16:33 INFO - TEST-INFO | started process 13438 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyMP64h/profile http://localhost:48749/getInfo.html) 04:16:36 INFO - PROCESS | 13438 | __metrics Screen width/height:1600/1200 04:16:36 INFO - PROCESS | 13438 | colorDepth:24 04:16:36 INFO - PROCESS | 13438 | Browser inner width/height: 1024/697 04:16:36 INFO - PROCESS | 13438 | __metrics 04:16:37 INFO - PROCESS | 13438 | 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" 04:16:37 INFO - PROCESS | 13438 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:16:38 INFO - TEST-INFO | 13438: exit 0 04:16:38 INFO - Browser initialized. 04:16:38 INFO - Running cycle 1/1 for dromaeo_css test... 04:16:38 INFO - TEST-INFO | started process 13523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyMP64h/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:16:50 INFO - PROCESS | 13523 | RSS: Main: 156561408 04:16:50 INFO - PROCESS | 13523 | 04:17:42 INFO - PROCESS | 13523 | 1470568662249 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:19:51 INFO - PROCESS | 13523 | Cycle 1(1): loaded http://localhost:48749/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48749/tests/dromaeo/cssquery-ext.html) 04:19:52 INFO - PROCESS | 13523 | RSS: Main: 262303744 04:19:52 INFO - PROCESS | 13523 | 04:22:54 INFO - PROCESS | 13523 | Cycle 1(1): loaded http://localhost:48749/tests/dromaeo/cssquery-ext.html (next: http://localhost:48749/tests/dromaeo/cssquery-jquery.html) 04:22:55 INFO - PROCESS | 13523 | RSS: Main: 242368512 04:22:55 INFO - PROCESS | 13523 | 04:25:57 INFO - PROCESS | 13523 | Cycle 1(1): loaded http://localhost:48749/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48749/tests/dromaeo/cssquery-mootools.html) 04:25:58 INFO - PROCESS | 13523 | RSS: Main: 186855424 04:25:58 INFO - PROCESS | 13523 | 04:29:00 INFO - PROCESS | 13523 | Cycle 1(1): loaded http://localhost:48749/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48749/tests/dromaeo/cssquery-prototype.html) 04:29:00 INFO - PROCESS | 13523 | RSS: Main: 232656896 04:29:00 INFO - PROCESS | 13523 | 04:32:03 INFO - PROCESS | 13523 | Cycle 1(1): loaded http://localhost:48749/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48749/tests/dromaeo/cssquery-yui.html) 04:32:04 INFO - PROCESS | 13523 | RSS: Main: 188006400 04:32:04 INFO - PROCESS | 13523 | 04:35:07 INFO - PROCESS | 13523 | Cycle 1(1): loaded http://localhost:48749/tests/dromaeo/cssquery-yui.html (next: http://localhost:48749/tests/dromaeo/cssquery-dojo.html) 04:35:07 INFO - PROCESS | 13523 | RSS: Main: 276561920 04:35:07 INFO - PROCESS | 13523 | 04:35:07 INFO - PROCESS | 13523 | __start_tp_report 04:35:07 INFO - PROCESS | 13523 | _x_x_mozilla_page_load 04:35:07 INFO - PROCESS | 13523 | _x_x_mozilla_page_load_details 04:35:07 INFO - PROCESS | 13523 | |i|pagename|runs| 04:35:07 INFO - PROCESS | 13523 | |0;dojo.html;3063.5098384258517;3066.064850220682;3097.907062788114;3119.7036281553246;3120.219945013746;5134.614903882205;5200.921986170201;5239.1093514102595;5292.153255479119;5297.178937264725;5273.18265668821;5303.522682958533;5342;5374.140137577979;5390.973045134779;4746.311784791212;4813.7593120343845;4856.417229932413;4863.051704917542;4968.254761785743;4869.820606445467;4879.585235255007;4907.0921879452235;4933.33399991002;4946;4712.481627021025;4736.360591320162;4752.9762351188365;4760.143174228638;4860.611151107921;4764.595009424169;4772.379590653193;4776;4823.03539292143;4861.246506791453;4778.498257682928;4791.688540244908;4809.663323567352;4854.247591623304;4861.708297502161;5135.3324067870935;5244.160934250502;5316.308879845634;5326.067938110854;5358.196270559409;5639.436056394327;5666.5183459406;5667.319921609392;5728.484436400702;5731.770729170828;5703.62926409782;5764.769409223626;5766.336871259817;5770.134479828017;5771.971140144315;5120.2831603575905;5219.243209734567;5292.9206061908335;5332.786688532454;5387.380451248117;5772.6536407815665;5784.1902133701315;5824.359320474744;5830.82507524775;5838.912416313674;5557.749901254453;5561.499465048084;5604.8038318658655;5611.607187496836;5615.410381909841;5520.641158324776;5620.241267428926;5637.379888212294;5669.348024977098;5681.289838770153;5677.37548869624;5684.829455116271;5685.118806584986;5720.713964301768;5734.369219385864;5635.5773317001385;5672.716364181774;5676.318841739017;5680.914786278209;5690.516306113944;4284.592963668447;4289.463817022872;4336.609705126553;4393.912121757547;4433.933490997638;3868.2843673920415;3874.3219936511;3884.495015648004;3899.2006638639577;3947.605239476087;5351.518363347317;5354.759035843396;5357.517823395913;5361.544268737123;5420.322459692538;5419.701916394636;5547.140193269969;5575.498205161555;5630.211770352154;5666.546676265889;5377.865553361197;5401.432849550819;5403.48666876654;5435.891282174413;5453.23654688344;4914;4923.950760492421;4927.162382395001;4937.506249375034;4971.825986090469;5735.541156707453;5845.7369418376275;5911.3201981772645;5915.556333275022;5916.408359164049;5700.315962084411;5714;5730.828075157752;5744.396838332083;5748.080307150836;5937.228160339128;5943.049112142036;5950.613210141327;5950.613210141327;5970.283565972111;5407.297051383295;5550.306211723535;5559.11054231321;5636.210930469655;5638.041532939492;5659.745311461076;5667.4332566743;5712.714364281686;5745.511631511201;5749.051406518045;5558.749856256397;5564.4713752193475;5568.470995255444;5569.303837020372;5572.498475137257;5286.259923610774;5485.204645326326;5562.082256427644;5563.082091454865;5564.638298510584;5432.728363581884;5480.780768769364;5500.312460942382;5537.833864984057;5538.363088244903;5575.358833734173;5586.804461843816;5621.8594535136945;5625.521830644441;5635.239242702182;5314.707691077027;5323.6273460857365;5457.7271136443815;5464;5472.042392581362 04:35:07 INFO - PROCESS | 13523 | |1;ext.html;572.3046498504316;585.1135529672547;609.7743834781131;613.7391608566361;636.9840105032472;42140.78929605352;43398.34902476461;43454.565454345444;43471.56528434718;46837;43930.780346098225;44484.332735009004;44555.3316700249;44565.331520027146;44581.108377832505;8987.236084932772;9155.908440915573;9174.08259174084;9182.357234993553;9183.540822958825;9009;9072.63709451621;9096.590653420579;9098.727038188865;9098.863517047217;9133.771655708593;9185.678501252458;9187.35688501805;9192.31057670674;9193.724188274362;9093.863267091614;9131.680391186277;9141.908580914172;9146.131117543822;9146.634134634607;9014.188723014895;9045.321600879895;9082.22801061904;9094.408863423856;9099;43297.78351108224;43532.56467435317;43568.782156089015;43685.78157109226;43764.343534847;3478.0783092480515;3936.252112098692;4092.0383709828166;4274.166537525184;4444.933326000112;32463;32506.512402313983;32608.836955815306;32681.346373072407;32954;4306.2894622387585;4349.9130017399475;4448.154850578379;4530.982975182713;4573.47405048417;371074;371307;373239;374414;375779;59357;59612.70193649091;59685;60059.69373215837;60121.398786012454;61052.389476105556;61113.38886611166;61126.0831087534;61172.69413652903;61228.693856531325;16958.321667133423;17245.827541724422;17247.65504689899;17248.741268880978;17251.3962011329;13498.257595832323;13565.321733913264;13588.524401645895;13589.796153057712;13597.252151131783;13004.869951300556;16076.598085047968;16227.594310142342;16462.506124816275;16844.915775421043;5266.157414813688;6114.847128821815;6203.844903877349;6328.335524769833;6329.177206963157;1057.391999600233;1074.4176088980505;1110.4947249001684;1152.6426807689643;1155.0470861539095;31540.89606863749;32988.835055824566;33267;33301.83349083239;34061.318773624385;1112.3659514076899;1125.6285425809463;1205.2045649871043;1213.308414203913;1231.1382032577233;16913.7462938056;17367;17395.65208695819;17437;17476.650466990843;511896;516533;517439.953602785;520765;525211;60363.09455358173;60431;60703;60793.39206607966;60811.39188608146;1248.1886773597234;1366.2144267046488;1381.4750394849893;1390.32569203936;1414.1161773891113;32337;33964.49053264154;34009.31981360408;34125.14687132841;34333.28333583261;51321;51680.483195167566;51956.480435196674;51971.48028519667;52085;412240;417993;419241;419396;419425.22299107694;27554.5866812002;28162.155135345973;28647.713522864506;28728;28885.85557072201;44824;49707.751461242464;49874;49880.750596246784;49882.75058624684;41027.38458923059;41039.794801025804;41228.79385603053;42449.78775106105;42578.57421425746;41007.38488922728;41287;41629.58370416378;41859.372109417774;42385;41823.58176418319;42703.78648106864;42945.35581966335;43031.7848410756;43108.353374698774;35510.82244588761;37039.25921481609;37270;37296.44055339226;37447.625523745504;28267.43465130727;28347.375824965962;28353.432931340845;28404.289892752848;28529 04:35:07 INFO - PROCESS | 13523 | |2;jquery.html;377.1438833847165;388.6676891257976;389.6532086443065;392.2273121949758;427.78610694652673;14380;14437.422503099877;18818.90590547049;19605;19607.607847843035;18948;19057.428277151706;19314.710279345785;19352.806471935277;19986;5670.659760414368;5768.36547979724;5817.098349755774;5825.184474173598;5835.941640583604;5680.091185410335;5686.31764188298;5786.334571524287;5813.796517121901;5814.97092514539;5707.058335374658;5789.189513468118;5790.71046447676;5791.478766910977;5799.159121927318;5603.8879222415735;5721.828345149632;5753.223314852483;5759.913601295984;5761.884762304751;5130.486951304877;5158.561522270612;5204.661696989683;5208.218767184915;5353.116735738598;14427.567172984827;14683.412663493447;15751;23573.17493887723;23981.40046498834;2252.5157091225465;2385.2486466762916;2551.630013648011;2563.8205325627214;2896.5799959005826;10777.407242601654;11870.643880683507;12622.116451848375;13850.445982160702;15455.608995190487;1878.1642169234697;1924.6728056230334;1991.2632326039313;1998.9910140309041;2011.2055737983414;67174.3282567173;68870;81008;83795.5810220945;85106;10683.786324273626;11148.777024459627;11219.382933938712;11266.94366528162;11373.260738052;15781.526554203392;16066.116363600115;16186.59533511648;16187.514374568545;16231.756523652155;7454.329110379983;7744;8348.123447038095;8411.957940210259;8470.915290847135;8000.679972801139;8129.065157506844;8239.176082391712;8378.874316885252;8399.580020998925;4828.5412885775795;4837.4920633332995;4910.091633047898;4914.911162755814;5021;1913.3016448996295;1977.20911635347;2009.6282187795011;2026.432598872318;2027.1587291274252;949.5632009275672;959.7456673981401;971.4754032822196;1001.3641337750436;1066.898644628759;19501;19510.317138900355;20041.298554550813;20172.29396971128;21021.369358919255;947.5593848860314;952.7284723853669;984.8128855517572;988.2113374791506;988.7379844341111;10777.515011824487;11330.150238732129;11460.484278207501;11461;11525.654230373102;491893;494530;507171;516068;517566;89391;89393.55303223443;93365.066349337;95430;96180.51909740547;948.1135138645388;958.1472489484504;983.3902980152351;992.1715367668078;999.8300288950895;15428.537143885702;18604.906975465037;18702.675290970874;18945.14746836368;19107;29645.407091858473;35465.468017979234;37820.810895945346;42003.159936801705;42141.94645133896;57811.710941445024;58555.41444585499;59228.40771592229;59754.40245597489;60165.69917150386;8332.250097491255;8417.915820841958;8539.53032583189;8604.857967886514;8669.869951950852;10600.363978161335;12922.224666520038;12997;13047.412866420844;13534.661633459242;11204.71988200269;11616.709582260173;11746.882531174579;11779.469923853276;12016.879831201577;11245.71885702864;11468.483918223534;11542.480588373375;11709.180357374902;11768;11851.644450666494;11927;11982.760344793229;11998.460069296729;12062.879371206176;8421.578921054046;8503.016120904367;8551.572421378782;8586.098459661895;8808.471491710518;10368.740781480523;11287.322760634388;11540.711482213012;11758.764824703287;11901.583444579399 04:35:07 INFO - PROCESS | 13523 | |3;mootools.html;1444.8627380398862;1501.3694248415666;1628.3079691131265;1723.241773619608;1768.0629266488766;8405.117462666416;9150.405223660457;9154.176124148826;9156.496392698398;9176.587053582589;7512.737054203104;8713.477191368507;8895.644174233039;8960.507172105532;8973.282137429007;2329.126577533425;2366.715994080713;2372.4306166519996;2373.003338597793;2373.620220764678;2382.3686723018413;2395.8682272475007;2419.2379400488876;2427.077710470028;2427.3082171581104;2067.7001834733956;2125.2349154304516;2127.2341956895507;2130.0734180631475;2322.3381336319153;2352.188494969241;2378.4410663494064;2380.7976322012564;2386.4391867911027;2389.2712722619594;2362.055177928842;2363.4564050268536;2367.597508423572;2395.2814155753376;2403.327068420845;8989.056149104315;9041.276697864156;9047.773805654846;9058.23005044572;9066.77333066672;5344;5459.3994660587305;5513.807016754435;5521.089020311644;5521.861953451155;3326.203889054756;3393.5927688677516;3487.982560087183;3497.667721566447;3498.667626575497;1057.5928267617023;1122.6183097746805;1123.0061395664814;2143.839212059086;2216.8004879560754;12437.440315185839;12506.687332816662;12549.058820588401;12591.874081259162;12597;4469.642428605704;4682.976585117052;4767.809287628456;4798.352222449925;4812.06164797861;10007.399556026661;10014.849777253346;10018.74953126163;10031.498425078717;10040.447775372279;5387.191921211771;5395.05586522357;5407.378151512547;5409.594280428983;5411.78352865881;4975.601951843843;4985.925211121836;5038.244263360525;5040.092783298968;5077.593792496591;3791.431285307226;3827.158025234444;3859.7684138951754;3868.709846761504;3929.724919255682;1153.936533490666;1155.8786327435666;1160.228448082016;1161.8083016302216;1185.869554349021;868.843608150539;966.4153187321709;984.640606178754;996.9601215951426;1000.1698590170141;6015.127806468037;6213.440790328892;6248.218972628421;6315.305316415191;6386.808395748135;433.1056368598833;453.25892166307665;459.9172149013143;466.7642840365594;472.5274725274725;4152.065785198306;4267.594578515036;4320.719153255029;4391.648668106608;4404.493483249404;10857.782844343226;11331.716707082389;11343.20597558163;11352.48913798881;11353.205275630626;9879.604815807432;10262.025107614765;10293.794124117476;10554.419506927192;10556.524956376981;8271.710490132937;8471.279941204943;8486.957565212135;8491.278241349555;8500.14998500145;6202.906956395567;6425.325340839145;6507.609543427409;6549;6598.571092878948;9489.572969216264;10450.843237351293;10462.529186186488;10475.109615682448;10551.208659350426;9982.950085249528;10147.34042287249;10183.33808302458;10251.948740256252;10252.58989640406;7940.761777146695;7957.8408431832195;8090.1909809018625;8092.150324216108;8155.10293867686;8506.872396914176;8729.083446238308;8732.388732788644;8740.694075707319;8746.344024198337;7648.961755191189;7749.496282741604;7947.364210863233;7952.84094318122;8164.550949697824;7353.742619008309;7639.274268944441;7717.151113377637;7736.690532378641;7866.9213307866185;7016.964915175391;7132.643367831692;7135.607541585263;7140.857182856417;7141.214466408587;5320.866978325573;5388.218708287355;5416.4041955385665;5423.728813559385;5636.577256705846;5264.605154613496;5293.576513878804;5329.54698850602;5403.270558474713;5491.7254137292175 04:35:07 INFO - PROCESS | 13523 | |4;prototype.html;316.08020659879753;331.1225450832267;341.14202780008276;347.6176206173209;353.8779121203184;5146.639735218531;5239.816606418781;5241.528262456378;5268.762905669245;5277.182036784295;4940.555350018498;5155.226715992603;5228.843134705955;5228.921566176501;5232.45059268777;4131.690123240754;4136.544980052192;4147;4151.460310159675;4181.707280490367;3964.920701585981;4007.438958545806;4129.566395528472;4132.152908653718;4134.524529679095;4093.4269202311702;4108.77401742904;4111.650509706678;4115.847562682454;4116.320807066831;4088.10061786408;4106.342985122366;4106.77412742299;4109.363048727452;4114.19773144237;3513.3149035938004;3678.4114541673202;3680.963190368089;3687.8340474678703;3699.7595156314756;5062.417821950486;5076.263941728429;5097.133487307166;5101.13280742271;5103.591712662978;4705.858824235244;4713.326768997025;4728.69263497875;4732.550407711262;4733.431988161408;5135.512126347991;5392.730363481849;5410.188471729232;5414.29614150158;5436.184572314145;4061.756294622332;4066.1867626474527;4070.816813243411;4074.1647962167685;4076.7961601920083;5583.6928968906695;5617.41017193197;5644.858878528029;5646.237757902672;5651.982643124236;3979.2837289287627;4054.4526488923616;4109.815058322382;4119.958800411958;4121.155163191538;4080.326746086922;4107.199096176217;4109.506859176918;4119.340905455173;4136.193442278787;4487.798049087799;4567.10941366437;4679.204535229019;4687.554682305175;4690.437147542317;5429.239906413105;5459.781608735606;5461.15352120422;5466.262054622654;5468.48049435303;1417;1436.4828661681786;1451.9201443920686;1452.7457694903349;1453.4331610671848;936.2743873498093;952.4808979106404;955.600045932698;961.1397798970022;967.2407160379069;4681.438227412732;4693.624510039189;4695.835645752382;4700.435947686299;4710.6702530823195;4901.460839307673;4903.719770306824;4911.803527858917;4916.459189489154;4938.654294199443;4680.321353403738;4711.717296962193;4930.531599498042;5317.627766056339;5339.679619222859;2941.9852900735787;2952.9114126576237;2956.7782416318864;2969.6733359330456;2969.930824903033;5673.659580425187;5848.684046089681;5853.824385268449;5862.8534286642325;5873.148393482921;5677.943220567824;5683.5737319700365;5723.656580605177;5736.68448235351;5751.798687045934;5797.8550536236935;5800.114962637244;5822.679752613647;5847.707614619252;5883.970580147072;5334.973325133349;5413.404525502113;5532.336119665666;5558.610897237317;5571.05292100352;5490.149026900836;5519.116941289374;5524.2046334940505;5534.52956498686;5534.861628459321;5813.680247586254;5820.912686309624;5827.562932779973;5832.300123985149;5832.795852145155;3850.9397472352157;4026.6913253192242;4058.6550143238155;4059.918801623892;4077.612626800449;5370.864434385423;5471.826340722292;5586.13414920688;5594.440555944536;5607.327120745536;5466.617336786387;5471.343438787212;5473.917891231555;5474.616776825584;5478.945210547843;5403.621746477709;5451.672899626035;5456.699881506555;5459.69971651563;5471.835844924659;5191.558717509054;5302.628815982845;5381.434949330421;5388.595855310946;5391.379991300893;5438.45615438453;5477.589180811376;5478.123500239943;5485.835424937259;5492.258545096521;5206.297149884717;5312.015988008993;5357.330333708286;5367.409584945731;5370.704611246419 04:35:07 INFO - PROCESS | 13523 | |5;yui.html;747.9513831600947;764.8737958236891;768.6118510152372;797.2107613462672;799.956002419867;16118.51644450667;16538.751918721227;16645.66708665826;16657.25042373093;16852.241649125786;14100.224487653175;14184.503542376018;15670.529884103467;16001.759973600376;16169.191540422991;820.2125959079276;837.8282452097305;839.9328053755685;840.155643578203;840.9285210757063;676.3439463720208;808.6280311056921;831.476170012894;833.8123922117505;840.2983508770184;860.6170254236868;865.4763867859948;867.5185272173941;867.9739607811775;869.0917990699734;861.9698310559131;864.4208380385094;864.4813112132733;865.074370423647;865.1219012702112;516.0968305465435;524.8215606693742;526.662935721135;612.773273888664;623.9719212635442;13025.674358141028;13127.671808204776;13161.86838131616;13162.407691653898;13230.404631791593;13211.603651890362;13747.243901585409;13811.723765524734;13845.930770346184;14062.367193476319;12044.397780111047;12451.93774031133;12483.750324993449;12583.811242831365;12909.225446473149;4181.184668989548;4275.8075886585175;4290.635295999844;4358.869233922987;4360.324149756792;78907.60546197233;79146;80162;85242;85422.57288713641;10819.56721731122;11018.50416731249;11643.126765492621;12129.696757580954;12201.267923924594;18872.056397180088;19026.61946761057;19028;19032.238710451704;19186.13662385196;8338.62476188573;8490.872636910452;8575.099614540384;8644.654213831376;8664.566771661517;4730.550597693214;4904.215325547895;4974.726390048582;5004.649674522749;5033.295338652591;3458.723302135823;3563.1448452371246;3567;3570.553680789901;3573.3210689968823;575.7869588252373;580.7212537981708;586.9002269614176;587.538782056084;589.9941000589939;659.6543052173608;689.6344937183301;703.4829400390709;712.7861641507527;759.343168159549;8839.29285657146;9166.251618687173;9409.161055342509;9874.308798384043;10046.111832385792;620.6462316479654;648.9740410383532;676.82064252973;691.4330249195611;729.9452541059442;4382.846600368972;4558.361829343895;4597.3793537872625;4682.6253899687945;4718.598919091847;74523;76935.61532192415;110864.4456777711;124162.37918810348;131826;107850;109523;110431;111198;117156;95690;95976.52011739896;96846.51576742071;97890;99526.5023674877;8929.330300227379;9009.414388065017;9044.186023257938;9134.817303653757;9343.29925255595;52778.47221527889;54075;55635.60910977258;56633.71683141558;57934;66731.33268667251;77868.60248276405;83461.58269208614;84211;84281.57859210664;11445.599404020819;11877.8122187784;13210.348706411698;13363;14102.083364581269;13139.540116096274;13497.46010159622;14092.718145637235;14323.57029289123;15534.300956457213;14834.925825371236;14857.554273371816;14897.47858824936;15136.957942363393;15469.303881325142;11556.826647600124;13834.446622135001;14218.928905355408;14259.215743134228;14756.262186890397;13448;13536.864631353561;13662.590122296348;13715.862841371458;14001.369938353002;10724.195685323475;10944.179186560881;11521.769564608829;11818.645440636794;11955.402229888645;10381.429021403896;11022.643685015999;11459.369734664673;11689.707757305796;11957.521699132285 04:35:07 INFO - PROCESS | 13523 | __end_tp_report 04:35:07 INFO - PROCESS | 13523 | __start_cc_report 04:35:07 INFO - PROCESS | 13523 | _x_x_mozilla_cycle_collect,938 04:35:07 INFO - PROCESS | 13523 | __end_cc_report 04:35:07 INFO - PROCESS | 13523 | __startTimestamp1470569707436__endTimestamp 04:35:07 INFO - PROCESS | 13523 | 04:35:07 INFO - PROCESS | 13523 | ------- Summary: start ------- 04:35:07 INFO - PROCESS | 13523 | Number of tests: 6 04:35:07 INFO - PROCESS | 13523 | 04:35:07 INFO - PROCESS | 13523 | [#0] dojo.html Cycles:165 Average:5275.71 Median:5464.00 stddev:596.97 (10.9%) stddev-sans-first:573.03 04:35:07 INFO - PROCESS | 13523 | Values: 3063.5 3066.1 3097.9 3119.7 3120.2 5134.6 5200.9 5239.1 5292.2 5297.2 5273.2 5303.5 5342.0 5374.1 5391.0 4746.3 4813.8 4856.4 4863.1 4968.3 4869.8 4879.6 4907.1 4933.3 4946.0 4712.5 4736.4 4753.0 4760.1 4860.6 4764.6 4772.4 4776.0 4823.0 4861.2 4778.5 4791.7 4809.7 4854.2 4861.7 5135.3 5244.2 5316.3 5326.1 5358.2 5639.4 5666.5 5667.3 5728.5 5731.8 5703.6 5764.8 5766.3 5770.1 5772.0 5120.3 5219.2 5292.9 5332.8 5387.4 5772.7 5784.2 5824.4 5830.8 5838.9 5557.7 5561.5 5604.8 5611.6 5615.4 5520.6 5620.2 5637.4 5669.3 5681.3 5677.4 5684.8 5685.1 5720.7 5734.4 5635.6 5672.7 5676.3 5680.9 5690.5 4284.6 4289.5 4336.6 4393.9 4433.9 3868.3 3874.3 3884.5 3899.2 3947.6 5351.5 5354.8 5357.5 5361.5 5420.3 5419.7 5547.1 5575.5 5630.2 5666.5 5377.9 5401.4 5403.5 5435.9 5453.2 4914.0 4924.0 4927.2 4937.5 4971.8 5735.5 5845.7 5911.3 5915.6 5916.4 5700.3 5714.0 5730.8 5744.4 5748.1 5937.2 5943.0 5950.6 5950.6 5970.3 5407.3 5550.3 5559.1 5636.2 5638.0 5659.7 5667.4 5712.7 5745.5 5749.1 5558.7 5564.5 5568.5 5569.3 5572.5 5286.3 5485.2 5562.1 5563.1 5564.6 5432.7 5480.8 5500.3 5537.8 5538.4 5575.4 5586.8 5621.9 5625.5 5635.2 5314.7 5323.6 5457.7 5464.0 5472.0 04:35:07 INFO - PROCESS | 13523 | 04:35:07 INFO - PROCESS | 13523 | [#1] ext.html Cycles:180 Average:60292.25 Median:23488.98 stddev:116574.26 (496.3%) stddev-sans-first:116815.05 04:35:07 INFO - PROCESS | 13523 | Values: 572.3 585.1 609.8 613.7 637.0 42140.8 43398.3 43454.6 43471.6 46837.0 43930.8 44484.3 44555.3 44565.3 44581.1 8987.2 9155.9 9174.1 9182.4 9183.5 9009.0 9072.6 9096.6 9098.7 9098.9 9133.8 9185.7 9187.4 9192.3 9193.7 9093.9 9131.7 9141.9 9146.1 9146.6 9014.2 9045.3 9082.2 9094.4 9099.0 43297.8 43532.6 43568.8 43685.8 43764.3 3478.1 3936.3 4092.0 4274.2 4444.9 32463.0 32506.5 32608.8 32681.3 32954.0 4306.3 4349.9 4448.2 4531.0 4573.5 371074.0 371307.0 373239.0 374414.0 375779.0 59357.0 59612.7 59685.0 60059.7 60121.4 61052.4 61113.4 61126.1 61172.7 61228.7 16958.3 17245.8 17247.7 17248.7 17251.4 13498.3 13565.3 13588.5 13589.8 13597.3 13004.9 16076.6 16227.6 16462.5 16844.9 5266.2 6114.8 6203.8 6328.3 6329.2 1057.4 1074.4 1110.5 1152.6 1155.0 31540.9 32988.8 33267.0 33301.8 34061.3 1112.4 1125.6 1205.2 1213.3 1231.1 16913.7 17367.0 17395.7 17437.0 17476.7 511896.0 516533.0 517440.0 520765.0 525211.0 60363.1 60431.0 60703.0 60793.4 60811.4 1248.2 1366.2 1381.5 1390.3 1414.1 32337.0 33964.5 34009.3 34125.1 34333.3 51321.0 51680.5 51956.5 51971.5 52085.0 412240.0 417993.0 419241.0 419396.0 419425.2 27554.6 28162.2 28647.7 28728.0 28885.9 44824.0 49707.8 49874.0 49880.8 49882.8 41027.4 41039.8 41228.8 42449.8 42578.6 41007.4 41287.0 41629.6 41859.4 42385.0 41823.6 42703.8 42945.4 43031.8 43108.4 35510.8 37039.3 37270.0 37296.4 37447.6 28267.4 28347.4 28353.4 28404.3 28529.0 04:35:07 INFO - PROCESS | 13523 | 04:35:07 INFO - PROCESS | 13523 | [#2] jquery.html Cycles:180 Average:29230.46 Median:19104.74 stddev:83232.87 (435.7%) stddev-sans-first:83438.17 04:35:07 INFO - PROCESS | 13523 | Values: 377.1 388.7 389.7 392.2 427.8 14380.0 14437.4 18818.9 19605.0 19607.6 18948.0 19057.4 19314.7 19352.8 19986.0 5670.7 5768.4 5817.1 5825.2 5835.9 5680.1 5686.3 5786.3 5813.8 5815.0 5707.1 5789.2 5790.7 5791.5 5799.2 5603.9 5721.8 5753.2 5759.9 5761.9 5130.5 5158.6 5204.7 5208.2 5353.1 14427.6 14683.4 15751.0 23573.2 23981.4 2252.5 2385.2 2551.6 2563.8 2896.6 10777.4 11870.6 12622.1 13850.4 15455.6 1878.2 1924.7 1991.3 1999.0 2011.2 67174.3 68870.0 81008.0 83795.6 85106.0 10683.8 11148.8 11219.4 11266.9 11373.3 15781.5 16066.1 16186.6 16187.5 16231.8 7454.3 7744.0 8348.1 8412.0 8470.9 8000.7 8129.1 8239.2 8378.9 8399.6 4828.5 4837.5 4910.1 4914.9 5021.0 1913.3 1977.2 2009.6 2026.4 2027.2 949.6 959.7 971.5 1001.4 1066.9 19501.0 19510.3 20041.3 20172.3 21021.4 947.6 952.7 984.8 988.2 988.7 10777.5 11330.2 11460.5 11461.0 11525.7 491893.0 494530.0 507171.0 516068.0 517566.0 89391.0 89393.6 93365.1 95430.0 96180.5 948.1 958.1 983.4 992.2 999.8 15428.5 18604.9 18702.7 18945.1 19107.0 29645.4 35465.5 37820.8 42003.2 42141.9 57811.7 58555.4 59228.4 59754.4 60165.7 8332.3 8417.9 8539.5 8604.9 8669.9 10600.4 12922.2 12997.0 13047.4 13534.7 11204.7 11616.7 11746.9 11779.5 12016.9 11245.7 11468.5 11542.5 11709.2 11768.0 11851.6 11927.0 11982.8 11998.5 12062.9 8421.6 8503.0 8551.6 8586.1 8808.5 10368.7 11287.3 11540.7 11758.8 11901.6 04:35:07 INFO - PROCESS | 13523 | 04:35:07 INFO - PROCESS | 13523 | [#3] mootools.html Cycles:180 Average:5894.01 Median:4783.08 stddev:3324.53 (69.5%) stddev-sans-first:3317.04 04:35:07 INFO - PROCESS | 13523 | Values: 1444.9 1501.4 1628.3 1723.2 1768.1 8405.1 9150.4 9154.2 9156.5 9176.6 7512.7 8713.5 8895.6 8960.5 8973.3 2329.1 2366.7 2372.4 2373.0 2373.6 2382.4 2395.9 2419.2 2427.1 2427.3 2067.7 2125.2 2127.2 2130.1 2322.3 2352.2 2378.4 2380.8 2386.4 2389.3 2362.1 2363.5 2367.6 2395.3 2403.3 8989.1 9041.3 9047.8 9058.2 9066.8 5344.0 5459.4 5513.8 5521.1 5521.9 3326.2 3393.6 3488.0 3497.7 3498.7 1057.6 1122.6 1123.0 2143.8 2216.8 12437.4 12506.7 12549.1 12591.9 12597.0 4469.6 4683.0 4767.8 4798.4 4812.1 10007.4 10014.8 10018.7 10031.5 10040.4 5387.2 5395.1 5407.4 5409.6 5411.8 4975.6 4985.9 5038.2 5040.1 5077.6 3791.4 3827.2 3859.8 3868.7 3929.7 1153.9 1155.9 1160.2 1161.8 1185.9 868.8 966.4 984.6 997.0 1000.2 6015.1 6213.4 6248.2 6315.3 6386.8 433.1 453.3 459.9 466.8 472.5 4152.1 4267.6 4320.7 4391.6 4404.5 10857.8 11331.7 11343.2 11352.5 11353.2 9879.6 10262.0 10293.8 10554.4 10556.5 8271.7 8471.3 8487.0 8491.3 8500.1 6202.9 6425.3 6507.6 6549.0 6598.6 9489.6 10450.8 10462.5 10475.1 10551.2 9983.0 10147.3 10183.3 10251.9 10252.6 7940.8 7957.8 8090.2 8092.2 8155.1 8506.9 8729.1 8732.4 8740.7 8746.3 7649.0 7749.5 7947.4 7952.8 8164.6 7353.7 7639.3 7717.2 7736.7 7866.9 7017.0 7132.6 7135.6 7140.9 7141.2 5320.9 5388.2 5416.4 5423.7 5636.6 5264.6 5293.6 5329.5 5403.3 5491.7 04:35:07 INFO - PROCESS | 13523 | 04:35:07 INFO - PROCESS | 13523 | [#4] prototype.html Cycles:180 Average:4575.07 Median:5150.93 stddev:1320.36 (25.6%) stddev-sans-first:1284.79 04:35:07 INFO - PROCESS | 13523 | Values: 316.1 331.1 341.1 347.6 353.9 5146.6 5239.8 5241.5 5268.8 5277.2 4940.6 5155.2 5228.8 5228.9 5232.5 4131.7 4136.5 4147.0 4151.5 4181.7 3964.9 4007.4 4129.6 4132.2 4134.5 4093.4 4108.8 4111.7 4115.8 4116.3 4088.1 4106.3 4106.8 4109.4 4114.2 3513.3 3678.4 3681.0 3687.8 3699.8 5062.4 5076.3 5097.1 5101.1 5103.6 4705.9 4713.3 4728.7 4732.6 4733.4 5135.5 5392.7 5410.2 5414.3 5436.2 4061.8 4066.2 4070.8 4074.2 4076.8 5583.7 5617.4 5644.9 5646.2 5652.0 3979.3 4054.5 4109.8 4120.0 4121.2 4080.3 4107.2 4109.5 4119.3 4136.2 4487.8 4567.1 4679.2 4687.6 4690.4 5429.2 5459.8 5461.2 5466.3 5468.5 1417.0 1436.5 1451.9 1452.7 1453.4 936.3 952.5 955.6 961.1 967.2 4681.4 4693.6 4695.8 4700.4 4710.7 4901.5 4903.7 4911.8 4916.5 4938.7 4680.3 4711.7 4930.5 5317.6 5339.7 2942.0 2952.9 2956.8 2969.7 2969.9 5673.7 5848.7 5853.8 5862.9 5873.1 5677.9 5683.6 5723.7 5736.7 5751.8 5797.9 5800.1 5822.7 5847.7 5884.0 5335.0 5413.4 5532.3 5558.6 5571.1 5490.1 5519.1 5524.2 5534.5 5534.9 5813.7 5820.9 5827.6 5832.3 5832.8 3850.9 4026.7 4058.7 4059.9 4077.6 5370.9 5471.8 5586.1 5594.4 5607.3 5466.6 5471.3 5473.9 5474.6 5478.9 5403.6 5451.7 5456.7 5459.7 5471.8 5191.6 5302.6 5381.4 5388.6 5391.4 5438.5 5477.6 5478.1 5485.8 5492.3 5206.3 5312.0 5357.3 5367.4 5370.7 04:35:07 INFO - PROCESS | 13523 | 04:35:07 INFO - PROCESS | 13523 | [#5] yui.html Cycles:180 Average:21486.16 Median:4577.87 stddev:31578.65 (689.8%) stddev-sans-first:31628.84 04:35:07 INFO - PROCESS | 13523 | Values: 748.0 764.9 768.6 797.2 800.0 16118.5 16538.8 16645.7 16657.3 16852.2 14100.2 14184.5 15670.5 16001.8 16169.2 820.2 837.8 839.9 840.2 840.9 676.3 808.6 831.5 833.8 840.3 860.6 865.5 867.5 868.0 869.1 862.0 864.4 864.5 865.1 865.1 516.1 524.8 526.7 612.8 624.0 13025.7 13127.7 13161.9 13162.4 13230.4 13211.6 13747.2 13811.7 13845.9 14062.4 12044.4 12451.9 12483.8 12583.8 12909.2 4181.2 4275.8 4290.6 4358.9 4360.3 78907.6 79146.0 80162.0 85242.0 85422.6 10819.6 11018.5 11643.1 12129.7 12201.3 18872.1 19026.6 19028.0 19032.2 19186.1 8338.6 8490.9 8575.1 8644.7 8664.6 4730.6 4904.2 4974.7 5004.6 5033.3 3458.7 3563.1 3567.0 3570.6 3573.3 575.8 580.7 586.9 587.5 590.0 659.7 689.6 703.5 712.8 759.3 8839.3 9166.3 9409.2 9874.3 10046.1 620.6 649.0 676.8 691.4 729.9 4382.8 4558.4 4597.4 4682.6 4718.6 74523.0 76935.6 110864.4 124162.4 131826.0 107850.0 109523.0 110431.0 111198.0 117156.0 95690.0 95976.5 96846.5 97890.0 99526.5 8929.3 9009.4 9044.2 9134.8 9343.3 52778.5 54075.0 55635.6 56633.7 57934.0 66731.3 77868.6 83461.6 84211.0 84281.6 11445.6 11877.8 13210.3 13363.0 14102.1 13139.5 13497.5 14092.7 14323.6 15534.3 14834.9 14857.6 14897.5 15137.0 15469.3 11556.8 13834.4 14218.9 14259.2 14756.3 13448.0 13536.9 13662.6 13715.9 14001.4 10724.2 10944.2 11521.8 11818.6 11955.4 10381.4 11022.6 11459.4 11689.7 11957.5 04:35:07 INFO - PROCESS | 13523 | -------- Summary: end -------- 04:35:07 INFO - PROCESS | 13523 | 04:35:08 INFO - TEST-INFO | 13523: exit 0 04:35:08 INFO - TEST-OK | dromaeo_css | took 1115020ms 04:35:08 INFO - TEST-START | kraken 04:35:08 INFO - operating with platform_type : linux_ 04:35:08 INFO - Initialising browser for kraken test... 04:35:08 INFO - TEST-INFO | started process 13725 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGpqJqm/profile http://localhost:48749/getInfo.html) 04:35:11 INFO - PROCESS | 13725 | __metrics Screen width/height:1600/1200 04:35:11 INFO - PROCESS | 13725 | colorDepth:24 04:35:11 INFO - PROCESS | 13725 | Browser inner width/height: 1024/697 04:35:11 INFO - PROCESS | 13725 | __metrics 04:35:12 INFO - PROCESS | 13725 | 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" 04:35:12 INFO - PROCESS | 13725 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 122: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:35:13 INFO - PROCESS | 13725 | console.error: PushService: 04:35:13 INFO - PROCESS | 13725 | stateChangeProcessEnqueue: Error transitioning state 04:35:13 INFO - PROCESS | 13725 | UnknownError 04:35:13 INFO - TEST-INFO | 13725: exit 0 04:35:13 INFO - Browser initialized. 04:35:13 INFO - Running cycle 1/1 for kraken test... 04:35:13 INFO - TEST-INFO | started process 13806 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGpqJqm/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:25 INFO - PROCESS | 13806 | RSS: Main: 155860992 04:35:25 INFO - PROCESS | 13806 | 04:35:27 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48749/tests/kraken/driver.html?testName=audio-beat-detection) 04:35:28 INFO - PROCESS | 13806 | RSS: Main: 212819968 04:35:28 INFO - PROCESS | 13806 | 04:35:31 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48749/tests/kraken/driver.html?testName=audio-dft) 04:35:31 INFO - PROCESS | 13806 | RSS: Main: 192303104 04:35:31 INFO - PROCESS | 13806 | 04:35:35 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48749/tests/kraken/driver.html?testName=audio-fft) 04:35:35 INFO - PROCESS | 13806 | RSS: Main: 268742656 04:35:35 INFO - PROCESS | 13806 | 04:35:37 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48749/tests/kraken/driver.html?testName=audio-oscillator) 04:35:38 INFO - PROCESS | 13806 | RSS: Main: 179490816 04:35:38 INFO - PROCESS | 13806 | 04:35:40 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48749/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:35:41 INFO - PROCESS | 13806 | RSS: Main: 184102912 04:35:41 INFO - PROCESS | 13806 | 04:35:44 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48749/tests/kraken/driver.html?testName=imaging-darkroom) 04:35:44 INFO - PROCESS | 13806 | RSS: Main: 218861568 04:35:44 INFO - PROCESS | 13806 | 04:35:48 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48749/tests/kraken/driver.html?testName=imaging-desaturate) 04:35:48 INFO - PROCESS | 13806 | RSS: Main: 220397568 04:35:48 INFO - PROCESS | 13806 | 04:35:51 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48749/tests/kraken/driver.html?testName=json-parse-financial) 04:35:52 INFO - PROCESS | 13806 | RSS: Main: 220209152 04:35:52 INFO - PROCESS | 13806 | 04:35:53 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48749/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:35:54 INFO - PROCESS | 13806 | RSS: Main: 184299520 04:35:54 INFO - PROCESS | 13806 | 04:35:55 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48749/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:35:56 INFO - PROCESS | 13806 | RSS: Main: 189808640 04:35:56 INFO - PROCESS | 13806 | 04:35:58 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48749/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:35:59 INFO - PROCESS | 13806 | RSS: Main: 193634304 04:35:59 INFO - PROCESS | 13806 | 04:36:01 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:36:02 INFO - PROCESS | 13806 | RSS: Main: 194875392 04:36:02 INFO - PROCESS | 13806 | 04:36:05 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:36:05 INFO - PROCESS | 13806 | RSS: Main: 195063808 04:36:05 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | Cycle 1(1): loaded http://localhost:48749/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48749/tests/kraken/driver.html?testName=ai-astar) 04:36:07 INFO - PROCESS | 13806 | RSS: Main: 243486720 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | __start_tp_report 04:36:07 INFO - PROCESS | 13806 | _x_x_mozilla_page_load 04:36:07 INFO - PROCESS | 13806 | _x_x_mozilla_page_load_details 04:36:07 INFO - PROCESS | 13806 | |i|pagename|runs| 04:36:07 INFO - PROCESS | 13806 | |0;ai-astar;102;111;112;111;112;112;110;111;110;110 04:36:07 INFO - PROCESS | 13806 | |1;audio-beat-detection;145;117;122;187;118;121;149;117;153;117 04:36:07 INFO - PROCESS | 13806 | |2;audio-dft;160;161;162;161;160;161;160;162;160;160 04:36:07 INFO - PROCESS | 13806 | |3;audio-fft;76;75;75;118;75;77;74;73;119;74 04:36:07 INFO - PROCESS | 13806 | |4;audio-oscillator;84;84;131;85;85;84;134;85;83;126 04:36:07 INFO - PROCESS | 13806 | |5;imaging-gaussian-blur;117;117;117;117;118;117;117;117;116;116 04:36:07 INFO - PROCESS | 13806 | |6;imaging-darkroom;144;145;146;145;146;146;146;146;145;145 04:36:07 INFO - PROCESS | 13806 | |7;imaging-desaturate;95;95;95;95;95;95;96;95;95;95 04:36:07 INFO - PROCESS | 13806 | |8;json-parse-financial;50;49;47;48;57;49;48;50;48;48 04:36:07 INFO - PROCESS | 13806 | |9;json-stringify-tinderbox;60;60;61;60;61;61;60;60;60;60 04:36:07 INFO - PROCESS | 13806 | |10;stanford-crypto-aes;76;76;75;79;76;77;75;75;76;80 04:36:07 INFO - PROCESS | 13806 | |11;stanford-crypto-ccm;127;117;119;119;128;120;127;125;132;126 04:36:07 INFO - PROCESS | 13806 | |12;stanford-crypto-pbkdf2;156;162;158;170;161;159;159;161;159;160 04:36:07 INFO - PROCESS | 13806 | |13;stanford-crypto-sha256-iterative;65;63;63;62;65;64;63;62;61;63 04:36:07 INFO - PROCESS | 13806 | __end_tp_report 04:36:07 INFO - PROCESS | 13806 | __start_cc_report 04:36:07 INFO - PROCESS | 13806 | _x_x_mozilla_cycle_collect,1666 04:36:07 INFO - PROCESS | 13806 | __end_cc_report 04:36:07 INFO - PROCESS | 13806 | __startTimestamp1470569767524__endTimestamp 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | ------- Summary: start ------- 04:36:07 INFO - PROCESS | 13806 | Number of tests: 14 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#0] ai-astar Cycles:10 Average:110.10 Median:111.00 stddev:2.96 (2.7%) stddev-sans-first:0.87 04:36:07 INFO - PROCESS | 13806 | Values: 102.0 111.0 112.0 111.0 112.0 112.0 110.0 111.0 110.0 110.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#1] audio-beat-detection Cycles:10 Average:134.60 Median:133.50 stddev:23.45 (17.6%) stddev-sans-first:24.57 04:36:07 INFO - PROCESS | 13806 | Values: 145.0 117.0 122.0 187.0 118.0 121.0 149.0 117.0 153.0 117.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#2] audio-dft Cycles:10 Average:160.70 Median:161.00 stddev:0.82 (0.5%) stddev-sans-first:0.83 04:36:07 INFO - PROCESS | 13806 | Values: 160.0 161.0 162.0 161.0 160.0 161.0 160.0 162.0 160.0 160.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#3] audio-fft Cycles:10 Average:83.60 Median:75.00 stddev:18.43 (24.6%) stddev-sans-first:19.34 04:36:07 INFO - PROCESS | 13806 | Values: 76.0 75.0 75.0 118.0 75.0 77.0 74.0 73.0 119.0 74.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#4] audio-oscillator Cycles:10 Average:98.10 Median:84.00 stddev:22.33 (26.6%) stddev-sans-first:23.10 04:36:07 INFO - PROCESS | 13806 | Values: 84.0 84.0 131.0 85.0 85.0 84.0 134.0 85.0 83.0 126.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#5] imaging-gaussian-blur Cycles:10 Average:116.90 Median:117.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 04:36:07 INFO - PROCESS | 13806 | Values: 117.0 117.0 117.0 117.0 118.0 117.0 117.0 117.0 116.0 116.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:146.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 04:36:07 INFO - PROCESS | 13806 | Values: 144.0 145.0 146.0 145.0 146.0 146.0 146.0 146.0 145.0 145.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 04:36:07 INFO - PROCESS | 13806 | Values: 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:49.00 stddev:2.84 (5.8%) stddev-sans-first:3.00 04:36:07 INFO - PROCESS | 13806 | Values: 50.0 49.0 47.0 48.0 57.0 49.0 48.0 50.0 48.0 48.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#9] json-stringify-tinderbox Cycles:10 Average:60.30 Median:60.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:36:07 INFO - PROCESS | 13806 | Values: 60.0 60.0 61.0 60.0 61.0 61.0 60.0 60.0 60.0 60.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#10] stanford-crypto-aes Cycles:10 Average:76.50 Median:76.00 stddev:1.72 (2.3%) stddev-sans-first:1.81 04:36:07 INFO - PROCESS | 13806 | Values: 76.0 76.0 75.0 79.0 76.0 77.0 75.0 75.0 76.0 80.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:126.50 stddev:4.92 (3.9%) stddev-sans-first:5.10 04:36:07 INFO - PROCESS | 13806 | Values: 127.0 117.0 119.0 119.0 128.0 120.0 127.0 125.0 132.0 126.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.50 Median:160.50 stddev:3.75 (2.3%) stddev-sans-first:3.61 04:36:07 INFO - PROCESS | 13806 | Values: 156.0 162.0 158.0 170.0 161.0 159.0 159.0 161.0 159.0 160.0 04:36:07 INFO - PROCESS | 13806 | 04:36:07 INFO - PROCESS | 13806 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.10 Median:63.00 stddev:1.29 (2.0%) stddev-sans-first:1.17 04:36:07 INFO - PROCESS | 13806 | Values: 65.0 63.0 63.0 62.0 65.0 64.0 63.0 62.0 61.0 63.0 04:36:07 INFO - PROCESS | 13806 | -------- Summary: end -------- 04:36:07 INFO - PROCESS | 13806 | 04:36:08 INFO - TEST-INFO | 13806: exit 0 04:36:08 INFO - TEST-OK | kraken | took 60443ms 04:36:08 INFO - SUITE-END | took 1175s 04:36:08 INFO - Completed test suite (00:19:35) 04:36:08 INFO - javascript benchmark 04:36:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3063.5098384258517, 3066.064850220682, 3097.907062788114, 3119.7036281553246, 3120.219945013746, 5134.614903882205, 5200.921986170201, 5239.1093514102595, 5292.153255479119, 5297.178937264725, 5273.18265668821, 5303.522682958533, 5342.0, 5374.140137577979, 5390.973045134779, 4746.311784791212, 4813.7593120343845, 4856.417229932413, 4863.051704917542, 4968.254761785743, 4869.820606445467, 4879.585235255007, 4907.0921879452235, 4933.33399991002, 4946.0, 4712.481627021025, 4736.360591320162, 4752.9762351188365, 4760.143174228638, 4860.611151107921, 4764.595009424169, 4772.379590653193, 4776.0, 4823.03539292143, 4861.246506791453, 4778.498257682928, 4791.688540244908, 4809.663323567352, 4854.247591623304, 4861.708297502161, 5135.3324067870935, 5244.160934250502, 5316.308879845634, 5326.067938110854, 5358.196270559409, 5639.436056394327, 5666.5183459406, 5667.319921609392, 5728.484436400702, 5731.770729170828, 5703.62926409782, 5764.769409223626, 5766.336871259817, 5770.134479828017, 5771.971140144315, 5120.2831603575905, 5219.243209734567, 5292.9206061908335, 5332.786688532454, 5387.380451248117, 5772.6536407815665, 5784.1902133701315, 5824.359320474744, 5830.82507524775, 5838.912416313674, 5557.749901254453, 5561.499465048084, 5604.8038318658655, 5611.607187496836, 5615.410381909841, 5520.641158324776, 5620.241267428926, 5637.379888212294, 5669.348024977098, 5681.289838770153, 5677.37548869624, 5684.829455116271, 5685.118806584986, 5720.713964301768, 5734.369219385864, 5635.5773317001385, 5672.716364181774, 5676.318841739017, 5680.914786278209, 5690.516306113944, 4284.592963668447, 4289.463817022872, 4336.609705126553, 4393.912121757547, 4433.933490997638, 3868.2843673920415, 3874.3219936511, 3884.495015648004, 3899.2006638639577, 3947.605239476087, 5351.518363347317, 5354.759035843396, 5357.517823395913, 5361.544268737123, 5420.322459692538, 5419.701916394636, 5547.140193269969, 5575.498205161555, 5630.211770352154, 5666.546676265889, 5377.865553361197, 5401.432849550819, 5403.48666876654, 5435.891282174413, 5453.23654688344, 4914.0, 4923.950760492421, 4927.162382395001, 4937.506249375034, 4971.825986090469, 5735.541156707453, 5845.7369418376275, 5911.3201981772645, 5915.556333275022, 5916.408359164049, 5700.315962084411, 5714.0, 5730.828075157752, 5744.396838332083, 5748.080307150836, 5937.228160339128, 5943.049112142036, 5950.613210141327, 5950.613210141327, 5970.283565972111, 5407.297051383295, 5550.306211723535, 5559.11054231321, 5636.210930469655, 5638.041532939492, 5659.745311461076, 5667.4332566743, 5712.714364281686, 5745.511631511201, 5749.051406518045, 5558.749856256397, 5564.4713752193475, 5568.470995255444, 5569.303837020372, 5572.498475137257, 5286.259923610774, 5485.204645326326, 5562.082256427644, 5563.082091454865, 5564.638298510584, 5432.728363581884, 5480.780768769364, 5500.312460942382, 5537.833864984057, 5538.363088244903, 5575.358833734173, 5586.804461843816, 5621.8594535136945, 5625.521830644441, 5635.239242702182, 5314.707691077027, 5323.6273460857365, 5457.7271136443815, 5464.0, 5472.042392581362], "value": 5235.745047085868, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.3046498504316, 585.1135529672547, 609.7743834781131, 613.7391608566361, 636.9840105032472, 42140.78929605352, 43398.34902476461, 43454.565454345444, 43471.56528434718, 46837.0, 43930.780346098225, 44484.332735009004, 44555.3316700249, 44565.331520027146, 44581.108377832505, 8987.236084932772, 9155.908440915573, 9174.08259174084, 9182.357234993553, 9183.540822958825, 9009.0, 9072.63709451621, 9096.590653420579, 9098.727038188865, 9098.863517047217, 9133.771655708593, 9185.678501252458, 9187.35688501805, 9192.31057670674, 9193.724188274362, 9093.863267091614, 9131.680391186277, 9141.908580914172, 9146.131117543822, 9146.634134634607, 9014.188723014895, 9045.321600879895, 9082.22801061904, 9094.408863423856, 9099.0, 43297.78351108224, 43532.56467435317, 43568.782156089015, 43685.78157109226, 43764.343534847, 3478.0783092480515, 3936.252112098692, 4092.0383709828166, 4274.166537525184, 4444.933326000112, 32463.0, 32506.512402313983, 32608.836955815306, 32681.346373072407, 32954.0, 4306.2894622387585, 4349.9130017399475, 4448.154850578379, 4530.982975182713, 4573.47405048417, 371074.0, 371307.0, 373239.0, 374414.0, 375779.0, 59357.0, 59612.70193649091, 59685.0, 60059.69373215837, 60121.398786012454, 61052.389476105556, 61113.38886611166, 61126.0831087534, 61172.69413652903, 61228.693856531325, 16958.321667133423, 17245.827541724422, 17247.65504689899, 17248.741268880978, 17251.3962011329, 13498.257595832323, 13565.321733913264, 13588.524401645895, 13589.796153057712, 13597.252151131783, 13004.869951300556, 16076.598085047968, 16227.594310142342, 16462.506124816275, 16844.915775421043, 5266.157414813688, 6114.847128821815, 6203.844903877349, 6328.335524769833, 6329.177206963157, 1057.391999600233, 1074.4176088980505, 1110.4947249001684, 1152.6426807689643, 1155.0470861539095, 31540.89606863749, 32988.835055824566, 33267.0, 33301.83349083239, 34061.318773624385, 1112.3659514076899, 1125.6285425809463, 1205.2045649871043, 1213.308414203913, 1231.1382032577233, 16913.7462938056, 17367.0, 17395.65208695819, 17437.0, 17476.650466990843, 511896.0, 516533.0, 517439.953602785, 520765.0, 525211.0, 60363.09455358173, 60431.0, 60703.0, 60793.39206607966, 60811.39188608146, 1248.1886773597234, 1366.2144267046488, 1381.4750394849893, 1390.32569203936, 1414.1161773891113, 32337.0, 33964.49053264154, 34009.31981360408, 34125.14687132841, 34333.28333583261, 51321.0, 51680.483195167566, 51956.480435196674, 51971.48028519667, 52085.0, 412240.0, 417993.0, 419241.0, 419396.0, 419425.22299107694, 27554.5866812002, 28162.155135345973, 28647.713522864506, 28728.0, 28885.85557072201, 44824.0, 49707.751461242464, 49874.0, 49880.750596246784, 49882.75058624684, 41027.38458923059, 41039.794801025804, 41228.79385603053, 42449.78775106105, 42578.57421425746, 41007.38488922728, 41287.0, 41629.58370416378, 41859.372109417774, 42385.0, 41823.58176418319, 42703.78648106864, 42945.35581966335, 43031.7848410756, 43108.353374698774, 35510.82244588761, 37039.25921481609, 37270.0, 37296.44055339226, 37447.625523745504, 28267.43465130727, 28347.375824965962, 28353.432931340845, 28404.289892752848, 28529.0], "value": 20417.264935714164, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [377.1438833847165, 388.6676891257976, 389.6532086443065, 392.2273121949758, 427.78610694652673, 14380.0, 14437.422503099877, 18818.90590547049, 19605.0, 19607.607847843035, 18948.0, 19057.428277151706, 19314.710279345785, 19352.806471935277, 19986.0, 5670.659760414368, 5768.36547979724, 5817.098349755774, 5825.184474173598, 5835.941640583604, 5680.091185410335, 5686.31764188298, 5786.334571524287, 5813.796517121901, 5814.97092514539, 5707.058335374658, 5789.189513468118, 5790.71046447676, 5791.478766910977, 5799.159121927318, 5603.8879222415735, 5721.828345149632, 5753.223314852483, 5759.913601295984, 5761.884762304751, 5130.486951304877, 5158.561522270612, 5204.661696989683, 5208.218767184915, 5353.116735738598, 14427.567172984827, 14683.412663493447, 15751.0, 23573.17493887723, 23981.40046498834, 2252.5157091225465, 2385.2486466762916, 2551.630013648011, 2563.8205325627214, 2896.5799959005826, 10777.407242601654, 11870.643880683507, 12622.116451848375, 13850.445982160702, 15455.608995190487, 1878.1642169234697, 1924.6728056230334, 1991.2632326039313, 1998.9910140309041, 2011.2055737983414, 67174.3282567173, 68870.0, 81008.0, 83795.5810220945, 85106.0, 10683.786324273626, 11148.777024459627, 11219.382933938712, 11266.94366528162, 11373.260738052, 15781.526554203392, 16066.116363600115, 16186.59533511648, 16187.514374568545, 16231.756523652155, 7454.329110379983, 7744.0, 8348.123447038095, 8411.957940210259, 8470.915290847135, 8000.679972801139, 8129.065157506844, 8239.176082391712, 8378.874316885252, 8399.580020998925, 4828.5412885775795, 4837.4920633332995, 4910.091633047898, 4914.911162755814, 5021.0, 1913.3016448996295, 1977.20911635347, 2009.6282187795011, 2026.432598872318, 2027.1587291274252, 949.5632009275672, 959.7456673981401, 971.4754032822196, 1001.3641337750436, 1066.898644628759, 19501.0, 19510.317138900355, 20041.298554550813, 20172.29396971128, 21021.369358919255, 947.5593848860314, 952.7284723853669, 984.8128855517572, 988.2113374791506, 988.7379844341111, 10777.515011824487, 11330.150238732129, 11460.484278207501, 11461.0, 11525.654230373102, 491893.0, 494530.0, 507171.0, 516068.0, 517566.0, 89391.0, 89393.55303223443, 93365.066349337, 95430.0, 96180.51909740547, 948.1135138645388, 958.1472489484504, 983.3902980152351, 992.1715367668078, 999.8300288950895, 15428.537143885702, 18604.906975465037, 18702.675290970874, 18945.14746836368, 19107.0, 29645.407091858473, 35465.468017979234, 37820.810895945346, 42003.159936801705, 42141.94645133896, 57811.710941445024, 58555.41444585499, 59228.40771592229, 59754.40245597489, 60165.69917150386, 8332.250097491255, 8417.915820841958, 8539.53032583189, 8604.857967886514, 8669.869951950852, 10600.363978161335, 12922.224666520038, 12997.0, 13047.412866420844, 13534.661633459242, 11204.71988200269, 11616.709582260173, 11746.882531174579, 11779.469923853276, 12016.879831201577, 11245.71885702864, 11468.483918223534, 11542.480588373375, 11709.180357374902, 11768.0, 11851.644450666494, 11927.0, 11982.760344793229, 11998.460069296729, 12062.879371206176, 8421.578921054046, 8503.016120904367, 8551.572421378782, 8586.098459661895, 8808.471491710518, 10368.740781480523, 11287.322760634388, 11540.711482213012, 11758.764824703287, 11901.583444579399], "value": 9226.568784640784, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1444.8627380398862, 1501.3694248415666, 1628.3079691131265, 1723.241773619608, 1768.0629266488766, 8405.117462666416, 9150.405223660457, 9154.176124148826, 9156.496392698398, 9176.587053582589, 7512.737054203104, 8713.477191368507, 8895.644174233039, 8960.507172105532, 8973.282137429007, 2329.126577533425, 2366.715994080713, 2372.4306166519996, 2373.003338597793, 2373.620220764678, 2382.3686723018413, 2395.8682272475007, 2419.2379400488876, 2427.077710470028, 2427.3082171581104, 2067.7001834733956, 2125.2349154304516, 2127.2341956895507, 2130.0734180631475, 2322.3381336319153, 2352.188494969241, 2378.4410663494064, 2380.7976322012564, 2386.4391867911027, 2389.2712722619594, 2362.055177928842, 2363.4564050268536, 2367.597508423572, 2395.2814155753376, 2403.327068420845, 8989.056149104315, 9041.276697864156, 9047.773805654846, 9058.23005044572, 9066.77333066672, 5344.0, 5459.3994660587305, 5513.807016754435, 5521.089020311644, 5521.861953451155, 3326.203889054756, 3393.5927688677516, 3487.982560087183, 3497.667721566447, 3498.667626575497, 1057.5928267617023, 1122.6183097746805, 1123.0061395664814, 2143.839212059086, 2216.8004879560754, 12437.440315185839, 12506.687332816662, 12549.058820588401, 12591.874081259162, 12597.0, 4469.642428605704, 4682.976585117052, 4767.809287628456, 4798.352222449925, 4812.06164797861, 10007.399556026661, 10014.849777253346, 10018.74953126163, 10031.498425078717, 10040.447775372279, 5387.191921211771, 5395.05586522357, 5407.378151512547, 5409.594280428983, 5411.78352865881, 4975.601951843843, 4985.925211121836, 5038.244263360525, 5040.092783298968, 5077.593792496591, 3791.431285307226, 3827.158025234444, 3859.7684138951754, 3868.709846761504, 3929.724919255682, 1153.936533490666, 1155.8786327435666, 1160.228448082016, 1161.8083016302216, 1185.869554349021, 868.843608150539, 966.4153187321709, 984.640606178754, 996.9601215951426, 1000.1698590170141, 6015.127806468037, 6213.440790328892, 6248.218972628421, 6315.305316415191, 6386.808395748135, 433.1056368598833, 453.25892166307665, 459.9172149013143, 466.7642840365594, 472.5274725274725, 4152.065785198306, 4267.594578515036, 4320.719153255029, 4391.648668106608, 4404.493483249404, 10857.782844343226, 11331.716707082389, 11343.20597558163, 11352.48913798881, 11353.205275630626, 9879.604815807432, 10262.025107614765, 10293.794124117476, 10554.419506927192, 10556.524956376981, 8271.710490132937, 8471.279941204943, 8486.957565212135, 8491.278241349555, 8500.14998500145, 6202.906956395567, 6425.325340839145, 6507.609543427409, 6549.0, 6598.571092878948, 9489.572969216264, 10450.843237351293, 10462.529186186488, 10475.109615682448, 10551.208659350426, 9982.950085249528, 10147.34042287249, 10183.33808302458, 10251.948740256252, 10252.58989640406, 7940.761777146695, 7957.8408431832195, 8090.1909809018625, 8092.150324216108, 8155.10293867686, 8506.872396914176, 8729.083446238308, 8732.388732788644, 8740.694075707319, 8746.344024198337, 7648.961755191189, 7749.496282741604, 7947.364210863233, 7952.84094318122, 8164.550949697824, 7353.742619008309, 7639.274268944441, 7717.151113377637, 7736.690532378641, 7866.9213307866185, 7016.964915175391, 7132.643367831692, 7135.607541585263, 7140.857182856417, 7141.214466408587, 5320.866978325573, 5388.218708287355, 5416.4041955385665, 5423.728813559385, 5636.577256705846, 5264.605154613496, 5293.576513878804, 5329.54698850602, 5403.270558474713, 5491.7254137292175], "value": 4656.379655177992, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [316.08020659879753, 331.1225450832267, 341.14202780008276, 347.6176206173209, 353.8779121203184, 5146.639735218531, 5239.816606418781, 5241.528262456378, 5268.762905669245, 5277.182036784295, 4940.555350018498, 5155.226715992603, 5228.843134705955, 5228.921566176501, 5232.45059268777, 4131.690123240754, 4136.544980052192, 4147.0, 4151.460310159675, 4181.707280490367, 3964.920701585981, 4007.438958545806, 4129.566395528472, 4132.152908653718, 4134.524529679095, 4093.4269202311702, 4108.77401742904, 4111.650509706678, 4115.847562682454, 4116.320807066831, 4088.10061786408, 4106.342985122366, 4106.77412742299, 4109.363048727452, 4114.19773144237, 3513.3149035938004, 3678.4114541673202, 3680.963190368089, 3687.8340474678703, 3699.7595156314756, 5062.417821950486, 5076.263941728429, 5097.133487307166, 5101.13280742271, 5103.591712662978, 4705.858824235244, 4713.326768997025, 4728.69263497875, 4732.550407711262, 4733.431988161408, 5135.512126347991, 5392.730363481849, 5410.188471729232, 5414.29614150158, 5436.184572314145, 4061.756294622332, 4066.1867626474527, 4070.816813243411, 4074.1647962167685, 4076.7961601920083, 5583.6928968906695, 5617.41017193197, 5644.858878528029, 5646.237757902672, 5651.982643124236, 3979.2837289287627, 4054.4526488923616, 4109.815058322382, 4119.958800411958, 4121.155163191538, 4080.326746086922, 4107.199096176217, 4109.506859176918, 4119.340905455173, 4136.193442278787, 4487.798049087799, 4567.10941366437, 4679.204535229019, 4687.554682305175, 4690.437147542317, 5429.239906413105, 5459.781608735606, 5461.15352120422, 5466.262054622654, 5468.48049435303, 1417.0, 1436.4828661681786, 1451.9201443920686, 1452.7457694903349, 1453.4331610671848, 936.2743873498093, 952.4808979106404, 955.600045932698, 961.1397798970022, 967.2407160379069, 4681.438227412732, 4693.624510039189, 4695.835645752382, 4700.435947686299, 4710.6702530823195, 4901.460839307673, 4903.719770306824, 4911.803527858917, 4916.459189489154, 4938.654294199443, 4680.321353403738, 4711.717296962193, 4930.531599498042, 5317.627766056339, 5339.679619222859, 2941.9852900735787, 2952.9114126576237, 2956.7782416318864, 2969.6733359330456, 2969.930824903033, 5673.659580425187, 5848.684046089681, 5853.824385268449, 5862.8534286642325, 5873.148393482921, 5677.943220567824, 5683.5737319700365, 5723.656580605177, 5736.68448235351, 5751.798687045934, 5797.8550536236935, 5800.114962637244, 5822.679752613647, 5847.707614619252, 5883.970580147072, 5334.973325133349, 5413.404525502113, 5532.336119665666, 5558.610897237317, 5571.05292100352, 5490.149026900836, 5519.116941289374, 5524.2046334940505, 5534.52956498686, 5534.861628459321, 5813.680247586254, 5820.912686309624, 5827.562932779973, 5832.300123985149, 5832.795852145155, 3850.9397472352157, 4026.6913253192242, 4058.6550143238155, 4059.918801623892, 4077.612626800449, 5370.864434385423, 5471.826340722292, 5586.13414920688, 5594.440555944536, 5607.327120745536, 5466.617336786387, 5471.343438787212, 5473.917891231555, 5474.616776825584, 5478.945210547843, 5403.621746477709, 5451.672899626035, 5456.699881506555, 5459.69971651563, 5471.835844924659, 5191.558717509054, 5302.628815982845, 5381.434949330421, 5388.595855310946, 5391.379991300893, 5438.45615438453, 5477.589180811376, 5478.123500239943, 5485.835424937259, 5492.258545096521, 5206.297149884717, 5312.015988008993, 5357.330333708286, 5367.409584945731, 5370.704611246419], "value": 4161.391644685479, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [747.9513831600947, 764.8737958236891, 768.6118510152372, 797.2107613462672, 799.956002419867, 16118.51644450667, 16538.751918721227, 16645.66708665826, 16657.25042373093, 16852.241649125786, 14100.224487653175, 14184.503542376018, 15670.529884103467, 16001.759973600376, 16169.191540422991, 820.2125959079276, 837.8282452097305, 839.9328053755685, 840.155643578203, 840.9285210757063, 676.3439463720208, 808.6280311056921, 831.476170012894, 833.8123922117505, 840.2983508770184, 860.6170254236868, 865.4763867859948, 867.5185272173941, 867.9739607811775, 869.0917990699734, 861.9698310559131, 864.4208380385094, 864.4813112132733, 865.074370423647, 865.1219012702112, 516.0968305465435, 524.8215606693742, 526.662935721135, 612.773273888664, 623.9719212635442, 13025.674358141028, 13127.671808204776, 13161.86838131616, 13162.407691653898, 13230.404631791593, 13211.603651890362, 13747.243901585409, 13811.723765524734, 13845.930770346184, 14062.367193476319, 12044.397780111047, 12451.93774031133, 12483.750324993449, 12583.811242831365, 12909.225446473149, 4181.184668989548, 4275.8075886585175, 4290.635295999844, 4358.869233922987, 4360.324149756792, 78907.60546197233, 79146.0, 80162.0, 85242.0, 85422.57288713641, 10819.56721731122, 11018.50416731249, 11643.126765492621, 12129.696757580954, 12201.267923924594, 18872.056397180088, 19026.61946761057, 19028.0, 19032.238710451704, 19186.13662385196, 8338.62476188573, 8490.872636910452, 8575.099614540384, 8644.654213831376, 8664.566771661517, 4730.550597693214, 4904.215325547895, 4974.726390048582, 5004.649674522749, 5033.295338652591, 3458.723302135823, 3563.1448452371246, 3567.0, 3570.553680789901, 3573.3210689968823, 575.7869588252373, 580.7212537981708, 586.9002269614176, 587.538782056084, 589.9941000589939, 659.6543052173608, 689.6344937183301, 703.4829400390709, 712.7861641507527, 759.343168159549, 8839.29285657146, 9166.251618687173, 9409.161055342509, 9874.308798384043, 10046.111832385792, 620.6462316479654, 648.9740410383532, 676.82064252973, 691.4330249195611, 729.9452541059442, 4382.846600368972, 4558.361829343895, 4597.3793537872625, 4682.6253899687945, 4718.598919091847, 74523.0, 76935.61532192415, 110864.4456777711, 124162.37918810348, 131826.0, 107850.0, 109523.0, 110431.0, 111198.0, 117156.0, 95690.0, 95976.52011739896, 96846.51576742071, 97890.0, 99526.5023674877, 8929.330300227379, 9009.414388065017, 9044.186023257938, 9134.817303653757, 9343.29925255595, 52778.47221527889, 54075.0, 55635.60910977258, 56633.71683141558, 57934.0, 66731.33268667251, 77868.60248276405, 83461.58269208614, 84211.0, 84281.57859210664, 11445.599404020819, 11877.8122187784, 13210.348706411698, 13363.0, 14102.083364581269, 13139.540116096274, 13497.46010159622, 14092.718145637235, 14323.57029289123, 15534.300956457213, 14834.925825371236, 14857.554273371816, 14897.47858824936, 15136.957942363393, 15469.303881325142, 11556.826647600124, 13834.446622135001, 14218.928905355408, 14259.215743134228, 14756.262186890397, 13448.0, 13536.864631353561, 13662.590122296348, 13715.862841371458, 14001.369938353002, 10724.195685323475, 10944.179186560881, 11521.769564608829, 11818.645440636794, 11955.402229888645, 10381.429021403896, 11022.643685015999, 11459.369734664673, 11689.707757305796, 11957.521699132285], "value": 7599.217790341559, "unit": "score"}], "name": "dromaeo_css", "value": 7250.252521226796, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [102.0, 111.0, 112.0, 111.0, 112.0, 112.0, 110.0, 111.0, 110.0, 110.0], "value": 110.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 117.0, 122.0, 187.0, 118.0, 121.0, 149.0, 117.0, 153.0, 117.0], "value": 134.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 161.0, 160.0, 161.0, 160.0, 162.0, 160.0, 160.0], "value": 160.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 75.0, 118.0, 75.0, 77.0, 74.0, 73.0, 119.0, 74.0], "value": 83.6, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 131.0, 85.0, 85.0, 84.0, 134.0, 85.0, 83.0, 126.0], "value": 98.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 117.0, 118.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 145.0, 146.0, 145.0, 146.0, 146.0, 146.0, 146.0, 145.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0], "value": 95.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 49.0, 47.0, 48.0, 57.0, 49.0, 48.0, 50.0, 48.0, 48.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 60.0, 61.0, 60.0, 61.0, 61.0, 60.0, 60.0, 60.0, 60.0], "value": 60.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 75.0, 79.0, 76.0, 77.0, 75.0, 75.0, 76.0, 80.0], "value": 76.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 117.0, 119.0, 119.0, 128.0, 120.0, 127.0, 125.0, 132.0, 126.0], "value": 124.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 162.0, 158.0, 170.0, 161.0, 159.0, 159.0, 161.0, 159.0, 160.0], "value": 160.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 62.0, 65.0, 64.0, 63.0, 62.0, 61.0, 63.0], "value": 63.1, "unit": "score"}], "name": "kraken", "value": 1478.3, "alertThreshold": 2.0}]} 04:36:08 INFO - Return code: 0 04:36:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:36:08 INFO - # TBPL SUCCESS # 04:36:08 INFO - Running post-action listener: _resource_record_post_action 04:36:08 INFO - [mozharness: 2016-08-07 11:36:08.813366Z] Finished run-tests step (success) 04:36:08 INFO - Running post-run listener: _resource_record_post_run 04:36:08 INFO - Total resource usage - Wall time: 1193s; CPU: 13.0%; Read bytes: 0; Write bytes: 548892672; Read time: 0; Write time: 471468 04:36:08 INFO - TinderboxPrint: CPU usage
13.0% 04:36:08 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:36:08 INFO - TinderboxPrint: I/O write bytes / time
548,892,672 / 471,468 04:36:08 INFO - TinderboxPrint: CPU idle
8,287.4 (87.0%) 04:36:08 INFO - TinderboxPrint: CPU user
1,188.2 (12.5%) 04:36:08 INFO - TinderboxPrint: Swap in / out
0 / 0 04:36:08 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 251949056; Read time: 0; Write time: 246384 04:36:08 INFO - run-tests - Wall time: 1176s; CPU: 13.0%; Read bytes: 0; Write bytes: 296329216; Read time: 0; Write time: 225084 04:36:09 INFO - Running post-run listener: _upload_blobber_files 04:36:09 INFO - Blob upload gear active. 04:36:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:36:09 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:36:09 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:36:09 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:36:09 INFO - (blobuploader) - INFO - Open directory for files ... 04:36:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:36:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:36:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:10 INFO - (blobuploader) - INFO - Done attempting. 04:36:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:36:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:36:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:11 INFO - (blobuploader) - INFO - Done attempting. 04:36:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:36:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:36:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:36:14 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:36:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:36:14 INFO - (blobuploader) - INFO - Done attempting. 04:36:14 INFO - (blobuploader) - INFO - Iteration through files over. 04:36:14 INFO - Return code: 0 04:36:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:36:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:36:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a5c997126b447cad2bc898547c46aa198fc23483341bc366a2b7193c52762b096949250293b8ea91cce1e3c55b9904b465ffa8017f287bc922dc4445961ba95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ce48b0aed6ba82cb7e2b649f1b9008a4a1d7957778944ad50b62082abbba68aa7272fdf15dfc65a9a7065cf5c2158b0712e86a32d9a1cecd072766fb5948115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a515c864475920a1ceee195fd98ac03e7de988de48447eaf0b686d7fa77271f9cdcee163aafa4f76b93935847a37267d89aebcba67ac08268c512019d1e345eb"} 04:36:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:36:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:36:14 INFO - Contents: 04:36:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a5c997126b447cad2bc898547c46aa198fc23483341bc366a2b7193c52762b096949250293b8ea91cce1e3c55b9904b465ffa8017f287bc922dc4445961ba95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ce48b0aed6ba82cb7e2b649f1b9008a4a1d7957778944ad50b62082abbba68aa7272fdf15dfc65a9a7065cf5c2158b0712e86a32d9a1cecd072766fb5948115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a515c864475920a1ceee195fd98ac03e7de988de48447eaf0b686d7fa77271f9cdcee163aafa4f76b93935847a37267d89aebcba67ac08268c512019d1e345eb"} 04:36:14 INFO - Running post-run listener: copy_logs_to_upload_dir 04:36:14 INFO - Copying logs to upload dir... 04:36:14 INFO - mkdir: /builds/slave/test/build/upload/logs 04:36:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1230.164538 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 30 secs) (at 2016-08-07 04:36:14.306819) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 04:36:14.310494) ========= 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=6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9a5c997126b447cad2bc898547c46aa198fc23483341bc366a2b7193c52762b096949250293b8ea91cce1e3c55b9904b465ffa8017f287bc922dc4445961ba95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ce48b0aed6ba82cb7e2b649f1b9008a4a1d7957778944ad50b62082abbba68aa7272fdf15dfc65a9a7065cf5c2158b0712e86a32d9a1cecd072766fb5948115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a515c864475920a1ceee195fd98ac03e7de988de48447eaf0b686d7fa77271f9cdcee163aafa4f76b93935847a37267d89aebcba67ac08268c512019d1e345eb"} build_url:https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/artifacts/public/build/firefox-51.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011322 build_url: 'https://queue.taskcluster.net/v1/task/b2y4k3mjRomeAXasUxy9-g/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/Firefox/sha512/9a5c997126b447cad2bc898547c46aa198fc23483341bc366a2b7193c52762b096949250293b8ea91cce1e3c55b9904b465ffa8017f287bc922dc4445961ba95", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ce48b0aed6ba82cb7e2b649f1b9008a4a1d7957778944ad50b62082abbba68aa7272fdf15dfc65a9a7065cf5c2158b0712e86a32d9a1cecd072766fb5948115", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a515c864475920a1ceee195fd98ac03e7de988de48447eaf0b686d7fa77271f9cdcee163aafa4f76b93935847a37267d89aebcba67ac08268c512019d1e345eb"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-08-07 04:36:14.334706) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 04:36:14.334976) ========= 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=6d15e502d8e29d5d2676d664000001c3-1470568542.369176-1542316025 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004571 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-08-07 04:36:14.416577) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 04:36:14.416846) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-08-07 04:36:14.417095) ========= ========= Total master_lag: 0.15 =========