builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-060 starttime: 1467941708.83 results: success (0) buildid: 20160707171626 builduid: d476c4c6f83f4ca48e110f6177a61747 revision: 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:08.827010) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:08.827676) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:08.828011) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:08.868828) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:08.869079) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 18:35:08-- 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% 222M=0s 2016-07-07 18:35:09 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094378 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:08.981204) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:08.981498) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016389 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.033068) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.033388) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c --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 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c --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=337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 18:35:09,151 truncating revision to first 12 chars 2016-07-07 18:35:09,151 Setting DEBUG logging. 2016-07-07 18:35:09,151 attempt 1/10 2016-07-07 18:35:09,151 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/4e3c16ea8fce?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 18:35:09,463 unpacking tar archive at: mozilla-central-4e3c16ea8fce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.651732 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.705225) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.705592) ========= script_repo_revision: 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.706031) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.706354) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.717877) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-07 18:35:09.718388) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:35:09 INFO - MultiFileLogger online at 20160707 18:35:09 in /builds/slave/test 18:35:09 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 18:35:09 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:35:09 INFO - {'append_to_log': False, 18:35:09 INFO - 'base_work_dir': '/builds/slave/test', 18:35:09 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:35:09 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:35:09 INFO - 'branch': 'Firefox-Non-PGO', 18:35:09 INFO - 'buildbot_json_path': 'buildprops.json', 18:35:09 INFO - 'config_files': ('talos/linux_config.py',), 18:35:09 INFO - 'default_actions': ('clobber', 18:35:09 INFO - 'read-buildbot-config', 18:35:09 INFO - 'download-and-extract', 18:35:09 INFO - 'populate-webroot', 18:35:09 INFO - 'create-virtualenv', 18:35:09 INFO - 'install', 18:35:09 INFO - 'run-tests'), 18:35:09 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:35:09 INFO - 'download_minidump_stackwalk': True, 18:35:09 INFO - 'download_symbols': 'ondemand', 18:35:09 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:35:09 INFO - 'tooltool.py': '/tools/tooltool.py', 18:35:09 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:35:09 INFO - '/tools/misc-python/virtualenv.py')}, 18:35:09 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:35:09 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:35:09 INFO - 'installer_path': 'installer.exe', 18:35:09 INFO - 'log_level': 'info', 18:35:09 INFO - 'log_name': 'talos', 18:35:09 INFO - 'log_to_console': True, 18:35:09 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:35:09 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:35:09 INFO - 'opt_config_files': (), 18:35:09 INFO - 'pip_index': False, 18:35:09 INFO - 'sps_profile': False, 18:35:09 INFO - 'sps_profile_interval': 0, 18:35:09 INFO - 'suite': 'dromaeojs-e10s', 18:35:09 INFO - 'system_bits': '32', 18:35:09 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:35:09 INFO - 'title': 'talos-linux64-ix-060', 18:35:09 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:35:09 INFO - 'use_talos_json': True, 18:35:09 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:35:09 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:35:09 INFO - 'work_dir': 'build'} 18:35:09 INFO - ##### 18:35:09 INFO - ##### Running clobber step. 18:35:09 INFO - ##### 18:35:09 INFO - Running pre-action listener: _resource_record_pre_action 18:35:09 INFO - Running main action method: clobber 18:35:09 INFO - rmtree: /builds/slave/test/build 18:35:09 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:35:10 INFO - Running post-action listener: _resource_record_post_action 18:35:10 INFO - ##### 18:35:10 INFO - ##### Finished clobber step (success) 18:35:10 INFO - ##### 18:35:10 INFO - ##### 18:35:10 INFO - ##### Running read-buildbot-config step. 18:35:10 INFO - ##### 18:35:10 INFO - Running pre-action listener: _resource_record_pre_action 18:35:10 INFO - Running main action method: read_buildbot_config 18:35:10 INFO - Using buildbot properties: 18:35:10 INFO - { 18:35:10 INFO - "project": "", 18:35:10 INFO - "product": "firefox", 18:35:10 INFO - "script_repo_revision": "production", 18:35:10 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 18:35:10 INFO - "repository": "", 18:35:10 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 18:35:10 INFO - "buildid": "20160707171626", 18:35:10 INFO - "pgo_build": "False", 18:35:10 INFO - "basedir": "/builds/slave/test", 18:35:10 INFO - "buildnumber": 103, 18:35:10 INFO - "slavename": "talos-linux64-ix-060", 18:35:10 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:35:10 INFO - "platform": "ubuntu64_hw", 18:35:10 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:35:10 INFO - "branch": "mozilla-central", 18:35:10 INFO - "repo_path": "mozilla-central", 18:35:10 INFO - "revision": "4e3c16ea8fced03ab4ef572f16d4aa4464981e2c", 18:35:10 INFO - "stage_platform": "linux64", 18:35:10 INFO - "builduid": "d476c4c6f83f4ca48e110f6177a61747", 18:35:10 INFO - "slavebuilddir": "test" 18:35:10 INFO - } 18:35:10 INFO - Found installer url https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 18:35:10 INFO - Running post-action listener: _resource_record_post_action 18:35:10 INFO - ##### 18:35:10 INFO - ##### Finished read-buildbot-config step (success) 18:35:10 INFO - ##### 18:35:10 INFO - ##### 18:35:10 INFO - ##### Running download-and-extract step. 18:35:10 INFO - ##### 18:35:10 INFO - Running pre-action listener: _resource_record_pre_action 18:35:10 INFO - Running main action method: download_and_extract 18:35:10 INFO - mkdir: /builds/slave/test/build/tests 18:35:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:10 INFO - https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 18:35:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:35:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:35:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:35:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 18:35:11 INFO - Downloaded 1361 bytes. 18:35:11 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:35:11 INFO - Using the following test package requirements: 18:35:11 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:35:11 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:35:11 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:35:11 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:11 INFO - u'jsshell-linux-x86_64.zip'], 18:35:11 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:35:11 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:35:11 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:35:11 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:35:11 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:35:11 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:11 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:35:11 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:35: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://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:11 INFO - https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:35:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:35:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:35:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:35:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:35:15 INFO - Downloaded 22734691 bytes. 18:35:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:35:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:35:16 INFO - Return code: 0 18:35:16 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:35:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:16 INFO - https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:35:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:35:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:35:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 18:35:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:35:17 INFO - Downloaded 22734691 bytes. 18:35:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:35:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 18:35:18 INFO - Return code: 0 18:35:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:18 INFO - https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:35:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:35:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:35:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:35:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:35:20 INFO - Downloaded 14403333 bytes. 18:35:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 18:35:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 18:35:20 INFO - Return code: 0 18:35:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:20 INFO - https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:35:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:35:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:35:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:35:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:35:23 INFO - Downloaded 56650191 bytes. 18:35:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:35:23 INFO - mkdir: /builds/slave/test/properties 18:35:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:35:23 INFO - Writing to file /builds/slave/test/properties/build_url 18:35:23 INFO - Contents: 18:35:23 INFO - build_url:https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 18:35:23 INFO - Running post-action listener: _resource_record_post_action 18:35:23 INFO - Running post-action listener: set_extra_try_arguments 18:35:23 INFO - ##### 18:35:23 INFO - ##### Finished download-and-extract step (success) 18:35:23 INFO - ##### 18:35:23 INFO - ##### 18:35:23 INFO - ##### Running populate-webroot step. 18:35:23 INFO - ##### 18:35:23 INFO - Running pre-action listener: _resource_record_pre_action 18:35:23 INFO - Running main action method: populate_webroot 18:35:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:35:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:35:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:35:23 INFO - '--tppagecycles', 18:35:23 INFO - '7'], 18:35:23 INFO - 'tests': ['tsvgm']}}, 18:35:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:35:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:35:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 18:35:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 18:35:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:35:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 18:35:24 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:24 INFO - 'talos_options': ['--disable-e10s'], 18:35:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:35:24 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:35:24 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:24 INFO - 'talos_options': ['--disable-e10s'], 18:35:24 INFO - 'tests': ['damp', 'tps']}, 18:35:24 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:24 INFO - 'tests': ['damp', 'tps']}, 18:35:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 18:35:24 INFO - 'tests': ['dromaeo_dom']}, 18:35:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:35:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 18:35:24 INFO - 'tests': ['basic_compositor_video']}, 18:35:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 18:35:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 18:35:24 INFO - 'tests': ['a11yr', 18:35:24 INFO - 'ts_paint', 18:35:24 INFO - 'tpaint', 18:35:24 INFO - 'sessionrestore', 18:35:24 INFO - 'sessionrestore_no_auto_restore', 18:35:24 INFO - 'tabpaint']}, 18:35:24 INFO - 'other-e10s': {'tests': ['a11yr', 18:35:24 INFO - 'ts_paint', 18:35:24 INFO - 'tpaint', 18:35:24 INFO - 'sessionrestore', 18:35:24 INFO - 'sessionrestore_no_auto_restore', 18:35:24 INFO - 'tabpaint']}, 18:35:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 18:35:24 INFO - 'ts_paint', 18:35:24 INFO - 'tpaint', 18:35:24 INFO - 'sessionrestore', 18:35:24 INFO - 'sessionrestore_no_auto_restore', 18:35:24 INFO - 'tabpaint']}, 18:35:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 18:35:24 INFO - 'ts_paint', 18:35:24 INFO - 'tpaint', 18:35:24 INFO - 'sessionrestore', 18:35:24 INFO - 'sessionrestore_no_auto_restore', 18:35:24 INFO - 'tabpaint']}, 18:35:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 18:35:24 INFO - 'tests': ['a11yr', 18:35:24 INFO - 'ts_paint', 18:35:24 INFO - 'tpaint', 18:35:24 INFO - 'sessionrestore', 18:35:24 INFO - 'sessionrestore_no_auto_restore', 18:35:24 INFO - 'tabpaint']}, 18:35:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 18:35:24 INFO - 'tests': ['a11yr', 18:35:24 INFO - 'ts_paint', 18:35:24 INFO - 'tpaint', 18:35:24 INFO - 'sessionrestore', 18:35:24 INFO - 'sessionrestore_no_auto_restore', 18:35:24 INFO - 'tabpaint']}, 18:35:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 18:35:24 INFO - 'tests': ['tsvgx', 18:35:24 INFO - 'tsvgr_opacity', 18:35:24 INFO - 'tart', 18:35:24 INFO - 'tscrollx', 18:35:24 INFO - 'cart']}, 18:35:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 18:35:24 INFO - 'tsvgr_opacity', 18:35:24 INFO - 'tart', 18:35:24 INFO - 'tscrollx', 18:35:24 INFO - 'cart']}, 18:35:24 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:24 INFO - 'talos_options': ['--disable-e10s'], 18:35:24 INFO - 'tests': ['tp5o']}, 18:35:24 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:24 INFO - 'tests': ['tp5o']}, 18:35:24 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:24 INFO - 'talos_options': ['--disable-e10s', 18:35:24 INFO - '--xperf_path', 18:35:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:35:24 INFO - 'tests': ['tp5n']}, 18:35:24 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:35:24 INFO - 'talos_options': ['--xperf_path', 18:35:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:35:24 INFO - 'tests': ['tp5n']}}, 18:35:24 INFO - 'talos.zip': {'path': '', 18:35:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:35:24 INFO - Running post-action listener: _resource_record_post_action 18:35:24 INFO - ##### 18:35:24 INFO - ##### Finished populate-webroot step (success) 18:35:24 INFO - ##### 18:35:24 INFO - ##### 18:35:24 INFO - ##### Running create-virtualenv step. 18:35:24 INFO - ##### 18:35:24 INFO - Running pre-action listener: _resource_record_pre_action 18:35:24 INFO - Running main action method: create_virtualenv 18:35:24 INFO - Creating virtualenv /builds/slave/test/build/venv 18:35:24 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 18:35:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:35:24 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:35:24 INFO - Using real prefix '/usr' 18:35:24 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:35:24 INFO - Installing distribute.............................................................................................................................................................................................done. 18:35:26 INFO - Installing pip.................done. 18:35:26 INFO - Return code: 0 18:35:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:26 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 0x28d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b01400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b90570>, '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 0x2b91470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91900>, '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': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', '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 18:35:26 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 18:35:26 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 18:35:26 INFO - Using env: {'DISPLAY': ':0', 18:35:26 INFO - 'HOME': '/home/cltbld', 18:35:26 INFO - 'LANG': 'en_US.UTF-8', 18:35:26 INFO - 'LANGUAGE': 'en_US:en', 18:35:26 INFO - 'LOGNAME': 'cltbld', 18:35:26 INFO - 'MAIL': '/var/mail/cltbld', 18:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:26 INFO - 'MOZ_NO_REMOTE': '1', 18:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:26 INFO - 'NO_EM_RESTART': '1', 18:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:26 INFO - 'PWD': '/builds/slave/test', 18:35:26 INFO - 'SHELL': '/bin/bash', 18:35:26 INFO - 'SHLVL': '1', 18:35:26 INFO - 'TERM': 'linux', 18:35:26 INFO - 'TMOUT': '86400', 18:35:26 INFO - 'USER': 'cltbld', 18:35:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', 18:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:26 INFO - '_': '/tools/buildbot/bin/python'} 18:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:26 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 18:35:26 INFO - Cleaning up... 18:35:26 INFO - Return code: 0 18:35:26 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:26 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 0x28d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b01400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b90570>, '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 0x2b91470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91900>, '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': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', '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 18:35:26 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 18:35:26 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 18:35:26 INFO - Using env: {'DISPLAY': ':0', 18:35:26 INFO - 'HOME': '/home/cltbld', 18:35:26 INFO - 'LANG': 'en_US.UTF-8', 18:35:26 INFO - 'LANGUAGE': 'en_US:en', 18:35:26 INFO - 'LOGNAME': 'cltbld', 18:35:26 INFO - 'MAIL': '/var/mail/cltbld', 18:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:26 INFO - 'MOZ_NO_REMOTE': '1', 18:35:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:26 INFO - 'NO_EM_RESTART': '1', 18:35:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:26 INFO - 'PWD': '/builds/slave/test', 18:35:26 INFO - 'SHELL': '/bin/bash', 18:35:26 INFO - 'SHLVL': '1', 18:35:26 INFO - 'TERM': 'linux', 18:35:26 INFO - 'TMOUT': '86400', 18:35:26 INFO - 'USER': 'cltbld', 18:35:26 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', 18:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:26 INFO - '_': '/tools/buildbot/bin/python'} 18:35:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:26 INFO - Downloading/unpacking psutil>=3.1.1 18:35:26 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 18:35:26 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 18:35:26 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 18:35:26 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 18:35:26 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 18:35:26 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 18:35:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:35:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:35:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:35:28 INFO - Installing collected packages: psutil 18:35:28 INFO - Running setup.py install for psutil 18:35:29 INFO - building 'psutil._psutil_linux' extension 18:35:29 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 18:35:29 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 18:35:29 INFO - building 'psutil._psutil_posix' extension 18:35:29 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 18:35:29 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 18:35:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:35:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:35:29 INFO - Successfully installed psutil 18:35:29 INFO - Cleaning up... 18:35:29 INFO - Return code: 0 18:35:29 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:29 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 0x28d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b01400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b90570>, '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 0x2b91470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91900>, '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': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', '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 18:35:29 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 18:35:29 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 18:35:29 INFO - Using env: {'DISPLAY': ':0', 18:35:29 INFO - 'HOME': '/home/cltbld', 18:35:29 INFO - 'LANG': 'en_US.UTF-8', 18:35:29 INFO - 'LANGUAGE': 'en_US:en', 18:35:29 INFO - 'LOGNAME': 'cltbld', 18:35:29 INFO - 'MAIL': '/var/mail/cltbld', 18:35:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:29 INFO - 'MOZ_NO_REMOTE': '1', 18:35:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:29 INFO - 'NO_EM_RESTART': '1', 18:35:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:29 INFO - 'PWD': '/builds/slave/test', 18:35:29 INFO - 'SHELL': '/bin/bash', 18:35:29 INFO - 'SHLVL': '1', 18:35:29 INFO - 'TERM': 'linux', 18:35:29 INFO - 'TMOUT': '86400', 18:35:29 INFO - 'USER': 'cltbld', 18:35:29 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', 18:35:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:29 INFO - '_': '/tools/buildbot/bin/python'} 18:35:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:29 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:35:29 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 18:35:29 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 18:35:29 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 18:35:29 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 18:35:29 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 18:35:29 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 18:35:31 INFO - Downloading mozsystemmonitor-0.3.tar.gz 18:35:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:35:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 18:35:31 INFO - Installing collected packages: mozsystemmonitor 18:35:31 INFO - Running setup.py install for mozsystemmonitor 18:35:31 INFO - Successfully installed mozsystemmonitor 18:35:31 INFO - Cleaning up... 18:35:31 INFO - Return code: 0 18:35:31 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:31 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 0x28d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b01400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b90570>, '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 0x2b91470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91900>, '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': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', '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 18:35:31 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 18:35:31 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 18:35:31 INFO - Using env: {'DISPLAY': ':0', 18:35:31 INFO - 'HOME': '/home/cltbld', 18:35:31 INFO - 'LANG': 'en_US.UTF-8', 18:35:31 INFO - 'LANGUAGE': 'en_US:en', 18:35:31 INFO - 'LOGNAME': 'cltbld', 18:35:31 INFO - 'MAIL': '/var/mail/cltbld', 18:35:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:31 INFO - 'MOZ_NO_REMOTE': '1', 18:35:31 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:31 INFO - 'NO_EM_RESTART': '1', 18:35:31 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:31 INFO - 'PWD': '/builds/slave/test', 18:35:31 INFO - 'SHELL': '/bin/bash', 18:35:31 INFO - 'SHLVL': '1', 18:35:31 INFO - 'TERM': 'linux', 18:35:31 INFO - 'TMOUT': '86400', 18:35:31 INFO - 'USER': 'cltbld', 18:35:31 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', 18:35:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:31 INFO - '_': '/tools/buildbot/bin/python'} 18:35:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:32 INFO - Downloading/unpacking jsonschema==2.5.1 18:35:32 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 18:35:32 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 18:35:32 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 18:35:32 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 18:35:32 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 18:35:32 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 18:35:33 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:35:33 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 18:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:34 INFO - Downloading functools32-3.2.3-2.tar.gz 18:35:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:35:34 INFO - warning: no files found matching '*.txt' 18:35:34 INFO - no previously-included directories found matching 'build' 18:35:34 INFO - no previously-included directories found matching 'dist' 18:35:34 INFO - no previously-included directories found matching '.git*' 18:35:34 INFO - Installing collected packages: jsonschema, functools32 18:35:34 INFO - Running setup.py install for functools32 18:35:34 INFO - warning: no files found matching '*.txt' 18:35:34 INFO - no previously-included directories found matching 'build' 18:35:34 INFO - no previously-included directories found matching 'dist' 18:35:34 INFO - no previously-included directories found matching '.git*' 18:35:34 INFO - Successfully installed jsonschema functools32 18:35:34 INFO - Cleaning up... 18:35:34 INFO - Return code: 0 18:35:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:34 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 0x28d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b01400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b90570>, '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 0x2b91470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91900>, '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': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', '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 18:35:34 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 18:35:34 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 18:35:34 INFO - Using env: {'DISPLAY': ':0', 18:35:34 INFO - 'HOME': '/home/cltbld', 18:35:34 INFO - 'LANG': 'en_US.UTF-8', 18:35:34 INFO - 'LANGUAGE': 'en_US:en', 18:35:34 INFO - 'LOGNAME': 'cltbld', 18:35:34 INFO - 'MAIL': '/var/mail/cltbld', 18:35:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:34 INFO - 'MOZ_NO_REMOTE': '1', 18:35:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:34 INFO - 'NO_EM_RESTART': '1', 18:35:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:34 INFO - 'PWD': '/builds/slave/test', 18:35:34 INFO - 'SHELL': '/bin/bash', 18:35:34 INFO - 'SHLVL': '1', 18:35:34 INFO - 'TERM': 'linux', 18:35:34 INFO - 'TMOUT': '86400', 18:35:34 INFO - 'USER': 'cltbld', 18:35:34 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', 18:35:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:34 INFO - '_': '/tools/buildbot/bin/python'} 18:35:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:34 INFO - Downloading/unpacking blobuploader==1.2.4 18:35:34 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 18:35:34 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 18:35:34 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 18:35:34 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 18:35:34 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 18:35:34 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 18:35:36 INFO - Downloading blobuploader-1.2.4.tar.gz 18:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:35:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:35:36 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 18:35:36 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 18:35:36 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 18:35:36 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 18:35:36 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 18:35:36 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 18:35:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:35:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:35:36 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 18:35:36 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 18:35:36 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 18:35:36 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 18:35:36 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 18:35:36 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 18:35:37 INFO - Downloading docopt-0.6.1.tar.gz 18:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:35:37 INFO - Installing collected packages: blobuploader, requests, docopt 18:35:37 INFO - Running setup.py install for blobuploader 18:35:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:35:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:35:37 INFO - Running setup.py install for requests 18:35:37 INFO - Running setup.py install for docopt 18:35:37 INFO - Successfully installed blobuploader requests docopt 18:35:37 INFO - Cleaning up... 18:35:37 INFO - Return code: 0 18:35:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:37 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 0x28d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b01400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b90570>, '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 0x2b91470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91900>, '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': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', '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 18:35:37 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 18:35:37 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 18:35:37 INFO - Using env: {'DISPLAY': ':0', 18:35:37 INFO - 'HOME': '/home/cltbld', 18:35:37 INFO - 'LANG': 'en_US.UTF-8', 18:35:37 INFO - 'LANGUAGE': 'en_US:en', 18:35:37 INFO - 'LOGNAME': 'cltbld', 18:35:37 INFO - 'MAIL': '/var/mail/cltbld', 18:35:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:37 INFO - 'MOZ_NO_REMOTE': '1', 18:35:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:37 INFO - 'NO_EM_RESTART': '1', 18:35:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:37 INFO - 'PWD': '/builds/slave/test', 18:35:37 INFO - 'SHELL': '/bin/bash', 18:35:37 INFO - 'SHLVL': '1', 18:35:37 INFO - 'TERM': 'linux', 18:35:37 INFO - 'TMOUT': '86400', 18:35:37 INFO - 'USER': 'cltbld', 18:35:37 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', 18:35:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:37 INFO - '_': '/tools/buildbot/bin/python'} 18:35:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:35:38 INFO - Running setup.py (path:/tmp/pip-7zRgos-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:35:38 INFO - Running setup.py (path:/tmp/pip-Y2neYe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:35:38 INFO - Running setup.py (path:/tmp/pip-2N4Vi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:35:38 INFO - Running setup.py (path:/tmp/pip-7RVnCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:35:38 INFO - Running setup.py (path:/tmp/pip-lNp0I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:35:38 INFO - Running setup.py (path:/tmp/pip-xJO2mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:35:38 INFO - Running setup.py (path:/tmp/pip-nW20Vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:35:38 INFO - Running setup.py (path:/tmp/pip-9F2_Bp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:35:38 INFO - Running setup.py (path:/tmp/pip-lMqJFQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:35:38 INFO - Running setup.py (path:/tmp/pip-jjdgxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:35:38 INFO - Running setup.py (path:/tmp/pip-QocwrD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:35:38 INFO - Running setup.py (path:/tmp/pip-hv1Cak-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:35:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:35:38 INFO - Running setup.py (path:/tmp/pip-GxtMZe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:35:39 INFO - Running setup.py (path:/tmp/pip-IpuH8H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:39 INFO - Running setup.py (path:/tmp/pip-lnFuht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:35:39 INFO - Running setup.py (path:/tmp/pip-ozb6EJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:35:39 INFO - Running setup.py (path:/tmp/pip-mNHrkL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:35:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:35:39 INFO - Running setup.py install for manifestparser 18:35:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:35:39 INFO - Running setup.py install for mozcrash 18:35:39 INFO - Running setup.py install for mozdebug 18:35:39 INFO - Running setup.py install for mozdevice 18:35:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:35:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:35:39 INFO - Running setup.py install for mozfile 18:35:39 INFO - Running setup.py install for mozhttpd 18:35:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:35:39 INFO - Running setup.py install for mozinfo 18:35:40 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Running setup.py install for mozInstall 18:35:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Running setup.py install for mozleak 18:35:40 INFO - Running setup.py install for mozlog 18:35:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Running setup.py install for moznetwork 18:35:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Running setup.py install for mozprocess 18:35:40 INFO - Running setup.py install for mozprofile 18:35:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Running setup.py install for mozrunner 18:35:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Running setup.py install for mozscreenshot 18:35:40 INFO - Running setup.py install for moztest 18:35:40 INFO - Running setup.py install for mozversion 18:35:41 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:35:41 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:35:41 INFO - Cleaning up... 18:35:41 INFO - Return code: 0 18:35:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:41 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 0x28d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b01400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b90570>, '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 0x2b91470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91900>, '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': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', '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 18:35:41 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 18:35:41 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 18:35:41 INFO - Using env: {'DISPLAY': ':0', 18:35:41 INFO - 'HOME': '/home/cltbld', 18:35:41 INFO - 'LANG': 'en_US.UTF-8', 18:35:41 INFO - 'LANGUAGE': 'en_US:en', 18:35:41 INFO - 'LOGNAME': 'cltbld', 18:35:41 INFO - 'MAIL': '/var/mail/cltbld', 18:35:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:41 INFO - 'MOZ_NO_REMOTE': '1', 18:35:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:41 INFO - 'NO_EM_RESTART': '1', 18:35:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:41 INFO - 'PWD': '/builds/slave/test', 18:35:41 INFO - 'SHELL': '/bin/bash', 18:35:41 INFO - 'SHLVL': '1', 18:35:41 INFO - 'TERM': 'linux', 18:35:41 INFO - 'TMOUT': '86400', 18:35:41 INFO - 'USER': 'cltbld', 18:35:41 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', 18:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:41 INFO - '_': '/tools/buildbot/bin/python'} 18:35:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:35:41 INFO - Running setup.py (path:/tmp/pip-BdO9yN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:35:41 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)) 18:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:35:41 INFO - Running setup.py (path:/tmp/pip-Z4ZiO4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:35:41 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)) 18:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:35:41 INFO - Running setup.py (path:/tmp/pip-dKZisF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:35:41 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)) 18:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:35:41 INFO - Running setup.py (path:/tmp/pip-8XdQ3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:35:41 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)) 18:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:35:41 INFO - Running setup.py (path:/tmp/pip-hUx5NU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:35:41 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)) 18:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:35:41 INFO - Running setup.py (path:/tmp/pip-o1yQJ6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:35:41 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)) 18:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:35:41 INFO - Running setup.py (path:/tmp/pip-p5j42b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:35:41 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)) 18:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:35:41 INFO - Running setup.py (path:/tmp/pip-dxskYv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:35:41 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)) 18:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:35:41 INFO - Running setup.py (path:/tmp/pip-bISsm3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:35:41 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)) 18:35:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:35:41 INFO - Running setup.py (path:/tmp/pip-HCExb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:35:42 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:35:42 INFO - Running setup.py (path:/tmp/pip-O7qqDR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:35:42 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)) 18:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:35:42 INFO - Running setup.py (path:/tmp/pip-Oh9d2D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:35:42 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)) 18:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:35:42 INFO - Running setup.py (path:/tmp/pip-NAoTyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:35:42 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)) 18:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:35:42 INFO - Running setup.py (path:/tmp/pip-mvL2_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:35:42 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)) 18:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:42 INFO - Running setup.py (path:/tmp/pip-NXuNKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:42 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)) 18:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:35:42 INFO - Running setup.py (path:/tmp/pip-jFAtOJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:35:42 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)) 18:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:35:42 INFO - Running setup.py (path:/tmp/pip-sZDhyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:35:42 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)) 18:35:42 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)) 18:35:42 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)) 18:35:42 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)) 18:35:42 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)) 18:35:42 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)) 18:35:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:35:42 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 18:35:42 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 18:35:42 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 18:35:42 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 18:35:42 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 18:35:42 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 18:35:44 INFO - Downloading blessings-1.6.tar.gz 18:35:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:35:44 INFO - Installing collected packages: blessings 18:35:44 INFO - Running setup.py install for blessings 18:35:44 INFO - Successfully installed blessings 18:35:44 INFO - Cleaning up... 18:35:44 INFO - Return code: 0 18:35:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:35:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:35:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:35:44 INFO - Reading from file tmpfile_stdout 18:35:44 INFO - Current package versions: 18:35:44 INFO - argparse == 1.2.1 18:35:44 INFO - blessings == 1.6 18:35:44 INFO - blobuploader == 1.2.4 18:35:44 INFO - docopt == 0.6.1 18:35:44 INFO - functools32 == 3.2.3-2 18:35:44 INFO - jsonschema == 2.5.1 18:35:44 INFO - manifestparser == 1.1 18:35:44 INFO - mozInstall == 1.12 18:35:44 INFO - mozcrash == 0.17 18:35:44 INFO - mozdebug == 0.1 18:35:44 INFO - mozdevice == 0.48 18:35:44 INFO - mozfile == 1.2 18:35:44 INFO - mozhttpd == 0.7 18:35:44 INFO - mozinfo == 0.9 18:35:44 INFO - mozleak == 0.1 18:35:44 INFO - mozlog == 3.2 18:35:44 INFO - moznetwork == 0.27 18:35:44 INFO - mozprocess == 0.23 18:35:44 INFO - mozprofile == 0.28 18:35:44 INFO - mozrunner == 6.12 18:35:44 INFO - mozscreenshot == 0.1 18:35:44 INFO - mozsystemmonitor == 0.3 18:35:44 INFO - moztest == 0.7 18:35:44 INFO - mozversion == 1.4 18:35:44 INFO - psutil == 3.1.1 18:35:44 INFO - requests == 1.2.3 18:35:44 INFO - wsgiref == 0.1.2 18:35:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:44 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 0x28d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b01400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b90570>, '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 0x2b91470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91900>, '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': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', '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 18:35:44 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 18:35:44 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 18:35:44 INFO - Using env: {'DISPLAY': ':0', 18:35:44 INFO - 'HOME': '/home/cltbld', 18:35:44 INFO - 'LANG': 'en_US.UTF-8', 18:35:44 INFO - 'LANGUAGE': 'en_US:en', 18:35:44 INFO - 'LOGNAME': 'cltbld', 18:35:44 INFO - 'MAIL': '/var/mail/cltbld', 18:35:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:44 INFO - 'MOZ_NO_REMOTE': '1', 18:35:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:44 INFO - 'NO_EM_RESTART': '1', 18:35:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:44 INFO - 'PWD': '/builds/slave/test', 18:35:44 INFO - 'SHELL': '/bin/bash', 18:35:44 INFO - 'SHLVL': '1', 18:35:44 INFO - 'TERM': 'linux', 18:35:44 INFO - 'TMOUT': '86400', 18:35:44 INFO - 'USER': 'cltbld', 18:35:44 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', 18:35:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:44 INFO - '_': '/tools/buildbot/bin/python'} 18:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:45 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)) 18:35:45 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)) 18:35:45 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)) 18:35:45 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)) 18:35:45 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)) 18:35:45 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)) 18:35:45 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)) 18:35:45 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)) 18:35:45 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)) 18:35:45 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)) 18:35:45 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)) 18:35:45 INFO - Cleaning up... 18:35:45 INFO - Return code: 0 18:35:45 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:45 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 0x28d2030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a358a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b01400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b90570>, '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 0x2b91470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91900>, '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': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', '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 18:35:45 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 18:35:45 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 18:35:45 INFO - Using env: {'DISPLAY': ':0', 18:35:45 INFO - 'HOME': '/home/cltbld', 18:35:45 INFO - 'LANG': 'en_US.UTF-8', 18:35:45 INFO - 'LANGUAGE': 'en_US:en', 18:35:45 INFO - 'LOGNAME': 'cltbld', 18:35:45 INFO - 'MAIL': '/var/mail/cltbld', 18:35:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:45 INFO - 'MOZ_NO_REMOTE': '1', 18:35:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:45 INFO - 'NO_EM_RESTART': '1', 18:35:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:45 INFO - 'PWD': '/builds/slave/test', 18:35:45 INFO - 'SHELL': '/bin/bash', 18:35:45 INFO - 'SHLVL': '1', 18:35:45 INFO - 'TERM': 'linux', 18:35:45 INFO - 'TMOUT': '86400', 18:35:45 INFO - 'USER': 'cltbld', 18:35:45 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', 18:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:45 INFO - '_': '/tools/buildbot/bin/python'} 18:35:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:35:45 INFO - Cleaning up... 18:35:45 INFO - Return code: 0 18:35:45 INFO - Running post-action listener: _resource_record_post_action 18:35:45 INFO - Running post-action listener: _start_resource_monitoring 18:35:45 INFO - Starting resource monitoring. 18:35:45 INFO - ##### 18:35:45 INFO - ##### Finished create-virtualenv step (success) 18:35:45 INFO - ##### 18:35:45 INFO - ##### 18:35:45 INFO - ##### Running install step. 18:35:45 INFO - ##### 18:35:45 INFO - Running pre-action listener: _resource_record_pre_action 18:35:45 INFO - Running main action method: install 18:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:35:45 INFO - Reading from file tmpfile_stdout 18:35:45 INFO - Detecting whether we're running mozinstall >=1.0... 18:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:35:45 INFO - Reading from file tmpfile_stdout 18:35:45 INFO - Output received: 18:35:45 INFO - Usage: mozinstall [options] installer 18:35:45 INFO - Options: 18:35:45 INFO - -h, --help show this help message and exit 18:35:45 INFO - -d DEST, --destination=DEST 18:35:45 INFO - Directory to install application into. [default: 18:35:45 INFO - "/builds/slave/test"] 18:35:45 INFO - --app=APP Application being installed. [default: firefox] 18:35:45 INFO - mkdir: /builds/slave/test/build/application 18:35:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:35:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:36:02 INFO - Reading from file tmpfile_stdout 18:36:02 INFO - Output received: 18:36:02 INFO - /builds/slave/test/build/application/firefox/firefox 18:36:02 INFO - Running post-action listener: _resource_record_post_action 18:36:02 INFO - ##### 18:36:02 INFO - ##### Finished install step (success) 18:36:02 INFO - ##### 18:36:02 INFO - ##### 18:36:02 INFO - ##### Running run-tests step. 18:36:02 INFO - ##### 18:36:02 INFO - Running pre-action listener: _resource_record_pre_action 18:36:02 INFO - Running main action method: run_tests 18:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:36:02 INFO - Python 2.7.3 18:36:02 INFO - Return code: 0 18:36:02 INFO - grabbing minidump binary from tooltool 18:36:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:36:02 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 0x2b90570>, '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 0x2b91470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b91900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:36:02 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 18:36:02 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 18:36:02 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 18:36:02 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:36:02 INFO - Return code: 0 18:36:02 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:36:02 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:36:02 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:36:02 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:36:02 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:36:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 18:36:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-060 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 18:36:02 INFO - Using env: {'DISPLAY': ':0', 18:36:02 INFO - 'HOME': '/home/cltbld', 18:36:02 INFO - 'LANG': 'en_US.UTF-8', 18:36:02 INFO - 'LANGUAGE': 'en_US:en', 18:36:02 INFO - 'LOGNAME': 'cltbld', 18:36:02 INFO - 'MAIL': '/var/mail/cltbld', 18:36:02 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:36:02 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:36:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:02 INFO - 'MOZ_NO_REMOTE': '1', 18:36:02 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:36:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:36:02 INFO - 'NO_EM_RESTART': '1', 18:36:02 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:36:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:02 INFO - 'PWD': '/builds/slave/test', 18:36:02 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:36:02 INFO - 'SHELL': '/bin/bash', 18:36:02 INFO - 'SHLVL': '1', 18:36:02 INFO - 'TERM': 'linux', 18:36:02 INFO - 'TMOUT': '86400', 18:36:02 INFO - 'USER': 'cltbld', 18:36:02 INFO - 'XDG_SESSION_COOKIE': '337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402', 18:36:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:02 INFO - '_': '/tools/buildbot/bin/python'} 18:36:02 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-060', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 18:36:02 INFO - mozversion application_buildid: 20160707171626 18:36:02 INFO - mozversion application_changeset: 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c 18:36:02 INFO - mozversion application_display_name: Nightly 18:36:02 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:36:02 INFO - mozversion application_name: Firefox 18:36:02 INFO - mozversion application_remotingname: firefox 18:36:02 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:36:02 INFO - mozversion application_vendor: Mozilla 18:36:02 INFO - mozversion application_version: 50.0a1 18:36:02 INFO - mozversion platform_buildid: 20160707171626 18:36:02 INFO - mozversion platform_changeset: 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c 18:36:02 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:36:02 INFO - mozversion platform_version: 50.0a1 18:36:02 INFO - using testdate: 1467941762 18:36:02 INFO - actual date: 1467941762 18:36:02 INFO - starting webserver on 'localhost:38075' 18:36:02 INFO - SUITE-START | Running 2 tests 18:36:02 INFO - TEST-START | dromaeo_css 18:36:02 INFO - operating with platform_type : linux_ 18:36:02 INFO - Initialising browser for dromaeo_css test... 18:36:02 INFO - TEST-INFO | started process 30338 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy510CB/profile http://localhost:38075/getInfo.html) 18:36:07 INFO - PROCESS | 30338 | __metrics Screen width/height:1600/1200 18:36:07 INFO - PROCESS | 30338 | colorDepth:24 18:36:07 INFO - PROCESS | 30338 | Browser inner width/height: 1024/697 18:36:07 INFO - PROCESS | 30338 | __metrics 18:36:07 ERROR - PROCESS | 30338 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 18:36:08 INFO - TEST-INFO | 30338: exit 0 18:36:08 INFO - Browser initialized. 18:36:08 INFO - Running cycle 1/1 for dromaeo_css test... 18:36:08 INFO - TEST-INFO | started process 30460 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpy510CB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:36:20 INFO - PROCESS | 30460 | RSS: Main: 169009152 18:36:20 INFO - PROCESS | 30460 | 18:37:10 INFO - PROCESS | 30460 | 1467941830276 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] 18:39:22 INFO - PROCESS | 30460 | Cycle 1(1): loaded http://localhost:38075/tests/dromaeo/cssquery-dojo.html (next: http://localhost:38075/tests/dromaeo/cssquery-ext.html) 18:39:23 INFO - PROCESS | 30460 | RSS: Main: 171286528 18:39:23 INFO - PROCESS | 30460 | 18:42:25 INFO - PROCESS | 30460 | Cycle 1(1): loaded http://localhost:38075/tests/dromaeo/cssquery-ext.html (next: http://localhost:38075/tests/dromaeo/cssquery-jquery.html) 18:42:26 INFO - PROCESS | 30460 | RSS: Main: 168607744 18:42:26 INFO - PROCESS | 30460 | 18:45:28 INFO - PROCESS | 30460 | Cycle 1(1): loaded http://localhost:38075/tests/dromaeo/cssquery-jquery.html (next: http://localhost:38075/tests/dromaeo/cssquery-mootools.html) 18:45:29 INFO - PROCESS | 30460 | RSS: Main: 170864640 18:45:29 INFO - PROCESS | 30460 | 18:48:30 INFO - PROCESS | 30460 | Cycle 1(1): loaded http://localhost:38075/tests/dromaeo/cssquery-mootools.html (next: http://localhost:38075/tests/dromaeo/cssquery-prototype.html) 18:48:31 INFO - PROCESS | 30460 | RSS: Main: 166666240 18:48:31 INFO - PROCESS | 30460 | 18:51:34 INFO - PROCESS | 30460 | Cycle 1(1): loaded http://localhost:38075/tests/dromaeo/cssquery-prototype.html (next: http://localhost:38075/tests/dromaeo/cssquery-yui.html) 18:51:35 INFO - PROCESS | 30460 | RSS: Main: 168808448 18:51:35 INFO - PROCESS | 30460 | 18:54:37 INFO - PROCESS | 30460 | Cycle 1(1): loaded http://localhost:38075/tests/dromaeo/cssquery-yui.html (next: http://localhost:38075/tests/dromaeo/cssquery-dojo.html) 18:54:37 INFO - PROCESS | 30460 | RSS: Main: 169738240 18:54:37 INFO - PROCESS | 30460 | 18:54:37 INFO - PROCESS | 30460 | __start_tp_report 18:54:37 INFO - PROCESS | 30460 | _x_x_mozilla_page_load 18:54:37 INFO - PROCESS | 30460 | _x_x_mozilla_page_load_details 18:54:37 INFO - PROCESS | 30460 | |i|pagename|runs| 18:54:37 INFO - PROCESS | 30460 | |0;dojo.html;2604.45306485638;2609.5172393107287;2619.2142357292814;2659.414928715682;2664.933376665583;4714.339992401066;4740.928886066712;4807.807687692488;4809.086273608012;4826.758662066895;4665;4774.212254977933;4804.735739534324;4827.275908613709;4880;4385.956140438595;4397.912041759163;4451.1765323415275;4483.439570053743;4508.504064552896;4482.663800214997;4483.932741008887;4505.662075344346;4513.3455648930885;4586.44962604488;4372.5627437256335;4434.911301773946;4452.265376212921;4460.8884777880485;4464.8214071437105;4459.197344477992;4459.331100334975;4463.040446304028;4467.3299005149165;4516.006478574708;4318.589733975267;4349.238883195429;4356.869293921156;4395.934060989088;4471;4781.426228852525;4813.422389313305;4815.759212039384;4816.686915350491;4846.806127754886;5098.872528186788;5125.333706618153;5144.099782538041;5144.151215049513;5149.253358263069;5130.153524668425;5153.819616313449;5172.948270517284;5184.922226166611;5201.921971170435;4829.27560865873;4848.490908454632;4852.830150944736;4854.878628034327;4894.975525122351;5220.869478262998;5279.41926388097;5285.920711189336;5294.894102117936;5316.627836051517;5019.648624596243;5100.69395836251;5108.310378098983;5110.233464980209;5110.744462776846;5064.316317297118;5107.8723031923755;5121.436641969381;5194.97402512985;5211.062008838369;4987.351644286292;5103.413107492686;5119.0273847968765;5119.795208191705;5121.07820592297;5046.949530504648;5076.060928728197;5116.130257856174;5120;5121.923171152435;4275.893102672396;4280.76455794928;4283.612185950158;4290.935635965463;4331.891702707458;3699.611540788232;3723.7579557328686;3756.3614185588517;3786.3373909565717;3802.448644946467;4449.933251001173;4456.910861782746;4466.6873318867365;4492.910141797146;4503.7522936238165;5217;5218.139007063792;5226.294450249244;5234;5234.3718753749035;4311.07311927937;4354.978225108917;4398.626116780046;4466.932996005063;4508.526604706524;4519.5480451954545;4547.431571053618;4547.63618910493;4550.158220729176;4601.217792975202;4740.739259340769;4778.928316075262;4783.521647835189;4783.617310615073;4783.95216047842;5078.847634570969;5140.665856719302;5146;5148.665336753099;5168.043911876315;4769.880752981203;4776.617870570277;4785.090832741768;4806.639502037431;4863.294822250825;5096.847094587169;5100.234964755168;5101.897962040664;5115.462876397924;5151.433342332415;5014.498550145102;5090.669106508065;5109.31024311728;5146.176611742103;5169.948300517097;4994.450610432922;5035;5039.395272567315;5039.521245481674;5052.7726252318;5067.341245638044;5067.645264831426;5075.11185542536;5078.466760990191;5118.3090282811345;4818.229083346788;4868.172410690262;4931.7040977541465;4981.028699403581;4987.551120399182;4985.1276026695905;5061.797528098835;5074.213496907985;5082.059818933509;5102.617303702312;4951.678140920829;4958.231474121517;4960.355153829979;4962.429320628174;5016.347874776256 18:54:37 INFO - PROCESS | 30460 | |1;ext.html;528.1259515501844;543.9102548079567;559.0775220885538;563.4872266237724;587.7707693999344;34905.47641785375;40076;40112.197756044865;40114.59885401145;40117.59882401175;36893;37206.62793372072;37250.813745931235;37316.253674926484;37391.4391284131;7624.69501219952;7751.6511756970785;7756.340711039568;7770.067591888953;7775.0669919609445;7597.31624153826;7647.158812530617;7647.273509016634;7673.846523069536;7728.613569321539;7626.7330643427495;7713.922860771377;7749.922500775005;7762.805929851743;7784.571848548356;7736.497127686683;7760.340371068438;7763.107242667081;7768.1066677332265;7772.922270777333;7615;7617;7659;7672.884906726404;7694.9230507694765;37878.43182352267;38308.425373619415;38366.80816595927;38493.49792263494;38497;2305.296884450242;2660.6940201876837;2705.715899830529;2863.2698661841305;2893.117599132264;26791;27618.447631047467;28009;29967.70032299671;30167.849160754275;3202.679732026802;3371.140359208386;3381.526586277923;3411.5053317268857;3521.330947120039;277118;279575;281418;281996;284170;48466.27300590494;48913.51086489161;48926;48935.5106448931;49110.843361447245;29390;30333.696663033086;30461.23846903801;30463;30485;13344.6663833403;13365.26491043002;13399.12905661129;13420.0605957584;13431.597052088453;9528.571214295373;9613.567389467491;9615.855762163574;9645.228381729445;9666.081722236377;18155.183016764277;18342;18373.17320720571;18375.816241837678;18390.540236494195;6686.465082793365;6741.292164322774;6807.421369183576;6809.285025072395;6846.828829279308;817.65249768848;949.3829011142674;964.3731574476647;1002.4135880509983;1020.260311274335;27918.720812792017;27981;28763.712362876522;28765.28086797847;28852;881.8368601808558;949.5252373813094;955.9522023898777;973.6105557776946;1010.7372083258406;14277.857221427861;14379.568612941628;14670.853291466949;14699.41202351894;14717.337719802634;428361;437122;437522;437560;437569;47130.76434617874;47694.5230547697;48011.75994120007;48280.5171948283;48336.7583162089;1146.415328182633;1174.236746115015;1193.2303664136584;1202.897753690946;1204.476052916984;25938.610920835825;26847;27013.324666883484;27453.588196176675;27550.724492754816;41685;41758.79120604499;42025.15949680928;42036.789816050725;42103.7894810524;350309;350532;351395;353441;353472;25015.49969000646;25174.74825251724;25367.36581585475;25687.743122568536;25899.352516187246;38280;38558;38618.22763544769;38943.221135577696;39278.661313788645;35815.10462238465;37127.81436092802;37248.62751372452;37508.2498350026;37692.24615507729;37033.44449833308;37160.256794864494;37185.814070929475;37644;37888.24223515459;29217.269568260963;32672.34655306928;32905.341893162484;33091.50362744513;33202.16994575155;30290.84854575713;33772.49341259834;33872.49191262084;35385.469217962265;36077.81961090178;23834.88082559576;24625.75374246306;25209.495810084063;25476.617850732626;25604.61593076068 18:54:37 INFO - PROCESS | 30460 | |2;jquery.html;353.8566880413433;362.89838845123376;364.1569765991729;364.64447164015087;393.2901113490151;16547.42084027059;18084.547886302847;18134.637307253848;18518.0740962952;18618.162182701777;16181.433649822258;16342.34630614774;17958.10209489527;18057;18076.36732714352;4625.745583992879;4782.13921494131;4810.9037819243595;4820.975895120519;4827.372441582589;3499.737519686021;4748.311494833247;5209.166533354664;5463.535599474049;5469.972650136744;5456.836294911139;5468.699221542814;5492.066348720727;5528.612997090206;5563.443655634424;5559;6065.302490213638;6185.505159587222;6233.688315584248;6256.655883926383;4515.390422292981;5489.423610520877;5507.586930980153;5510.834674959758;5512.641678290938;12424.75150496994;12509.937450312782;19635;21082.472938176667;21083.156673733185;1913.1199648161862;1926.0851095729556;1957.07039156401;2191.7150770399903;2203.8457307988447;9086.45481271126;9157.358984871062;9171.40385874916;9278.582463789078;9403.62385504579;1579.3051057534649;1628.6986907422047;1713.6230029393514;1726.9740953885703;1738.3133662203486;69159;70687.69842261799;71921.28078719198;72147.27852721458;73009.6349518249;9779.168770654433;9800.55897484615;10268.332558383681;10298.588056477807;10970.945145274223;14040.929795350958;14043.78934315986;14174.929125354514;14264.144151350953;14317.35571899267;7039;7090.822729431806;7118.893216601755;7228.819279517949;7239.167495737952;6572.07990881277;6579.671016449159;6653.434458071021;6706.83232919181;6762.661866906733;4363.80362883671;4366.14860102277;4428.955710442919;4441;4503.301988191835;1643.1948345310711;1674.5060207238894;1812.8549716022687;1820.2082094289026;1870.1677753399606;843.6920524008692;880.41892351048;882.4572887674034;898.874157617934;917.9724608261763;16383.180840958143;16614.169291535374;16654;16959.23683434224;17289.82710172907;838.5010918503481;838.5807096451774;855.2601999270586;858.7767180533107;871.8299931513294;9261.861072083924;9359.672411465566;9509.915113240542;9534;9709.563069661883;365159;370957;372125;383495;384911;76470.61764691141;76716;77661.61169194117;77804;80416.59791701005;885.685581618529;890.398980688033;900.7928176519438;904.9502277374676;908.56842999576;14938.402463901322;15209.695806084037;15437.536873893801;15552.222388880737;15557.45548905783;36558.8172059138;37531.43702844514;37573.24853502969;38154;38970.220595587365;46457.76771116123;54405;55016.72491637516;55800.441995579524;55910.16134757901;7407.296306850841;7644.694212231449;7657;7713.382929365525;7735.22647735222;6004.519638428827;11482.311061336346;12214.26714397139;12351.752964940471;12589.811152832897;10968.835467467834;11055;11145.832812507657;11184.273022253852;11427.142964277878;10544.683659490227;10630.73423164427;10751.301165424222;10973.231873769078;11116.777664446827;10935.125189984623;11032;11034.503447344729;11093.112550996062;11182.776344472903;7802.102758182655;7823.491473054233;7869.724559640385;8047.83904321922;8144.75565733029;8169.305609023062;10110.949445253022;10651.627193048205;10662.73343166427;10726.839097413702 18:54:37 INFO - PROCESS | 30460 | |3;mootools.html;1217.5738491527964;1257.2205232755693;1335.9379293461698;1466.7213229486404;1474.7714104313823;6706.195256569218;7215.314545118212;7262.237465066171;7529.774106776792;7722.227777222282;7406.666699998499;7676.232376762321;7695.192004839481;7703.383729301657;7712.305892469677;2178.9564208715856;2217.6119179143666;2225.043231410493;2229.9554008919895;2232.2633530934754;2132.7547332056856;2143.8928053597338;2194.670799380098;2194.901229444679;2198.120751699325;2207.3708992937018;2209.0832304593573;2218.955620887581;2219.289827255279;2220.877851718155;2152.9031193596247;2162.0703097668074;2164.3615133535645;2165.1447678167115;2171.0447403142566;2073.7304150460495;2136.316378758798;2137.6900349449397;2140.9571808563896;2145.3885642591786;7735;7737.613119344011;7779.416543759241;7785.455018148732;7790.415718821111;4456.621187199092;4595.609373203281;4630.699004564693;4631.258998560248;4634.513376095529;2816.633837601119;2829.0664080853476;2840.332521857362;2856.2573730829927;2913.1843083936533;881.9911800882037;882.2148288023664;909.8908131024253;918.903515130915;919.645936314517;10265.640702575449;10330.431826249629;10365.533550990223;10385.480725963671;10396.16830653546;4001.1797581495725;4146.108586653884;4185.539590645027;4254.638355739797;4271.273883439822;8943.060978597154;8986.326025548111;9001.144891235323;9006.819863602692;9012.098790121066;4534.886627834265;4559.316102584573;4566.954330456653;4589.151007063704;4589.311603259538;3694.7228957827733;4074.7555146691293;4106.2198182345255;4127.2570937230985;4246.044639955985;3595.31020420402;3621.3662609043313;3670.3576874046935;3679.300932822755;3709.9072523186596;1175.5944199251244;1176.8823117688335;1196.3838623109107;1198.5924785572947;1209.2260952990093;614.9477294429934;634.7841733810434;666.6100331306143;696.2445746365149;706.3254591864757;5037.471065538139;5047.621428392885;5073.898522029539;5107.668001579886;5519.586031047687;840.6595328891808;853.2491407561306;865.1391865094146;902.5938327752538;908.731924082384;3558.7864728116397;3589.4615807628543;3622.5290712207243;3651.561812582454;3733.8133093345223;9289.489078100634;9610.855837162448;9650.855237171449;9686.951565242129;9728.416295022322;9566.426014439156;9596;9605.519724013771;9610.903890961;9643.08390702882;6994.475414343945;7358.969744235811;7376.409887209011;7444.404447644176;7445.553266804009;5186.144286192736;5266.447023062523;5329.54698850602;5423.430539793265;5468.945310546844;8602.440841345293;8858;8878.73363799087;8881.644734210819;8902.065283145435;8827.984781750181;8836.248918841713;8840.850689410336;8911.06433824439;8980.595873185854;5745.396733342939;5960.910586341121;6045.153678485103;6228.314885362697;6349.523785716182;7020.122484689414;7025.121859767529;7081.362677359062;7105.0408194893025;7109.182444019004;6153.846153846118;6481.513886458629;6513.576617519846;6518.217813862367;6609.933900660932;6114.602550834182;6268.435840774352;6510.934890651222;6567.44176744982;6635.369639884203;5934;5935.643861368331;5935.732892019956;5961.552883533665;5992.790252341147;4183.581641835792;4330.41539392178;4386.166628340605;4389.429374181336;4403.2306905675705;4203.117345357509;4330;4366.14860102277;4372.803223854998;4382.342648602735 18:54:37 INFO - PROCESS | 30460 | |4;prototype.html;295.3399152893283;301.3355551010023;306.5463114590406;310.11153046521724;310.6862069309996;4851.442084160322;4983.302337672729;5054.418741844689;5096.77064532096;5106.846794596168;4992.578599379298;5001.224810154423;5010.423801262856;5010.997800439917;5016.372953380827;3919.5497665863672;3934.527856657191;3938.5864484229173;3959.9010024749323;3982.1836523512684;3889.760339932085;3923.941140882889;3970;3971.4439978403047;3983.6215559521943;3901.765894046366;3902.0049887278706;3925.3130702127155;3941.1920556286036;3948.7828169450668;3917.9608203918024;3926.5484469285825;3934.980325098385;3954.548180128339;3967.7222594418404;3506.824658767077;3522.119470132467;3522.788632682047;3528.2061536154415;3531.5585551806025;4670.953290467086;4913.140200464904;4974.328465657126;4990.675606085629;5013.172826483626;4400.22995975703;4407.405000324947;4413.845515406945;4434.290513517822;4457.612214716806;5230.267762513251;5232.529072383466;5247.790088396498;5250.921236181461;5294.7617357219015;3638.3450978823803;3668.5781135169264;3695.575008873987;3743.251349730038;3746.194568167857;5472.91790623141;5498.395176530578;5499.917501237484;5520.696361700065;5532.972335138298;3777.376732839106;3783.2244389900006;3792.58281589025;3803.7147213959065;3804.239152169577;3862.0731024553907;3870.167913898469;3875.8643447479767;3880.573136954989;3881.1849511602313;4200.348945913388;4410.69125161242;4413.234706117514;4417.447819022622;4417.8232870684815;5216.37403511581;5222.869428264324;5230.424653288135;5241.109011468059;5245.816396426107;1242.1180961517243;1288.2528133682442;1322.8280323558067;1327.389400875608;1327.8937684985178;889.6485888074304;893.2853717026483;906.981860362789;911.8313112074287;921.5576523268868;4501.68488205829;4506.481754598263;4524.389207456951;4525.230710779176;4541.704789188692;5326.760295786699;5327;5342.252084708144;5342.866428339323;5355.7054362009685;4383.838282855046;4512.2329204035395;4526.755142335884;4531.864044078683;4539.0694907543875;2505.6993160820816;2539.3240461295454;2547.6942766868096;2572.2797616667362;2578.48430313938;4407.603315701603;4472.776361181993;4478.753668548196;4502.263121609057;4503.221227615074;4663.417072865892;4812.783424745825;4890;4911.852644420602;4920.606351491872;4424;4444.355568442623;4459.0413061192;4479.70881892676;4492.292928687143;4689.827543114221;4725.5983241424865;4756.40660378777;4760.642951778561;4787.257975013878;4602.7008244464005;4632.652551058617;4644.396228490275;4673.6494762892235;4685.039566888848;4150.958490415178;4444.777761111867;4450.132224216247;4481.686281960231;4486.484054333663;3478.556399094449;3479.251960828333;3479.9826000869834;3484.5295885055193;3494.2836718472145;4806.188379797857;4813.975930120327;4839.419269687519;4844.297576851407;5186;5050.419201791841;5221.216817477409;5227.18978558324;5234.267202591716;5311.548518375981;5200.193969934666;5232.241325007776;5238.423773384849;5240.502152295526;5252.947470525246;4919.680220785637;5136.768845402041;5154.664946778447;5160.458151893997;5235.214717792362;5309.973450132725;5316.388615309134;5342.851286973164;5346.1980702893325;5376.112941364631;5209.739513024258;5220.190870415092;5233.267342571967;5259.631825772312;5271.630985830955 18:54:37 INFO - PROCESS | 30460 | |5;yui.html;568.3208565763914;578.9218455508508;580.474670423267;610.3957082488336;623.9750409983595;11752.294862308258;12396.690082747937;12408.627741167767;12432.254064756122;12436.253824770509;11488.195826292163;11606.59376921808;11781.7643647127;11827.172097953147;11876;747.8317378589815;757.2427572427572;757.6666266842599;761.075293518375;765.7281665008925;769.2346115614943;771.7376092128675;772.3049255669886;772.5557804262544;773.5088218980959;808.8139727862596;809.1059379385782;810.3679130278392;811.7889348769332;813.1421350475247;798.7763426240633;799.7400844725458;800.9118996910336;802.5224991130268;803.1927912447952;583.6731430398991;585.5491271720751;588.1119509540582;588.3351812451945;589.6167491130799;10967.83548246777;11124.110071194285;11166.106711463064;11171.72070698239;11177;10462.79074418515;10886.782264354668;10905.618303359424;11025.944870275678;11243.156763242789;9111.635534578609;9199.678011269574;9259.814803703888;9281.118293762082;9283.11810378013;3160.9683903160903;3210.1493104327374;3211.0687900508824;3222.3072039511617;3261.037993791837;41260;54433.1835022471;56957.430425695624;56974.71512642452;65295.673521633034;10733.248672592843;10971.670849874517;10983.121350291958;11018.559257629766;11276.492557834918;19471.318503852297;19481.51296217606;19674.60650786976;19808.20767169326;20015.399538013884;6902.206246281641;6952.721891124298;6956.756513522002;6957.443404527626;7060.611666358297;3526.9294614107575;3626.9455958160647;3652.0687224757517;3661.3043521730788;3735.0662334416397;2595.740425957389;2661.5874539446418;2692.0846912049606;2699.0283497940727;2700.770434513049;510.62213961668095;539.2262103880944;539.7220431477792;554.8807006493543;556.2546188107955;424.71544065476206;516.8397796682965;566.4109326300601;600.8798240351947;611.807280706585;8705.825883482295;8860.64557417709;8888.555572221363;8900.73297801067;8951.239144672645;542.029766717579;560.4115678537519;562.1315068219529;571.6427232979388;573.9426057394311;4051.3922911562913;4221.303484924953;4237.788110594458;4325.6106950374615;4385.780710964503;59794;71814;103347;106034.46982765036;106345.46827265814;92777.8495542674;93209.5339523298;93348.06651933394;94336.52831735798;94354;51276.23085653644;57754;76957;82264.58867705624;82536.58731706304;8041.557714325534;8047.678092876454;8090.878636820335;8237.011558613005;8398.496090234361;46401.02377988749;47472.52527474681;47659.285110724064;48450.27324590064;49072.50927490679;39672;40316;40637.39043914403;57946.7102664484;66429.33570664232;9477.620895164391;9660.95169524148;9753.317267791186;9838;10318.742031449274;10677.9466102669;10828.512716927915;11565.710857228636;11586.47860846247;11791.941040294743;9531.952340238255;10692.83960740574;11869.762604747684;12188.878111218773;12702.745945080862;12615.684607884876;12750.34077802232;12755.298458584866;12875.935620321838;12972.740545188855;10588.152947764007;11128.499217535069;11273.098152147644;11686;11702;10394.896051039394;10535.157187424835;10569.365838049742;10903.454827258764;11321.943390282995;9608.279379046739;9902.158316542886;9907.554160062959;10072.143867771321;10626.681199564026 18:54:37 INFO - PROCESS | 30460 | __end_tp_report 18:54:37 INFO - PROCESS | 30460 | __start_cc_report 18:54:37 INFO - PROCESS | 30460 | _x_x_mozilla_cycle_collect,410 18:54:37 INFO - PROCESS | 30460 | __end_cc_report 18:54:37 INFO - PROCESS | 30460 | __startTimestamp1467942877901__endTimestamp 18:54:37 INFO - PROCESS | 30460 | 18:54:37 INFO - PROCESS | 30460 | ------- Summary: start ------- 18:54:37 INFO - PROCESS | 30460 | Number of tests: 6 18:54:37 INFO - PROCESS | 30460 | 18:54:37 INFO - PROCESS | 30460 | [#0] dojo.html Cycles:165 Average:4752.03 Median:4854.88 stddev:510.66 (10.5%) stddev-sans-first:483.64 18:54:37 INFO - PROCESS | 30460 | Values: 2604.5 2609.5 2619.2 2659.4 2664.9 4714.3 4740.9 4807.8 4809.1 4826.8 4665.0 4774.2 4804.7 4827.3 4880.0 4386.0 4397.9 4451.2 4483.4 4508.5 4482.7 4483.9 4505.7 4513.3 4586.4 4372.6 4434.9 4452.3 4460.9 4464.8 4459.2 4459.3 4463.0 4467.3 4516.0 4318.6 4349.2 4356.9 4395.9 4471.0 4781.4 4813.4 4815.8 4816.7 4846.8 5098.9 5125.3 5144.1 5144.2 5149.3 5130.2 5153.8 5172.9 5184.9 5201.9 4829.3 4848.5 4852.8 4854.9 4895.0 5220.9 5279.4 5285.9 5294.9 5316.6 5019.6 5100.7 5108.3 5110.2 5110.7 5064.3 5107.9 5121.4 5195.0 5211.1 4987.4 5103.4 5119.0 5119.8 5121.1 5046.9 5076.1 5116.1 5120.0 5121.9 4275.9 4280.8 4283.6 4290.9 4331.9 3699.6 3723.8 3756.4 3786.3 3802.4 4449.9 4456.9 4466.7 4492.9 4503.8 5217.0 5218.1 5226.3 5234.0 5234.4 4311.1 4355.0 4398.6 4466.9 4508.5 4519.5 4547.4 4547.6 4550.2 4601.2 4740.7 4778.9 4783.5 4783.6 4784.0 5078.8 5140.7 5146.0 5148.7 5168.0 4769.9 4776.6 4785.1 4806.6 4863.3 5096.8 5100.2 5101.9 5115.5 5151.4 5014.5 5090.7 5109.3 5146.2 5169.9 4994.5 5035.0 5039.4 5039.5 5052.8 5067.3 5067.6 5075.1 5078.5 5118.3 4818.2 4868.2 4931.7 4981.0 4987.6 4985.1 5061.8 5074.2 5082.1 5102.6 4951.7 4958.2 4960.4 4962.4 5016.3 18:54:37 INFO - PROCESS | 30460 | 18:54:37 INFO - PROCESS | 30460 | [#1] ext.html Cycles:180 Average:49342.00 Median:37227.63 stddev:95691.58 (257.0%) stddev-sans-first:95889.84 18:54:37 INFO - PROCESS | 30460 | Values: 528.1 543.9 559.1 563.5 587.8 34905.5 40076.0 40112.2 40114.6 40117.6 36893.0 37206.6 37250.8 37316.3 37391.4 7624.7 7751.7 7756.3 7770.1 7775.1 7597.3 7647.2 7647.3 7673.8 7728.6 7626.7 7713.9 7749.9 7762.8 7784.6 7736.5 7760.3 7763.1 7768.1 7772.9 7615.0 7617.0 7659.0 7672.9 7694.9 37878.4 38308.4 38366.8 38493.5 38497.0 2305.3 2660.7 2705.7 2863.3 2893.1 26791.0 27618.4 28009.0 29967.7 30167.8 3202.7 3371.1 3381.5 3411.5 3521.3 277118.0 279575.0 281418.0 281996.0 284170.0 48466.3 48913.5 48926.0 48935.5 49110.8 29390.0 30333.7 30461.2 30463.0 30485.0 13344.7 13365.3 13399.1 13420.1 13431.6 9528.6 9613.6 9615.9 9645.2 9666.1 18155.2 18342.0 18373.2 18375.8 18390.5 6686.5 6741.3 6807.4 6809.3 6846.8 817.7 949.4 964.4 1002.4 1020.3 27918.7 27981.0 28763.7 28765.3 28852.0 881.8 949.5 956.0 973.6 1010.7 14277.9 14379.6 14670.9 14699.4 14717.3 428361.0 437122.0 437522.0 437560.0 437569.0 47130.8 47694.5 48011.8 48280.5 48336.8 1146.4 1174.2 1193.2 1202.9 1204.5 25938.6 26847.0 27013.3 27453.6 27550.7 41685.0 41758.8 42025.2 42036.8 42103.8 350309.0 350532.0 351395.0 353441.0 353472.0 25015.5 25174.7 25367.4 25687.7 25899.4 38280.0 38558.0 38618.2 38943.2 39278.7 35815.1 37127.8 37248.6 37508.2 37692.2 37033.4 37160.3 37185.8 37644.0 37888.2 29217.3 32672.3 32905.3 33091.5 33202.2 30290.8 33772.5 33872.5 35385.5 36077.8 23834.9 24625.8 25209.5 25476.6 25604.6 18:54:37 INFO - PROCESS | 30460 | 18:54:37 INFO - PROCESS | 30460 | [#2] jquery.html Cycles:180 Average:24068.32 Median:4472.15 stddev:62189.02 (1390.6%) stddev-sans-first:62337.99 18:54:37 INFO - PROCESS | 30460 | Values: 353.9 362.9 364.2 364.6 393.3 16547.4 18084.5 18134.6 18518.1 18618.2 16181.4 16342.3 17958.1 18057.0 18076.4 4625.7 4782.1 4810.9 4821.0 4827.4 3499.7 4748.3 5209.2 5463.5 5470.0 5456.8 5468.7 5492.1 5528.6 5563.4 5559.0 6065.3 6185.5 6233.7 6256.7 4515.4 5489.4 5507.6 5510.8 5512.6 12424.8 12509.9 19635.0 21082.5 21083.2 1913.1 1926.1 1957.1 2191.7 2203.8 9086.5 9157.4 9171.4 9278.6 9403.6 1579.3 1628.7 1713.6 1727.0 1738.3 69159.0 70687.7 71921.3 72147.3 73009.6 9779.2 9800.6 10268.3 10298.6 10970.9 14040.9 14043.8 14174.9 14264.1 14317.4 7039.0 7090.8 7118.9 7228.8 7239.2 6572.1 6579.7 6653.4 6706.8 6762.7 4363.8 4366.1 4429.0 4441.0 4503.3 1643.2 1674.5 1812.9 1820.2 1870.2 843.7 880.4 882.5 898.9 918.0 16383.2 16614.2 16654.0 16959.2 17289.8 838.5 838.6 855.3 858.8 871.8 9261.9 9359.7 9509.9 9534.0 9709.6 365159.0 370957.0 372125.0 383495.0 384911.0 76470.6 76716.0 77661.6 77804.0 80416.6 885.7 890.4 900.8 905.0 908.6 14938.4 15209.7 15437.5 15552.2 15557.5 36558.8 37531.4 37573.2 38154.0 38970.2 46457.8 54405.0 55016.7 55800.4 55910.2 7407.3 7644.7 7657.0 7713.4 7735.2 6004.5 11482.3 12214.3 12351.8 12589.8 10968.8 11055.0 11145.8 11184.3 11427.1 10544.7 10630.7 10751.3 10973.2 11116.8 10935.1 11032.0 11034.5 11093.1 11182.8 7802.1 7823.5 7869.7 8047.8 8144.8 8169.3 10110.9 10651.6 10662.7 10726.8 18:54:37 INFO - PROCESS | 30460 | 18:54:37 INFO - PROCESS | 30460 | [#3] mootools.html Cycles:180 Average:5021.43 Median:5298.00 stddev:2817.18 (53.2%) stddev-sans-first:2810.58 18:54:37 INFO - PROCESS | 30460 | Values: 1217.6 1257.2 1335.9 1466.7 1474.8 6706.2 7215.3 7262.2 7529.8 7722.2 7406.7 7676.2 7695.2 7703.4 7712.3 2179.0 2217.6 2225.0 2230.0 2232.3 2132.8 2143.9 2194.7 2194.9 2198.1 2207.4 2209.1 2219.0 2219.3 2220.9 2152.9 2162.1 2164.4 2165.1 2171.0 2073.7 2136.3 2137.7 2141.0 2145.4 7735.0 7737.6 7779.4 7785.5 7790.4 4456.6 4595.6 4630.7 4631.3 4634.5 2816.6 2829.1 2840.3 2856.3 2913.2 882.0 882.2 909.9 918.9 919.6 10265.6 10330.4 10365.5 10385.5 10396.2 4001.2 4146.1 4185.5 4254.6 4271.3 8943.1 8986.3 9001.1 9006.8 9012.1 4534.9 4559.3 4567.0 4589.2 4589.3 3694.7 4074.8 4106.2 4127.3 4246.0 3595.3 3621.4 3670.4 3679.3 3709.9 1175.6 1176.9 1196.4 1198.6 1209.2 614.9 634.8 666.6 696.2 706.3 5037.5 5047.6 5073.9 5107.7 5519.6 840.7 853.2 865.1 902.6 908.7 3558.8 3589.5 3622.5 3651.6 3733.8 9289.5 9610.9 9650.9 9687.0 9728.4 9566.4 9596.0 9605.5 9610.9 9643.1 6994.5 7359.0 7376.4 7444.4 7445.6 5186.1 5266.4 5329.5 5423.4 5468.9 8602.4 8858.0 8878.7 8881.6 8902.1 8828.0 8836.2 8840.9 8911.1 8980.6 5745.4 5960.9 6045.2 6228.3 6349.5 7020.1 7025.1 7081.4 7105.0 7109.2 6153.8 6481.5 6513.6 6518.2 6609.9 6114.6 6268.4 6510.9 6567.4 6635.4 5934.0 5935.6 5935.7 5961.6 5992.8 4183.6 4330.4 4386.2 4389.4 4403.2 4203.1 4330.0 4366.1 4372.8 4382.3 18:54:37 INFO - PROCESS | 30460 | 18:54:37 INFO - PROCESS | 30460 | [#4] prototype.html Cycles:180 Average:4218.65 Median:4525.99 stddev:1218.81 (26.9%) stddev-sans-first:1186.12 18:54:37 INFO - PROCESS | 30460 | Values: 295.3 301.3 306.5 310.1 310.7 4851.4 4983.3 5054.4 5096.8 5106.8 4992.6 5001.2 5010.4 5011.0 5016.4 3919.5 3934.5 3938.6 3959.9 3982.2 3889.8 3923.9 3970.0 3971.4 3983.6 3901.8 3902.0 3925.3 3941.2 3948.8 3918.0 3926.5 3935.0 3954.5 3967.7 3506.8 3522.1 3522.8 3528.2 3531.6 4671.0 4913.1 4974.3 4990.7 5013.2 4400.2 4407.4 4413.8 4434.3 4457.6 5230.3 5232.5 5247.8 5250.9 5294.8 3638.3 3668.6 3695.6 3743.3 3746.2 5472.9 5498.4 5499.9 5520.7 5533.0 3777.4 3783.2 3792.6 3803.7 3804.2 3862.1 3870.2 3875.9 3880.6 3881.2 4200.3 4410.7 4413.2 4417.4 4417.8 5216.4 5222.9 5230.4 5241.1 5245.8 1242.1 1288.3 1322.8 1327.4 1327.9 889.6 893.3 907.0 911.8 921.6 4501.7 4506.5 4524.4 4525.2 4541.7 5326.8 5327.0 5342.3 5342.9 5355.7 4383.8 4512.2 4526.8 4531.9 4539.1 2505.7 2539.3 2547.7 2572.3 2578.5 4407.6 4472.8 4478.8 4502.3 4503.2 4663.4 4812.8 4890.0 4911.9 4920.6 4424.0 4444.4 4459.0 4479.7 4492.3 4689.8 4725.6 4756.4 4760.6 4787.3 4602.7 4632.7 4644.4 4673.6 4685.0 4151.0 4444.8 4450.1 4481.7 4486.5 3478.6 3479.3 3480.0 3484.5 3494.3 4806.2 4814.0 4839.4 4844.3 5186.0 5050.4 5221.2 5227.2 5234.3 5311.5 5200.2 5232.2 5238.4 5240.5 5252.9 4919.7 5136.8 5154.7 5160.5 5235.2 5310.0 5316.4 5342.9 5346.2 5376.1 5209.7 5220.2 5233.3 5259.6 5271.6 18:54:37 INFO - PROCESS | 30460 | 18:54:37 INFO - PROCESS | 30460 | [#5] yui.html Cycles:180 Average:17000.76 Median:25893.43 stddev:24774.09 (95.7%) stddev-sans-first:24812.86 18:54:37 INFO - PROCESS | 30460 | Values: 568.3 578.9 580.5 610.4 624.0 11752.3 12396.7 12408.6 12432.3 12436.3 11488.2 11606.6 11781.8 11827.2 11876.0 747.8 757.2 757.7 761.1 765.7 769.2 771.7 772.3 772.6 773.5 808.8 809.1 810.4 811.8 813.1 798.8 799.7 800.9 802.5 803.2 583.7 585.5 588.1 588.3 589.6 10967.8 11124.1 11166.1 11171.7 11177.0 10462.8 10886.8 10905.6 11025.9 11243.2 9111.6 9199.7 9259.8 9281.1 9283.1 3161.0 3210.1 3211.1 3222.3 3261.0 41260.0 54433.2 56957.4 56974.7 65295.7 10733.2 10971.7 10983.1 11018.6 11276.5 19471.3 19481.5 19674.6 19808.2 20015.4 6902.2 6952.7 6956.8 6957.4 7060.6 3526.9 3626.9 3652.1 3661.3 3735.1 2595.7 2661.6 2692.1 2699.0 2700.8 510.6 539.2 539.7 554.9 556.3 424.7 516.8 566.4 600.9 611.8 8705.8 8860.6 8888.6 8900.7 8951.2 542.0 560.4 562.1 571.6 573.9 4051.4 4221.3 4237.8 4325.6 4385.8 59794.0 71814.0 103347.0 106034.5 106345.5 92777.8 93209.5 93348.1 94336.5 94354.0 51276.2 57754.0 76957.0 82264.6 82536.6 8041.6 8047.7 8090.9 8237.0 8398.5 46401.0 47472.5 47659.3 48450.3 49072.5 39672.0 40316.0 40637.4 57946.7 66429.3 9477.6 9661.0 9753.3 9838.0 10318.7 10677.9 10828.5 11565.7 11586.5 11791.9 9532.0 10692.8 11869.8 12188.9 12702.7 12615.7 12750.3 12755.3 12875.9 12972.7 10588.2 11128.5 11273.1 11686.0 11702.0 10394.9 10535.2 10569.4 10903.5 11321.9 9608.3 9902.2 9907.6 10072.1 10626.7 18:54:37 INFO - PROCESS | 30460 | -------- Summary: end -------- 18:54:37 INFO - PROCESS | 30460 | 18:54:38 INFO - TEST-INFO | 30460: exit 0 18:54:38 INFO - TEST-OK | dromaeo_css | took 1116375ms 18:54:38 INFO - TEST-START | kraken 18:54:38 INFO - operating with platform_type : linux_ 18:54:38 INFO - Initialising browser for kraken test... 18:54:38 INFO - TEST-INFO | started process 30705 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp474ceW/profile http://localhost:38075/getInfo.html) 18:54:43 INFO - PROCESS | 30705 | __metrics Screen width/height:1600/1200 18:54:43 INFO - PROCESS | 30705 | colorDepth:24 18:54:43 INFO - PROCESS | 30705 | Browser inner width/height: 1024/697 18:54:43 INFO - PROCESS | 30705 | __metrics 18:54:44 ERROR - PROCESS | 30705 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 18:54:44 INFO - TEST-INFO | 30705: exit 0 18:54:44 INFO - Browser initialized. 18:54:44 INFO - Running cycle 1/1 for kraken test... 18:54:44 INFO - TEST-INFO | started process 30822 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp474ceW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:54:56 INFO - PROCESS | 30822 | RSS: Main: 169263104 18:54:56 INFO - PROCESS | 30822 | 18:54:59 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:38075/tests/kraken/driver.html?testName=audio-beat-detection) 18:55:00 INFO - PROCESS | 30822 | RSS: Main: 174129152 18:55:00 INFO - PROCESS | 30822 | 18:55:03 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:38075/tests/kraken/driver.html?testName=audio-dft) 18:55:03 INFO - PROCESS | 30822 | RSS: Main: 173789184 18:55:03 INFO - PROCESS | 30822 | 18:55:06 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:38075/tests/kraken/driver.html?testName=audio-fft) 18:55:07 INFO - PROCESS | 30822 | RSS: Main: 168517632 18:55:07 INFO - PROCESS | 30822 | 18:55:09 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:38075/tests/kraken/driver.html?testName=audio-oscillator) 18:55:10 INFO - PROCESS | 30822 | RSS: Main: 169316352 18:55:10 INFO - PROCESS | 30822 | 18:55:12 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:38075/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:55:13 INFO - PROCESS | 30822 | RSS: Main: 169705472 18:55:13 INFO - PROCESS | 30822 | 18:55:16 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:38075/tests/kraken/driver.html?testName=imaging-darkroom) 18:55:17 INFO - PROCESS | 30822 | RSS: Main: 170299392 18:55:17 INFO - PROCESS | 30822 | 18:55:20 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:38075/tests/kraken/driver.html?testName=imaging-desaturate) 18:55:21 INFO - PROCESS | 30822 | RSS: Main: 167239680 18:55:21 INFO - PROCESS | 30822 | 18:55:24 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:38075/tests/kraken/driver.html?testName=json-parse-financial) 18:55:24 INFO - PROCESS | 30822 | RSS: Main: 168943616 18:55:24 INFO - PROCESS | 30822 | 18:55:26 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:38075/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:55:27 INFO - PROCESS | 30822 | RSS: Main: 169172992 18:55:27 INFO - PROCESS | 30822 | 18:55:29 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:38075/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:55:29 INFO - PROCESS | 30822 | RSS: Main: 169435136 18:55:29 INFO - PROCESS | 30822 | 18:55:31 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:38075/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:55:32 INFO - PROCESS | 30822 | RSS: Main: 170229760 18:55:32 INFO - PROCESS | 30822 | 18:55:35 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:38075/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:55:36 INFO - PROCESS | 30822 | RSS: Main: 170180608 18:55:36 INFO - PROCESS | 30822 | 18:55:38 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:38075/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:55:39 INFO - PROCESS | 30822 | RSS: Main: 169938944 18:55:39 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | Cycle 1(1): loaded http://localhost:38075/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:38075/tests/kraken/driver.html?testName=ai-astar) 18:55:41 INFO - PROCESS | 30822 | RSS: Main: 170606592 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | __start_tp_report 18:55:41 INFO - PROCESS | 30822 | _x_x_mozilla_page_load 18:55:41 INFO - PROCESS | 30822 | _x_x_mozilla_page_load_details 18:55:41 INFO - PROCESS | 30822 | |i|pagename|runs| 18:55:41 INFO - PROCESS | 30822 | |0;ai-astar;110;113;108;116;116;114;124;114;113;113 18:55:41 INFO - PROCESS | 30822 | |1;audio-beat-detection;150;125;148;184;132;145;148;127;186;140 18:55:41 INFO - PROCESS | 30822 | |2;audio-dft;163;162;165;168;169;162;163;163;163;164 18:55:41 INFO - PROCESS | 30822 | |3;audio-fft;76;76;78;158;78;76;76;77;158;77 18:55:41 INFO - PROCESS | 30822 | |4;audio-oscillator;87;85;153;86;87;86;133;85;86;133 18:55:41 INFO - PROCESS | 30822 | |5;imaging-gaussian-blur;117;119;117;117;118;121;119;117;120;117 18:55:41 INFO - PROCESS | 30822 | |6;imaging-darkroom;149;150;149;148;149;147;147;148;147;148 18:55:41 INFO - PROCESS | 30822 | |7;imaging-desaturate;95;95;96;96;95;96;96;96;96;96 18:55:41 INFO - PROCESS | 30822 | |8;json-parse-financial;64;65;64;67;65;64;66;64;65;63 18:55:41 INFO - PROCESS | 30822 | |9;json-stringify-tinderbox;64;66;65;64;65;64;66;65;64;65 18:55:41 INFO - PROCESS | 30822 | |10;stanford-crypto-aes;89;83;79;80;80;84;81;85;91;81 18:55:41 INFO - PROCESS | 30822 | |11;stanford-crypto-ccm;147;142;132;141;155;147;132;131;183;135 18:55:41 INFO - PROCESS | 30822 | |12;stanford-crypto-pbkdf2;165;164;167;169;165;162;164;165;167;162 18:55:41 INFO - PROCESS | 30822 | |13;stanford-crypto-sha256-iterative;68;74;68;68;71;68;68;70;67;71 18:55:41 INFO - PROCESS | 30822 | __end_tp_report 18:55:41 INFO - PROCESS | 30822 | __start_cc_report 18:55:41 INFO - PROCESS | 30822 | _x_x_mozilla_cycle_collect,978 18:55:41 INFO - PROCESS | 30822 | __end_cc_report 18:55:41 INFO - PROCESS | 30822 | __startTimestamp1467942941595__endTimestamp 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | ------- Summary: start ------- 18:55:41 INFO - PROCESS | 30822 | Number of tests: 14 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.00 stddev:4.25 (3.7%) stddev-sans-first:4.25 18:55:41 INFO - PROCESS | 30822 | Values: 110.0 113.0 108.0 116.0 116.0 114.0 124.0 114.0 113.0 113.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#1] audio-beat-detection Cycles:10 Average:148.50 Median:148.00 stddev:21.19 (14.3%) stddev-sans-first:22.47 18:55:41 INFO - PROCESS | 30822 | Values: 150.0 125.0 148.0 184.0 132.0 145.0 148.0 127.0 186.0 140.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#2] audio-dft Cycles:10 Average:164.20 Median:163.50 stddev:2.44 (1.5%) stddev-sans-first:2.55 18:55:41 INFO - PROCESS | 30822 | Values: 163.0 162.0 165.0 168.0 169.0 162.0 163.0 163.0 163.0 164.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#3] audio-fft Cycles:10 Average:93.00 Median:76.50 stddev:34.27 (44.8%) stddev-sans-first:35.79 18:55:41 INFO - PROCESS | 30822 | Values: 76.0 76.0 78.0 158.0 78.0 76.0 76.0 77.0 158.0 77.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#4] audio-oscillator Cycles:10 Average:102.10 Median:86.00 stddev:26.50 (30.8%) stddev-sans-first:27.54 18:55:41 INFO - PROCESS | 30822 | Values: 87.0 85.0 153.0 86.0 87.0 86.0 133.0 85.0 86.0 133.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#5] imaging-gaussian-blur Cycles:10 Average:118.20 Median:118.50 stddev:1.48 (1.2%) stddev-sans-first:1.50 18:55:41 INFO - PROCESS | 30822 | Values: 117.0 119.0 117.0 117.0 118.0 121.0 119.0 117.0 120.0 117.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.50 stddev:1.03 (0.7%) stddev-sans-first:1.05 18:55:41 INFO - PROCESS | 30822 | Values: 149.0 150.0 149.0 148.0 149.0 147.0 147.0 148.0 147.0 148.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 18:55:41 INFO - PROCESS | 30822 | Values: 95.0 95.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 96.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#8] json-parse-financial Cycles:10 Average:64.70 Median:65.00 stddev:1.16 (1.8%) stddev-sans-first:1.20 18:55:41 INFO - PROCESS | 30822 | Values: 64.0 65.0 64.0 67.0 65.0 64.0 66.0 64.0 65.0 63.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#9] json-stringify-tinderbox Cycles:10 Average:64.80 Median:65.00 stddev:0.79 (1.2%) stddev-sans-first:0.78 18:55:41 INFO - PROCESS | 30822 | Values: 64.0 66.0 65.0 64.0 65.0 64.0 66.0 65.0 64.0 65.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#10] stanford-crypto-aes Cycles:10 Average:83.30 Median:83.50 stddev:4.03 (4.8%) stddev-sans-first:3.71 18:55:41 INFO - PROCESS | 30822 | Values: 89.0 83.0 79.0 80.0 80.0 84.0 81.0 85.0 91.0 81.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#11] stanford-crypto-ccm Cycles:10 Average:144.50 Median:144.50 stddev:15.66 (10.8%) stddev-sans-first:16.59 18:55:41 INFO - PROCESS | 30822 | Values: 147.0 142.0 132.0 141.0 155.0 147.0 132.0 131.0 183.0 135.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.00 Median:165.00 stddev:2.21 (1.3%) stddev-sans-first:2.35 18:55:41 INFO - PROCESS | 30822 | Values: 165.0 164.0 167.0 169.0 165.0 162.0 164.0 165.0 167.0 162.0 18:55:41 INFO - PROCESS | 30822 | 18:55:41 INFO - PROCESS | 30822 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:2.16 (3.1%) stddev-sans-first:2.24 18:55:41 INFO - PROCESS | 30822 | Values: 68.0 74.0 68.0 68.0 71.0 68.0 68.0 70.0 67.0 71.0 18:55:41 INFO - PROCESS | 30822 | -------- Summary: end -------- 18:55:41 INFO - PROCESS | 30822 | 18:55:42 INFO - TEST-INFO | 30822: exit 0 18:55:42 INFO - TEST-OK | kraken | took 63957ms 18:55:42 INFO - SUITE-END | took 1180s 18:55:42 INFO - Completed test suite (00:19:40) 18:55:42 INFO - javascript benchmark 18:55:42 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6336.590233111448, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.45306485638, 2609.5172393107287, 2619.2142357292814, 2659.414928715682, 2664.933376665583, 4714.339992401066, 4740.928886066712, 4807.807687692488, 4809.086273608012, 4826.758662066895, 4665.0, 4774.212254977933, 4804.735739534324, 4827.275908613709, 4880.0, 4385.956140438595, 4397.912041759163, 4451.1765323415275, 4483.439570053743, 4508.504064552896, 4482.663800214997, 4483.932741008887, 4505.662075344346, 4513.3455648930885, 4586.44962604488, 4372.5627437256335, 4434.911301773946, 4452.265376212921, 4460.8884777880485, 4464.8214071437105, 4459.197344477992, 4459.331100334975, 4463.040446304028, 4467.3299005149165, 4516.006478574708, 4318.589733975267, 4349.238883195429, 4356.869293921156, 4395.934060989088, 4471.0, 4781.426228852525, 4813.422389313305, 4815.759212039384, 4816.686915350491, 4846.806127754886, 5098.872528186788, 5125.333706618153, 5144.099782538041, 5144.151215049513, 5149.253358263069, 5130.153524668425, 5153.819616313449, 5172.948270517284, 5184.922226166611, 5201.921971170435, 4829.27560865873, 4848.490908454632, 4852.830150944736, 4854.878628034327, 4894.975525122351, 5220.869478262998, 5279.41926388097, 5285.920711189336, 5294.894102117936, 5316.627836051517, 5019.648624596243, 5100.69395836251, 5108.310378098983, 5110.233464980209, 5110.744462776846, 5064.316317297118, 5107.8723031923755, 5121.436641969381, 5194.97402512985, 5211.062008838369, 4987.351644286292, 5103.413107492686, 5119.0273847968765, 5119.795208191705, 5121.07820592297, 5046.949530504648, 5076.060928728197, 5116.130257856174, 5120.0, 5121.923171152435, 4275.893102672396, 4280.76455794928, 4283.612185950158, 4290.935635965463, 4331.891702707458, 3699.611540788232, 3723.7579557328686, 3756.3614185588517, 3786.3373909565717, 3802.448644946467, 4449.933251001173, 4456.910861782746, 4466.6873318867365, 4492.910141797146, 4503.7522936238165, 5217.0, 5218.139007063792, 5226.294450249244, 5234.0, 5234.3718753749035, 4311.07311927937, 4354.978225108917, 4398.626116780046, 4466.932996005063, 4508.526604706524, 4519.5480451954545, 4547.431571053618, 4547.63618910493, 4550.158220729176, 4601.217792975202, 4740.739259340769, 4778.928316075262, 4783.521647835189, 4783.617310615073, 4783.95216047842, 5078.847634570969, 5140.665856719302, 5146.0, 5148.665336753099, 5168.043911876315, 4769.880752981203, 4776.617870570277, 4785.090832741768, 4806.639502037431, 4863.294822250825, 5096.847094587169, 5100.234964755168, 5101.897962040664, 5115.462876397924, 5151.433342332415, 5014.498550145102, 5090.669106508065, 5109.31024311728, 5146.176611742103, 5169.948300517097, 4994.450610432922, 5035.0, 5039.395272567315, 5039.521245481674, 5052.7726252318, 5067.341245638044, 5067.645264831426, 5075.11185542536, 5078.466760990191, 5118.3090282811345, 4818.229083346788, 4868.172410690262, 4931.7040977541465, 4981.028699403581, 4987.551120399182, 4985.1276026695905, 5061.797528098835, 5074.213496907985, 5082.059818933509, 5102.617303702312, 4951.678140920829, 4958.231474121517, 4960.355153829979, 4962.429320628174, 5016.347874776256], "value": 4718.194955020924, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [528.1259515501844, 543.9102548079567, 559.0775220885538, 563.4872266237724, 587.7707693999344, 34905.47641785375, 40076.0, 40112.197756044865, 40114.59885401145, 40117.59882401175, 36893.0, 37206.62793372072, 37250.813745931235, 37316.253674926484, 37391.4391284131, 7624.69501219952, 7751.6511756970785, 7756.340711039568, 7770.067591888953, 7775.0669919609445, 7597.31624153826, 7647.158812530617, 7647.273509016634, 7673.846523069536, 7728.613569321539, 7626.7330643427495, 7713.922860771377, 7749.922500775005, 7762.805929851743, 7784.571848548356, 7736.497127686683, 7760.340371068438, 7763.107242667081, 7768.1066677332265, 7772.922270777333, 7615.0, 7617.0, 7659.0, 7672.884906726404, 7694.9230507694765, 37878.43182352267, 38308.425373619415, 38366.80816595927, 38493.49792263494, 38497.0, 2305.296884450242, 2660.6940201876837, 2705.715899830529, 2863.2698661841305, 2893.117599132264, 26791.0, 27618.447631047467, 28009.0, 29967.70032299671, 30167.849160754275, 3202.679732026802, 3371.140359208386, 3381.526586277923, 3411.5053317268857, 3521.330947120039, 277118.0, 279575.0, 281418.0, 281996.0, 284170.0, 48466.27300590494, 48913.51086489161, 48926.0, 48935.5106448931, 49110.843361447245, 29390.0, 30333.696663033086, 30461.23846903801, 30463.0, 30485.0, 13344.6663833403, 13365.26491043002, 13399.12905661129, 13420.0605957584, 13431.597052088453, 9528.571214295373, 9613.567389467491, 9615.855762163574, 9645.228381729445, 9666.081722236377, 18155.183016764277, 18342.0, 18373.17320720571, 18375.816241837678, 18390.540236494195, 6686.465082793365, 6741.292164322774, 6807.421369183576, 6809.285025072395, 6846.828829279308, 817.65249768848, 949.3829011142674, 964.3731574476647, 1002.4135880509983, 1020.260311274335, 27918.720812792017, 27981.0, 28763.712362876522, 28765.28086797847, 28852.0, 881.8368601808558, 949.5252373813094, 955.9522023898777, 973.6105557776946, 1010.7372083258406, 14277.857221427861, 14379.568612941628, 14670.853291466949, 14699.41202351894, 14717.337719802634, 428361.0, 437122.0, 437522.0, 437560.0, 437569.0, 47130.76434617874, 47694.5230547697, 48011.75994120007, 48280.5171948283, 48336.7583162089, 1146.415328182633, 1174.236746115015, 1193.2303664136584, 1202.897753690946, 1204.476052916984, 25938.610920835825, 26847.0, 27013.324666883484, 27453.588196176675, 27550.724492754816, 41685.0, 41758.79120604499, 42025.15949680928, 42036.789816050725, 42103.7894810524, 350309.0, 350532.0, 351395.0, 353441.0, 353472.0, 25015.49969000646, 25174.74825251724, 25367.36581585475, 25687.743122568536, 25899.352516187246, 38280.0, 38558.0, 38618.22763544769, 38943.221135577696, 39278.661313788645, 35815.10462238465, 37127.81436092802, 37248.62751372452, 37508.2498350026, 37692.24615507729, 37033.44449833308, 37160.256794864494, 37185.814070929475, 37644.0, 37888.24223515459, 29217.269568260963, 32672.34655306928, 32905.341893162484, 33091.50362744513, 33202.16994575155, 30290.84854575713, 33772.49341259834, 33872.49191262084, 35385.469217962265, 36077.81961090178, 23834.88082559576, 24625.75374246306, 25209.495810084063, 25476.617850732626, 25604.61593076068], "value": 17003.82949757913, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.8566880413433, 362.89838845123376, 364.1569765991729, 364.64447164015087, 393.2901113490151, 16547.42084027059, 18084.547886302847, 18134.637307253848, 18518.0740962952, 18618.162182701777, 16181.433649822258, 16342.34630614774, 17958.10209489527, 18057.0, 18076.36732714352, 4625.745583992879, 4782.13921494131, 4810.9037819243595, 4820.975895120519, 4827.372441582589, 3499.737519686021, 4748.311494833247, 5209.166533354664, 5463.535599474049, 5469.972650136744, 5456.836294911139, 5468.699221542814, 5492.066348720727, 5528.612997090206, 5563.443655634424, 5559.0, 6065.302490213638, 6185.505159587222, 6233.688315584248, 6256.655883926383, 4515.390422292981, 5489.423610520877, 5507.586930980153, 5510.834674959758, 5512.641678290938, 12424.75150496994, 12509.937450312782, 19635.0, 21082.472938176667, 21083.156673733185, 1913.1199648161862, 1926.0851095729556, 1957.07039156401, 2191.7150770399903, 2203.8457307988447, 9086.45481271126, 9157.358984871062, 9171.40385874916, 9278.582463789078, 9403.62385504579, 1579.3051057534649, 1628.6986907422047, 1713.6230029393514, 1726.9740953885703, 1738.3133662203486, 69159.0, 70687.69842261799, 71921.28078719198, 72147.27852721458, 73009.6349518249, 9779.168770654433, 9800.55897484615, 10268.332558383681, 10298.588056477807, 10970.945145274223, 14040.929795350958, 14043.78934315986, 14174.929125354514, 14264.144151350953, 14317.35571899267, 7039.0, 7090.822729431806, 7118.893216601755, 7228.819279517949, 7239.167495737952, 6572.07990881277, 6579.671016449159, 6653.434458071021, 6706.83232919181, 6762.661866906733, 4363.80362883671, 4366.14860102277, 4428.955710442919, 4441.0, 4503.301988191835, 1643.1948345310711, 1674.5060207238894, 1812.8549716022687, 1820.2082094289026, 1870.1677753399606, 843.6920524008692, 880.41892351048, 882.4572887674034, 898.874157617934, 917.9724608261763, 16383.180840958143, 16614.169291535374, 16654.0, 16959.23683434224, 17289.82710172907, 838.5010918503481, 838.5807096451774, 855.2601999270586, 858.7767180533107, 871.8299931513294, 9261.861072083924, 9359.672411465566, 9509.915113240542, 9534.0, 9709.563069661883, 365159.0, 370957.0, 372125.0, 383495.0, 384911.0, 76470.61764691141, 76716.0, 77661.61169194117, 77804.0, 80416.59791701005, 885.685581618529, 890.398980688033, 900.7928176519438, 904.9502277374676, 908.56842999576, 14938.402463901322, 15209.695806084037, 15437.536873893801, 15552.222388880737, 15557.45548905783, 36558.8172059138, 37531.43702844514, 37573.24853502969, 38154.0, 38970.220595587365, 46457.76771116123, 54405.0, 55016.72491637516, 55800.441995579524, 55910.16134757901, 7407.296306850841, 7644.694212231449, 7657.0, 7713.382929365525, 7735.22647735222, 6004.519638428827, 11482.311061336346, 12214.26714397139, 12351.752964940471, 12589.811152832897, 10968.835467467834, 11055.0, 11145.832812507657, 11184.273022253852, 11427.142964277878, 10544.683659490227, 10630.73423164427, 10751.301165424222, 10973.231873769078, 11116.777664446827, 10935.125189984623, 11032.0, 11034.503447344729, 11093.112550996062, 11182.776344472903, 7802.102758182655, 7823.491473054233, 7869.724559640385, 8047.83904321922, 8144.75565733029, 8169.305609023062, 10110.949445253022, 10651.627193048205, 10662.73343166427, 10726.839097413702], "value": 8220.021999909157, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1217.5738491527964, 1257.2205232755693, 1335.9379293461698, 1466.7213229486404, 1474.7714104313823, 6706.195256569218, 7215.314545118212, 7262.237465066171, 7529.774106776792, 7722.227777222282, 7406.666699998499, 7676.232376762321, 7695.192004839481, 7703.383729301657, 7712.305892469677, 2178.9564208715856, 2217.6119179143666, 2225.043231410493, 2229.9554008919895, 2232.2633530934754, 2132.7547332056856, 2143.8928053597338, 2194.670799380098, 2194.901229444679, 2198.120751699325, 2207.3708992937018, 2209.0832304593573, 2218.955620887581, 2219.289827255279, 2220.877851718155, 2152.9031193596247, 2162.0703097668074, 2164.3615133535645, 2165.1447678167115, 2171.0447403142566, 2073.7304150460495, 2136.316378758798, 2137.6900349449397, 2140.9571808563896, 2145.3885642591786, 7735.0, 7737.613119344011, 7779.416543759241, 7785.455018148732, 7790.415718821111, 4456.621187199092, 4595.609373203281, 4630.699004564693, 4631.258998560248, 4634.513376095529, 2816.633837601119, 2829.0664080853476, 2840.332521857362, 2856.2573730829927, 2913.1843083936533, 881.9911800882037, 882.2148288023664, 909.8908131024253, 918.903515130915, 919.645936314517, 10265.640702575449, 10330.431826249629, 10365.533550990223, 10385.480725963671, 10396.16830653546, 4001.1797581495725, 4146.108586653884, 4185.539590645027, 4254.638355739797, 4271.273883439822, 8943.060978597154, 8986.326025548111, 9001.144891235323, 9006.819863602692, 9012.098790121066, 4534.886627834265, 4559.316102584573, 4566.954330456653, 4589.151007063704, 4589.311603259538, 3694.7228957827733, 4074.7555146691293, 4106.2198182345255, 4127.2570937230985, 4246.044639955985, 3595.31020420402, 3621.3662609043313, 3670.3576874046935, 3679.300932822755, 3709.9072523186596, 1175.5944199251244, 1176.8823117688335, 1196.3838623109107, 1198.5924785572947, 1209.2260952990093, 614.9477294429934, 634.7841733810434, 666.6100331306143, 696.2445746365149, 706.3254591864757, 5037.471065538139, 5047.621428392885, 5073.898522029539, 5107.668001579886, 5519.586031047687, 840.6595328891808, 853.2491407561306, 865.1391865094146, 902.5938327752538, 908.731924082384, 3558.7864728116397, 3589.4615807628543, 3622.5290712207243, 3651.561812582454, 3733.8133093345223, 9289.489078100634, 9610.855837162448, 9650.855237171449, 9686.951565242129, 9728.416295022322, 9566.426014439156, 9596.0, 9605.519724013771, 9610.903890961, 9643.08390702882, 6994.475414343945, 7358.969744235811, 7376.409887209011, 7444.404447644176, 7445.553266804009, 5186.144286192736, 5266.447023062523, 5329.54698850602, 5423.430539793265, 5468.945310546844, 8602.440841345293, 8858.0, 8878.73363799087, 8881.644734210819, 8902.065283145435, 8827.984781750181, 8836.248918841713, 8840.850689410336, 8911.06433824439, 8980.595873185854, 5745.396733342939, 5960.910586341121, 6045.153678485103, 6228.314885362697, 6349.523785716182, 7020.122484689414, 7025.121859767529, 7081.362677359062, 7105.0408194893025, 7109.182444019004, 6153.846153846118, 6481.513886458629, 6513.576617519846, 6518.217813862367, 6609.933900660932, 6114.602550834182, 6268.435840774352, 6510.934890651222, 6567.44176744982, 6635.369639884203, 5934.0, 5935.643861368331, 5935.732892019956, 5961.552883533665, 5992.790252341147, 4183.581641835792, 4330.41539392178, 4386.166628340605, 4389.429374181336, 4403.2306905675705, 4203.117345357509, 4330.0, 4366.14860102277, 4372.803223854998, 4382.342648602735], "value": 4035.056467440728, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [295.3399152893283, 301.3355551010023, 306.5463114590406, 310.11153046521724, 310.6862069309996, 4851.442084160322, 4983.302337672729, 5054.418741844689, 5096.77064532096, 5106.846794596168, 4992.578599379298, 5001.224810154423, 5010.423801262856, 5010.997800439917, 5016.372953380827, 3919.5497665863672, 3934.527856657191, 3938.5864484229173, 3959.9010024749323, 3982.1836523512684, 3889.760339932085, 3923.941140882889, 3970.0, 3971.4439978403047, 3983.6215559521943, 3901.765894046366, 3902.0049887278706, 3925.3130702127155, 3941.1920556286036, 3948.7828169450668, 3917.9608203918024, 3926.5484469285825, 3934.980325098385, 3954.548180128339, 3967.7222594418404, 3506.824658767077, 3522.119470132467, 3522.788632682047, 3528.2061536154415, 3531.5585551806025, 4670.953290467086, 4913.140200464904, 4974.328465657126, 4990.675606085629, 5013.172826483626, 4400.22995975703, 4407.405000324947, 4413.845515406945, 4434.290513517822, 4457.612214716806, 5230.267762513251, 5232.529072383466, 5247.790088396498, 5250.921236181461, 5294.7617357219015, 3638.3450978823803, 3668.5781135169264, 3695.575008873987, 3743.251349730038, 3746.194568167857, 5472.91790623141, 5498.395176530578, 5499.917501237484, 5520.696361700065, 5532.972335138298, 3777.376732839106, 3783.2244389900006, 3792.58281589025, 3803.7147213959065, 3804.239152169577, 3862.0731024553907, 3870.167913898469, 3875.8643447479767, 3880.573136954989, 3881.1849511602313, 4200.348945913388, 4410.69125161242, 4413.234706117514, 4417.447819022622, 4417.8232870684815, 5216.37403511581, 5222.869428264324, 5230.424653288135, 5241.109011468059, 5245.816396426107, 1242.1180961517243, 1288.2528133682442, 1322.8280323558067, 1327.389400875608, 1327.8937684985178, 889.6485888074304, 893.2853717026483, 906.981860362789, 911.8313112074287, 921.5576523268868, 4501.68488205829, 4506.481754598263, 4524.389207456951, 4525.230710779176, 4541.704789188692, 5326.760295786699, 5327.0, 5342.252084708144, 5342.866428339323, 5355.7054362009685, 4383.838282855046, 4512.2329204035395, 4526.755142335884, 4531.864044078683, 4539.0694907543875, 2505.6993160820816, 2539.3240461295454, 2547.6942766868096, 2572.2797616667362, 2578.48430313938, 4407.603315701603, 4472.776361181993, 4478.753668548196, 4502.263121609057, 4503.221227615074, 4663.417072865892, 4812.783424745825, 4890.0, 4911.852644420602, 4920.606351491872, 4424.0, 4444.355568442623, 4459.0413061192, 4479.70881892676, 4492.292928687143, 4689.827543114221, 4725.5983241424865, 4756.40660378777, 4760.642951778561, 4787.257975013878, 4602.7008244464005, 4632.652551058617, 4644.396228490275, 4673.6494762892235, 4685.039566888848, 4150.958490415178, 4444.777761111867, 4450.132224216247, 4481.686281960231, 4486.484054333663, 3478.556399094449, 3479.251960828333, 3479.9826000869834, 3484.5295885055193, 3494.2836718472145, 4806.188379797857, 4813.975930120327, 4839.419269687519, 4844.297576851407, 5186.0, 5050.419201791841, 5221.216817477409, 5227.18978558324, 5234.267202591716, 5311.548518375981, 5200.193969934666, 5232.241325007776, 5238.423773384849, 5240.502152295526, 5252.947470525246, 4919.680220785637, 5136.768845402041, 5154.664946778447, 5160.458151893997, 5235.214717792362, 5309.973450132725, 5316.388615309134, 5342.851286973164, 5346.1980702893325, 5376.112941364631, 5209.739513024258, 5220.190870415092, 5233.267342571967, 5259.631825772312, 5271.630985830955], "value": 3834.843428260577, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [568.3208565763914, 578.9218455508508, 580.474670423267, 610.3957082488336, 623.9750409983595, 11752.294862308258, 12396.690082747937, 12408.627741167767, 12432.254064756122, 12436.253824770509, 11488.195826292163, 11606.59376921808, 11781.7643647127, 11827.172097953147, 11876.0, 747.8317378589815, 757.2427572427572, 757.6666266842599, 761.075293518375, 765.7281665008925, 769.2346115614943, 771.7376092128675, 772.3049255669886, 772.5557804262544, 773.5088218980959, 808.8139727862596, 809.1059379385782, 810.3679130278392, 811.7889348769332, 813.1421350475247, 798.7763426240633, 799.7400844725458, 800.9118996910336, 802.5224991130268, 803.1927912447952, 583.6731430398991, 585.5491271720751, 588.1119509540582, 588.3351812451945, 589.6167491130799, 10967.83548246777, 11124.110071194285, 11166.106711463064, 11171.72070698239, 11177.0, 10462.79074418515, 10886.782264354668, 10905.618303359424, 11025.944870275678, 11243.156763242789, 9111.635534578609, 9199.678011269574, 9259.814803703888, 9281.118293762082, 9283.11810378013, 3160.9683903160903, 3210.1493104327374, 3211.0687900508824, 3222.3072039511617, 3261.037993791837, 41260.0, 54433.1835022471, 56957.430425695624, 56974.71512642452, 65295.673521633034, 10733.248672592843, 10971.670849874517, 10983.121350291958, 11018.559257629766, 11276.492557834918, 19471.318503852297, 19481.51296217606, 19674.60650786976, 19808.20767169326, 20015.399538013884, 6902.206246281641, 6952.721891124298, 6956.756513522002, 6957.443404527626, 7060.611666358297, 3526.9294614107575, 3626.9455958160647, 3652.0687224757517, 3661.3043521730788, 3735.0662334416397, 2595.740425957389, 2661.5874539446418, 2692.0846912049606, 2699.0283497940727, 2700.770434513049, 510.62213961668095, 539.2262103880944, 539.7220431477792, 554.8807006493543, 556.2546188107955, 424.71544065476206, 516.8397796682965, 566.4109326300601, 600.8798240351947, 611.807280706585, 8705.825883482295, 8860.64557417709, 8888.555572221363, 8900.73297801067, 8951.239144672645, 542.029766717579, 560.4115678537519, 562.1315068219529, 571.6427232979388, 573.9426057394311, 4051.3922911562913, 4221.303484924953, 4237.788110594458, 4325.6106950374615, 4385.780710964503, 59794.0, 71814.0, 103347.0, 106034.46982765036, 106345.46827265814, 92777.8495542674, 93209.5339523298, 93348.06651933394, 94336.52831735798, 94354.0, 51276.23085653644, 57754.0, 76957.0, 82264.58867705624, 82536.58731706304, 8041.557714325534, 8047.678092876454, 8090.878636820335, 8237.011558613005, 8398.496090234361, 46401.02377988749, 47472.52527474681, 47659.285110724064, 48450.27324590064, 49072.50927490679, 39672.0, 40316.0, 40637.39043914403, 57946.7102664484, 66429.33570664232, 9477.620895164391, 9660.95169524148, 9753.317267791186, 9838.0, 10318.742031449274, 10677.9466102669, 10828.512716927915, 11565.710857228636, 11586.47860846247, 11791.941040294743, 9531.952340238255, 10692.83960740574, 11869.762604747684, 12188.878111218773, 12702.745945080862, 12615.684607884876, 12750.34077802232, 12755.298458584866, 12875.935620321838, 12972.740545188855, 10588.152947764007, 11128.499217535069, 11273.098152147644, 11686.0, 11702.0, 10394.896051039394, 10535.157187424835, 10569.365838049742, 10903.454827258764, 11321.943390282995, 9608.279379046739, 9902.158316542886, 9907.554160062959, 10072.143867771321, 10626.681199564026], "value": 6342.96558096939, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1575.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 113.0, 108.0, 116.0, 116.0, 114.0, 124.0, 114.0, 113.0, 113.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 125.0, 148.0, 184.0, 132.0, 145.0, 148.0, 127.0, 186.0, 140.0], "value": 148.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 162.0, 165.0, 168.0, 169.0, 162.0, 163.0, 163.0, 163.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 78.0, 158.0, 78.0, 76.0, 76.0, 77.0, 158.0, 77.0], "value": 93.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 153.0, 86.0, 87.0, 86.0, 133.0, 85.0, 86.0, 133.0], "value": 102.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 119.0, 117.0, 117.0, 118.0, 121.0, 119.0, 117.0, 120.0, 117.0], "value": 118.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 150.0, 149.0, 148.0, 149.0, 147.0, 147.0, 148.0, 147.0, 148.0], "value": 148.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 96.0], "value": 95.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 67.0, 65.0, 64.0, 66.0, 64.0, 65.0, 63.0], "value": 64.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 65.0, 64.0, 65.0, 64.0, 66.0, 65.0, 64.0, 65.0], "value": 64.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 83.0, 79.0, 80.0, 80.0, 84.0, 81.0, 85.0, 91.0, 81.0], "value": 83.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 142.0, 132.0, 141.0, 155.0, 147.0, 132.0, 131.0, 183.0, 135.0], "value": 144.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 167.0, 169.0, 165.0, 162.0, 164.0, 165.0, 167.0, 162.0], "value": 165.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 74.0, 68.0, 68.0, 71.0, 68.0, 68.0, 70.0, 67.0, 71.0], "value": 69.3, "unit": "score"}]}]} 18:55:42 INFO - Return code: 0 18:55:42 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:55:42 ERROR - # TBPL SUCCESS # 18:55:42 INFO - Running post-action listener: _resource_record_post_action 18:55:42 INFO - ##### 18:55:42 INFO - ##### Finished run-tests step (success) 18:55:42 INFO - ##### 18:55:42 INFO - Running post-run listener: _resource_record_post_run 18:55:42 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 549646336; Read time: 24; Write time: 416484 18:55:42 INFO - TinderboxPrint: CPU usage
13.4% 18:55:42 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 24 18:55:42 INFO - TinderboxPrint: I/O write bytes / time
549,646,336 / 416,484 18:55:42 INFO - TinderboxPrint: CPU idle
8,272.5 (86.6%) 18:55:42 INFO - TinderboxPrint: CPU user
1,223.7 (12.8%) 18:55:42 INFO - TinderboxPrint: Swap in / out
0 / 0 18:55:43 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 261615616; Read time: 0; Write time: 249512 18:55:43 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288030720; Read time: 0; Write time: 166972 18:55:43 INFO - Running post-run listener: _upload_blobber_files 18:55:43 INFO - Blob upload gear active. 18:55:43 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:55:43 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 18:55:43 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:55:43 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:55:43 INFO - (blobuploader) - INFO - Open directory for files ... 18:55:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 18:55:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:55:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:55:45 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 18:55:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:55:45 INFO - (blobuploader) - INFO - Done attempting. 18:55:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:55:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:55:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:55:48 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:55:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:55:48 INFO - (blobuploader) - INFO - Done attempting. 18:55:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 18:55:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:55:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:55:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 18:55:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:55:49 INFO - (blobuploader) - INFO - Done attempting. 18:55:49 INFO - (blobuploader) - INFO - Iteration through files over. 18:55:49 INFO - Return code: 0 18:55:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:55:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:55:49 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c30651fd4b45c262d44534a8a0fca5bb7d49cccd17a27bac1a0976a818920567f1451fd0a93f98c6f10294d9cefeb0607d70348266d42f80acaf6010b647da8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e58d3fe9dfe55fa22ecc6b67e35282c941ec6a7a97129af3d1611ab1be802690f06e7e599ea348253967651084b9418740bd81041b8acf9773ffd22e79ba0276", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05c13b2096bc2d597dca9325fa7aefbb066db69b1121a1492b2eb01ab7f138464981aa2d90c4c13c8d19acc830e1cbd10ac9be347550c2efeb8998d7fbd34e75"} 18:55:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:55:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:55:49 INFO - Contents: 18:55:49 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c30651fd4b45c262d44534a8a0fca5bb7d49cccd17a27bac1a0976a818920567f1451fd0a93f98c6f10294d9cefeb0607d70348266d42f80acaf6010b647da8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e58d3fe9dfe55fa22ecc6b67e35282c941ec6a7a97129af3d1611ab1be802690f06e7e599ea348253967651084b9418740bd81041b8acf9773ffd22e79ba0276", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05c13b2096bc2d597dca9325fa7aefbb066db69b1121a1492b2eb01ab7f138464981aa2d90c4c13c8d19acc830e1cbd10ac9be347550c2efeb8998d7fbd34e75"} 18:55:49 INFO - Running post-run listener: copy_logs_to_upload_dir 18:55:49 INFO - Copying logs to upload dir... 18:55:49 INFO - mkdir: /builds/slave/test/build/upload/logs 18:55:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.464692 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-07 18:55:49.207433) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 18:55:49.210748) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c30651fd4b45c262d44534a8a0fca5bb7d49cccd17a27bac1a0976a818920567f1451fd0a93f98c6f10294d9cefeb0607d70348266d42f80acaf6010b647da8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e58d3fe9dfe55fa22ecc6b67e35282c941ec6a7a97129af3d1611ab1be802690f06e7e599ea348253967651084b9418740bd81041b8acf9773ffd22e79ba0276", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05c13b2096bc2d597dca9325fa7aefbb066db69b1121a1492b2eb01ab7f138464981aa2d90c4c13c8d19acc830e1cbd10ac9be347550c2efeb8998d7fbd34e75"} build_url:https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011394 build_url: 'https://queue.taskcluster.net/v1/task/AzQFd4kORSKB6lyU6D3R2g/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/7c30651fd4b45c262d44534a8a0fca5bb7d49cccd17a27bac1a0976a818920567f1451fd0a93f98c6f10294d9cefeb0607d70348266d42f80acaf6010b647da8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/e58d3fe9dfe55fa22ecc6b67e35282c941ec6a7a97129af3d1611ab1be802690f06e7e599ea348253967651084b9418740bd81041b8acf9773ffd22e79ba0276", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/05c13b2096bc2d597dca9325fa7aefbb066db69b1121a1492b2eb01ab7f138464981aa2d90c4c13c8d19acc830e1cbd10ac9be347550c2efeb8998d7fbd34e75"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 18:55:49.242916) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:55:49.243279) ========= 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=337fe3f4b1febe37b85fccc40000019e-1467938901.691382-1581653402 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004451 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:55:49.328447) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 18:55:49.329202) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 18:55:49.329803) ========= ========= Total master_lag: 0.20 =========