builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-069 starttime: 1467941708.86 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.860058) ========= 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.860454) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:08.860726) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:08.890368) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:08.890745) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 18:35:10-- 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% 46.1M=0s 2016-07-07 18:35:10 (46.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.094435 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.007724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.008001) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018438 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.069326) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.069664) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 18:35:10,346 truncating revision to first 12 chars 2016-07-07 18:35:10,346 Setting DEBUG logging. 2016-07-07 18:35:10,346 attempt 1/10 2016-07-07 18:35:10,346 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:10,669 unpacking tar archive at: mozilla-central-4e3c16ea8fce/testing/mozharness/ program finished with exit code 0 elapsedTime=0.653496 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.739369) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.739982) ========= script_repo_revision: 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.740839) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.749296) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 18:35:09.760420) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-07 18:35:09.760745) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:35:11 INFO - MultiFileLogger online at 20160707 18:35:11 in /builds/slave/test 18:35:11 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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:11 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:35:11 INFO - {'append_to_log': False, 18:35:11 INFO - 'base_work_dir': '/builds/slave/test', 18:35:11 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 18:35:11 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:35:11 INFO - 'branch': 'Firefox-Non-PGO', 18:35:11 INFO - 'buildbot_json_path': 'buildprops.json', 18:35:11 INFO - 'config_files': ('talos/linux_config.py',), 18:35:11 INFO - 'default_actions': ('clobber', 18:35:11 INFO - 'read-buildbot-config', 18:35:11 INFO - 'download-and-extract', 18:35:11 INFO - 'populate-webroot', 18:35:11 INFO - 'create-virtualenv', 18:35:11 INFO - 'install', 18:35:11 INFO - 'run-tests'), 18:35:11 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:35:11 INFO - 'download_minidump_stackwalk': True, 18:35:11 INFO - 'download_symbols': 'ondemand', 18:35:11 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:35:11 INFO - 'tooltool.py': '/tools/tooltool.py', 18:35:11 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:35:11 INFO - '/tools/misc-python/virtualenv.py')}, 18:35:11 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:35:11 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:35:11 INFO - 'installer_path': 'installer.exe', 18:35:11 INFO - 'log_level': 'info', 18:35:11 INFO - 'log_name': 'talos', 18:35:11 INFO - 'log_to_console': True, 18:35:11 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:35:11 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:35:11 INFO - 'opt_config_files': (), 18:35:11 INFO - 'pip_index': False, 18:35:11 INFO - 'sps_profile': False, 18:35:11 INFO - 'sps_profile_interval': 0, 18:35:11 INFO - 'suite': 'dromaeojs', 18:35:11 INFO - 'system_bits': '32', 18:35:11 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:35:11 INFO - 'title': 'talos-linux64-ix-069', 18:35:11 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:35:11 INFO - 'use_talos_json': True, 18:35:11 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:35:11 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:35:11 INFO - 'work_dir': 'build'} 18:35:11 INFO - ##### 18:35:11 INFO - ##### Running clobber step. 18:35:11 INFO - ##### 18:35:11 INFO - Running pre-action listener: _resource_record_pre_action 18:35:11 INFO - Running main action method: clobber 18:35:11 INFO - rmtree: /builds/slave/test/build 18:35:11 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:35:11 INFO - Running post-action listener: _resource_record_post_action 18:35:11 INFO - ##### 18:35:11 INFO - ##### Finished clobber step (success) 18:35:11 INFO - ##### 18:35:11 INFO - ##### 18:35:11 INFO - ##### Running read-buildbot-config step. 18:35:11 INFO - ##### 18:35:11 INFO - Running pre-action listener: _resource_record_pre_action 18:35:11 INFO - Running main action method: read_buildbot_config 18:35:11 INFO - Using buildbot properties: 18:35:11 INFO - { 18:35:11 INFO - "project": "", 18:35:11 INFO - "product": "firefox", 18:35:11 INFO - "script_repo_revision": "production", 18:35:11 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 18:35:11 INFO - "repository": "", 18:35:11 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 18:35:11 INFO - "buildid": "20160707171626", 18:35:11 INFO - "pgo_build": "False", 18:35:11 INFO - "basedir": "/builds/slave/test", 18:35:11 INFO - "buildnumber": 545, 18:35:11 INFO - "slavename": "talos-linux64-ix-069", 18:35:11 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:35:11 INFO - "platform": "ubuntu64_hw", 18:35:11 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 18:35:11 INFO - "branch": "mozilla-central", 18:35:11 INFO - "repo_path": "mozilla-central", 18:35:11 INFO - "revision": "4e3c16ea8fced03ab4ef572f16d4aa4464981e2c", 18:35:11 INFO - "stage_platform": "linux64", 18:35:11 INFO - "builduid": "d476c4c6f83f4ca48e110f6177a61747", 18:35:11 INFO - "slavebuilddir": "test" 18:35:11 INFO - } 18:35:11 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:11 INFO - Running post-action listener: _resource_record_post_action 18:35:11 INFO - ##### 18:35:11 INFO - ##### Finished read-buildbot-config step (success) 18:35:11 INFO - ##### 18:35:11 INFO - ##### 18:35:11 INFO - ##### Running download-and-extract step. 18:35:11 INFO - ##### 18:35:11 INFO - Running pre-action listener: _resource_record_pre_action 18:35:11 INFO - Running main action method: download_and_extract 18:35:11 INFO - mkdir: /builds/slave/test/build/tests 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.test_packages.json 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.test_packages.json 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.test_packages.json 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.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:35:11 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:14 INFO - Downloaded 1361 bytes. 18:35:14 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 18:35:14 INFO - Using the following test package requirements: 18:35:14 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:35:14 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:35:14 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 18:35:14 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:14 INFO - u'jsshell-linux-x86_64.zip'], 18:35:14 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:35:14 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 18:35:14 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:35:14 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:35:14 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:35:14 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 18:35:14 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:35:14 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:35:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:14 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:14 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:14 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:14 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:14 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:16 INFO - Downloaded 22734691 bytes. 18:35:16 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:16 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:17 INFO - Return code: 0 18:35:17 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:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:17 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:17 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:17 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:17 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:17 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:19 INFO - Downloaded 22734691 bytes. 18:35:19 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:19 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: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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip 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.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 18:35:20 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:21 INFO - Downloaded 14403333 bytes. 18:35:21 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:21 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:21 INFO - Return code: 0 18:35:21 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:21 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:21 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:21 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:21 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:21 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:24 INFO - Running post-action listener: _resource_record_post_action 18:35:24 INFO - Running post-action listener: set_extra_try_arguments 18:35:24 INFO - ##### 18:35:24 INFO - ##### Finished download-and-extract step (success) 18:35:24 INFO - ##### 18:35:24 INFO - ##### 18:35:24 INFO - ##### Running populate-webroot 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: populate_webroot 18:35:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:35:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:35:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:35:24 INFO - '--tppagecycles', 18:35:24 INFO - '7'], 18:35:24 INFO - 'tests': ['tsvgm']}}, 18:35:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 18:35:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:35:24 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:25 INFO - Installing distribute.............................................................................................................................................................................................done. 18:35:27 INFO - Installing pip.................done. 18:35:27 INFO - Return code: 0 18:35:27 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:27 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 0x122a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e93b0>, '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 0x14ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', '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:27 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:27 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:27 INFO - Using env: {'DISPLAY': ':0', 18:35:27 INFO - 'HOME': '/home/cltbld', 18:35:27 INFO - 'LANG': 'en_US.UTF-8', 18:35:27 INFO - 'LANGUAGE': 'en_US:en', 18:35:27 INFO - 'LOGNAME': 'cltbld', 18:35:27 INFO - 'MAIL': '/var/mail/cltbld', 18:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:27 INFO - 'MOZ_NO_REMOTE': '1', 18:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:27 INFO - 'NO_EM_RESTART': '1', 18:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:27 INFO - 'PWD': '/builds/slave/test', 18:35:27 INFO - 'SHELL': '/bin/bash', 18:35:27 INFO - 'SHLVL': '1', 18:35:27 INFO - 'TERM': 'linux', 18:35:27 INFO - 'TMOUT': '86400', 18:35:27 INFO - 'USER': 'cltbld', 18:35:27 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', 18:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:27 INFO - '_': '/tools/buildbot/bin/python'} 18:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:27 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:27 INFO - Cleaning up... 18:35:27 INFO - Return code: 0 18:35:27 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 18:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:27 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 0x122a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e93b0>, '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 0x14ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', '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:27 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:27 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:27 INFO - Using env: {'DISPLAY': ':0', 18:35:27 INFO - 'HOME': '/home/cltbld', 18:35:27 INFO - 'LANG': 'en_US.UTF-8', 18:35:27 INFO - 'LANGUAGE': 'en_US:en', 18:35:27 INFO - 'LOGNAME': 'cltbld', 18:35:27 INFO - 'MAIL': '/var/mail/cltbld', 18:35:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:27 INFO - 'MOZ_NO_REMOTE': '1', 18:35:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:27 INFO - 'NO_EM_RESTART': '1', 18:35:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:27 INFO - 'PWD': '/builds/slave/test', 18:35:27 INFO - 'SHELL': '/bin/bash', 18:35:27 INFO - 'SHLVL': '1', 18:35:27 INFO - 'TERM': 'linux', 18:35:27 INFO - 'TMOUT': '86400', 18:35:27 INFO - 'USER': 'cltbld', 18:35:27 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', 18:35:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:27 INFO - '_': '/tools/buildbot/bin/python'} 18:35:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:27 INFO - Downloading/unpacking psutil>=3.1.1 18:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:35:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:35:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:35:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 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 - Installing collected packages: psutil 18:35:29 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:30 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:30 INFO - building 'psutil._psutil_posix' extension 18:35:30 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:30 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:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:35:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:35:30 INFO - Successfully installed psutil 18:35:30 INFO - Cleaning up... 18:35:30 INFO - Return code: 0 18:35:30 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 18:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:35:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:30 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 0x122a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e93b0>, '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 0x14ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', '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:30 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:30 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:30 INFO - Using env: {'DISPLAY': ':0', 18:35:30 INFO - 'HOME': '/home/cltbld', 18:35:30 INFO - 'LANG': 'en_US.UTF-8', 18:35:30 INFO - 'LANGUAGE': 'en_US:en', 18:35:30 INFO - 'LOGNAME': 'cltbld', 18:35:30 INFO - 'MAIL': '/var/mail/cltbld', 18:35:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:30 INFO - 'MOZ_NO_REMOTE': '1', 18:35:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:30 INFO - 'NO_EM_RESTART': '1', 18:35:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:30 INFO - 'PWD': '/builds/slave/test', 18:35:30 INFO - 'SHELL': '/bin/bash', 18:35:30 INFO - 'SHLVL': '1', 18:35:30 INFO - 'TERM': 'linux', 18:35:30 INFO - 'TMOUT': '86400', 18:35:30 INFO - 'USER': 'cltbld', 18:35:30 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', 18:35:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:30 INFO - '_': '/tools/buildbot/bin/python'} 18:35:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:30 INFO - Downloading/unpacking mozsystemmonitor==0.3 18:35:30 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:30 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:30 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:30 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:30 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:30 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 - Downloading mozsystemmonitor-0.3.tar.gz 18:35:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:35:32 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:32 INFO - Installing collected packages: mozsystemmonitor 18:35:32 INFO - Running setup.py install for mozsystemmonitor 18:35:32 INFO - Successfully installed mozsystemmonitor 18:35:32 INFO - Cleaning up... 18:35:32 INFO - Return code: 0 18:35:32 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 18:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:32 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 0x122a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e93b0>, '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 0x14ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', '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:32 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:32 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:32 INFO - Using env: {'DISPLAY': ':0', 18:35:32 INFO - 'HOME': '/home/cltbld', 18:35:32 INFO - 'LANG': 'en_US.UTF-8', 18:35:32 INFO - 'LANGUAGE': 'en_US:en', 18:35:32 INFO - 'LOGNAME': 'cltbld', 18:35:32 INFO - 'MAIL': '/var/mail/cltbld', 18:35:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:32 INFO - 'MOZ_NO_REMOTE': '1', 18:35:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:32 INFO - 'NO_EM_RESTART': '1', 18:35:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:32 INFO - 'PWD': '/builds/slave/test', 18:35:32 INFO - 'SHELL': '/bin/bash', 18:35:32 INFO - 'SHLVL': '1', 18:35:32 INFO - 'TERM': 'linux', 18:35:32 INFO - 'TMOUT': '86400', 18:35:32 INFO - 'USER': 'cltbld', 18:35:32 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', 18:35:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:32 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:34 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:35:34 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 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: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:35 INFO - Installing collected packages: jsonschema, functools32 18:35:35 INFO - Running setup.py install for functools32 18:35:35 INFO - warning: no files found matching '*.txt' 18:35:35 INFO - no previously-included directories found matching 'build' 18:35:35 INFO - no previously-included directories found matching 'dist' 18:35:35 INFO - no previously-included directories found matching '.git*' 18:35:35 INFO - Successfully installed jsonschema functools32 18:35:35 INFO - Cleaning up... 18:35:35 INFO - Return code: 0 18:35:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:35:35 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:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:35 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:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:35 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 0x122a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e93b0>, '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 0x14ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', '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:35 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:35 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:35 INFO - Using env: {'DISPLAY': ':0', 18:35:35 INFO - 'HOME': '/home/cltbld', 18:35:35 INFO - 'LANG': 'en_US.UTF-8', 18:35:35 INFO - 'LANGUAGE': 'en_US:en', 18:35:35 INFO - 'LOGNAME': 'cltbld', 18:35:35 INFO - 'MAIL': '/var/mail/cltbld', 18:35:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:35 INFO - 'MOZ_NO_REMOTE': '1', 18:35:35 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:35 INFO - 'NO_EM_RESTART': '1', 18:35:35 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:35 INFO - 'PWD': '/builds/slave/test', 18:35:35 INFO - 'SHELL': '/bin/bash', 18:35:35 INFO - 'SHLVL': '1', 18:35:35 INFO - 'TERM': 'linux', 18:35:35 INFO - 'TMOUT': '86400', 18:35:35 INFO - 'USER': 'cltbld', 18:35:35 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', 18:35:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:35 INFO - '_': '/tools/buildbot/bin/python'} 18:35:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:35 INFO - Downloading/unpacking blobuploader==1.2.4 18:35:35 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:35 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:35 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:35 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:35 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:35 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 blobuploader-1.2.4.tar.gz 18:35:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:35:37 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:35:37 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:37 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 - 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:37 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:37 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:37 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 - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:35:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:35:37 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:37 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 - 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:37 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:37 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:37 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:38 INFO - Installing collected packages: blobuploader, requests, docopt 18:35:38 INFO - Running setup.py install for blobuploader 18:35:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:35:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:35:38 INFO - Running setup.py install for requests 18:35:38 INFO - Running setup.py install for docopt 18:35:38 INFO - Successfully installed blobuploader requests docopt 18:35:38 INFO - Cleaning up... 18:35:38 INFO - Return code: 0 18:35:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:38 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 0x122a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e93b0>, '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 0x14ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', '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:38 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:38 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:38 INFO - Using env: {'DISPLAY': ':0', 18:35:38 INFO - 'HOME': '/home/cltbld', 18:35:38 INFO - 'LANG': 'en_US.UTF-8', 18:35:38 INFO - 'LANGUAGE': 'en_US:en', 18:35:38 INFO - 'LOGNAME': 'cltbld', 18:35:38 INFO - 'MAIL': '/var/mail/cltbld', 18:35:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:38 INFO - 'MOZ_NO_REMOTE': '1', 18:35:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:38 INFO - 'NO_EM_RESTART': '1', 18:35:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:38 INFO - 'PWD': '/builds/slave/test', 18:35:38 INFO - 'SHELL': '/bin/bash', 18:35:38 INFO - 'SHLVL': '1', 18:35:38 INFO - 'TERM': 'linux', 18:35:38 INFO - 'TMOUT': '86400', 18:35:38 INFO - 'USER': 'cltbld', 18:35:38 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', 18:35:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:38 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-LatPLx-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-2mM6k8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:35:39 INFO - Running setup.py (path:/tmp/pip-IkPJDG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:35:39 INFO - Running setup.py (path:/tmp/pip-A4ZY26-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:35:39 INFO - Running setup.py (path:/tmp/pip-1lABGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:35:39 INFO - Running setup.py (path:/tmp/pip-T56A1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:35:39 INFO - Running setup.py (path:/tmp/pip-5AS5U1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:35:39 INFO - Running setup.py (path:/tmp/pip-G2wcFn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:35:39 INFO - Running setup.py (path:/tmp/pip-9Mp5o5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:35:39 INFO - Running setup.py (path:/tmp/pip-Y8lW38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:35:39 INFO - Running setup.py (path:/tmp/pip-0naJx7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:35:39 INFO - Running setup.py (path:/tmp/pip-MNmD6V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:35:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:35:39 INFO - Running setup.py (path:/tmp/pip-b9nQSo-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-1X08PV-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-npQrzc-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-75v3hH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:35:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:35:40 INFO - Running setup.py (path:/tmp/pip-qy4ajh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:35:40 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:35:40 INFO - Running setup.py install for manifestparser 18:35:40 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Running setup.py install for mozcrash 18:35:40 INFO - Running setup.py install for mozdebug 18:35:40 INFO - Running setup.py install for mozdevice 18:35:40 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:35:40 INFO - Running setup.py install for mozfile 18:35:40 INFO - Running setup.py install for mozhttpd 18:35:40 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:35:40 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:41 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:35:41 INFO - Running setup.py install for moznetwork 18:35:41 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:35:41 INFO - Running setup.py install for mozprocess 18:35:41 INFO - Running setup.py install for mozprofile 18:35:41 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:35:41 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:35:41 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:35:41 INFO - Running setup.py install for mozrunner 18:35:41 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:35:41 INFO - Running setup.py install for mozscreenshot 18:35:41 INFO - Running setup.py install for moztest 18:35:41 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 0x122a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e93b0>, '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 0x14ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', 18:35:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:41 INFO - '_': '/tools/buildbot/bin/python'} 18:35:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:35:42 INFO - Running setup.py (path:/tmp/pip-WunQzS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:35:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:35:42 INFO - Running setup.py (path:/tmp/pip-A3NTEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:35:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:35:42 INFO - Running setup.py (path:/tmp/pip-IFVEIb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:35:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:35:42 INFO - Running setup.py (path:/tmp/pip-rA8xq7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:35:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:35:42 INFO - Running setup.py (path:/tmp/pip-jZ4OfK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:35:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:35:42 INFO - Running setup.py (path:/tmp/pip-RPx5pr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:35:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:35:42 INFO - Running setup.py (path:/tmp/pip-ee5P6D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:35:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:35:42 INFO - Running setup.py (path:/tmp/pip-WCdX4J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:35:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:35:42 INFO - Running setup.py (path:/tmp/pip-SgLzCO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:35:42 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:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:35:42 INFO - Running setup.py (path:/tmp/pip-h78IV9-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-wRQRqm-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-VMQkvO-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-L80asd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:35:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:35:43 INFO - Running setup.py (path:/tmp/pip-m7hyfg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:35:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:43 INFO - Running setup.py (path:/tmp/pip-mVMZsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:35:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:35:43 INFO - Running setup.py (path:/tmp/pip-JiojAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:35:43 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:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:35:43 INFO - Running setup.py (path:/tmp/pip-mEmWRR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:35:43 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:43 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:43 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:43 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:43 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:43 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:43 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:35:43 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:43 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:43 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:43 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:43 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:43 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:45 INFO - Downloading blessings-1.6.tar.gz 18:35:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:35:45 INFO - Installing collected packages: blessings 18:35:45 INFO - Running setup.py install for blessings 18:35:45 INFO - Successfully installed blessings 18:35:45 INFO - Cleaning up... 18:35:45 INFO - Return code: 0 18:35:45 INFO - Done creating virtualenv /builds/slave/test/build/venv. 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 - Current package versions: 18:35:45 INFO - argparse == 1.2.1 18:35:45 INFO - blessings == 1.6 18:35:45 INFO - blobuploader == 1.2.4 18:35:45 INFO - docopt == 0.6.1 18:35:45 INFO - functools32 == 3.2.3-2 18:35:45 INFO - jsonschema == 2.5.1 18:35:45 INFO - manifestparser == 1.1 18:35:45 INFO - mozInstall == 1.12 18:35:45 INFO - mozcrash == 0.17 18:35:45 INFO - mozdebug == 0.1 18:35:45 INFO - mozdevice == 0.48 18:35:45 INFO - mozfile == 1.2 18:35:45 INFO - mozhttpd == 0.7 18:35:45 INFO - mozinfo == 0.9 18:35:45 INFO - mozleak == 0.1 18:35:45 INFO - mozlog == 3.2 18:35:45 INFO - moznetwork == 0.27 18:35:45 INFO - mozprocess == 0.23 18:35:45 INFO - mozprofile == 0.28 18:35:45 INFO - mozrunner == 6.12 18:35:45 INFO - mozscreenshot == 0.1 18:35:45 INFO - mozsystemmonitor == 0.3 18:35:45 INFO - moztest == 0.7 18:35:45 INFO - mozversion == 1.4 18:35:45 INFO - psutil == 3.1.1 18:35:45 INFO - requests == 1.2.3 18:35:45 INFO - wsgiref == 0.1.2 18:35:45 INFO - Installing None 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', '-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 0x122a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e93b0>, '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 0x14ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', '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', '-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:45 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: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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', 18:35:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:45 INFO - '_': '/tools/buildbot/bin/python'} 18:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:46 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:46 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:46 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:46 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:46 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:46 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:46 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:46 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:46 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:46 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:46 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:46 INFO - Cleaning up... 18:35:46 INFO - Return code: 0 18:35:46 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:35:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:35:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:35:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x122a030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x138d8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14eb180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14e93b0>, '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 0x14ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea740>, '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': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', '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:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 18:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 18:35:46 INFO - Using env: {'DISPLAY': ':0', 18:35:46 INFO - 'HOME': '/home/cltbld', 18:35:46 INFO - 'LANG': 'en_US.UTF-8', 18:35:46 INFO - 'LANGUAGE': 'en_US:en', 18:35:46 INFO - 'LOGNAME': 'cltbld', 18:35:46 INFO - 'MAIL': '/var/mail/cltbld', 18:35:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:46 INFO - 'MOZ_NO_REMOTE': '1', 18:35:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:35:46 INFO - 'NO_EM_RESTART': '1', 18:35:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:35:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:46 INFO - 'PWD': '/builds/slave/test', 18:35:46 INFO - 'SHELL': '/bin/bash', 18:35:46 INFO - 'SHLVL': '1', 18:35:46 INFO - 'TERM': 'linux', 18:35:46 INFO - 'TMOUT': '86400', 18:35:46 INFO - 'USER': 'cltbld', 18:35:46 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', 18:35:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:46 INFO - '_': '/tools/buildbot/bin/python'} 18:35:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:35:46 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 18:35:46 INFO - Cleaning up... 18:35:46 INFO - Return code: 0 18:35:46 INFO - Running post-action listener: _resource_record_post_action 18:35:46 INFO - Running post-action listener: _start_resource_monitoring 18:35:46 INFO - Starting resource monitoring. 18:35:46 INFO - ##### 18:35:46 INFO - ##### Finished create-virtualenv step (success) 18:35:46 INFO - ##### 18:35:46 INFO - ##### 18:35:46 INFO - ##### Running install step. 18:35:46 INFO - ##### 18:35:46 INFO - Running pre-action listener: _resource_record_pre_action 18:35:46 INFO - Running main action method: install 18:35:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:35:46 INFO - Reading from file tmpfile_stdout 18:35:46 INFO - Detecting whether we're running mozinstall >=1.0... 18:35:46 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:35:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:35:46 INFO - Reading from file tmpfile_stdout 18:35:46 INFO - Output received: 18:35:46 INFO - Usage: mozinstall [options] installer 18:35:46 INFO - Options: 18:35:46 INFO - -h, --help show this help message and exit 18:35:46 INFO - -d DEST, --destination=DEST 18:35:46 INFO - Directory to install application into. [default: 18:35:46 INFO - "/builds/slave/test"] 18:35:46 INFO - --app=APP Application being installed. [default: firefox] 18:35:46 INFO - mkdir: /builds/slave/test/build/application 18:35:46 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:46 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 0x14e93b0>, '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 0x14ea2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14ea740>, '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:03 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:36:03 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:36:03 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:36:03 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:36:03 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:36:03 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', '--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-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 18:36:03 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 --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-069 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 18:36:03 INFO - Using env: {'DISPLAY': ':0', 18:36:03 INFO - 'HOME': '/home/cltbld', 18:36:03 INFO - 'LANG': 'en_US.UTF-8', 18:36:03 INFO - 'LANGUAGE': 'en_US:en', 18:36:03 INFO - 'LOGNAME': 'cltbld', 18:36:03 INFO - 'MAIL': '/var/mail/cltbld', 18:36:03 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:36:03 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:36:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:36:03 INFO - 'MOZ_NO_REMOTE': '1', 18:36:03 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:36:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:36:03 INFO - 'NO_EM_RESTART': '1', 18:36:03 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:36:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:36:03 INFO - 'PWD': '/builds/slave/test', 18:36:03 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:36:03 INFO - 'SHELL': '/bin/bash', 18:36:03 INFO - 'SHLVL': '1', 18:36:03 INFO - 'TERM': 'linux', 18:36:03 INFO - 'TMOUT': '86400', 18:36:03 INFO - 'USER': 'cltbld', 18:36:03 INFO - 'XDG_SESSION_COOKIE': '05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068', 18:36:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:36:03 INFO - '_': '/tools/buildbot/bin/python'} 18:36:03 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', '--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-069', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 18:36:03 INFO - mozversion application_buildid: 20160707171626 18:36:03 INFO - mozversion application_changeset: 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c 18:36:03 INFO - mozversion application_display_name: Nightly 18:36:03 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:36:03 INFO - mozversion application_name: Firefox 18:36:03 INFO - mozversion application_remotingname: firefox 18:36:03 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 18:36:03 INFO - mozversion application_vendor: Mozilla 18:36:03 INFO - mozversion application_version: 50.0a1 18:36:03 INFO - mozversion platform_buildid: 20160707171626 18:36:03 INFO - mozversion platform_changeset: 4e3c16ea8fced03ab4ef572f16d4aa4464981e2c 18:36:03 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 18:36:03 INFO - mozversion platform_version: 50.0a1 18:36:03 INFO - using testdate: 1467941763 18:36:03 INFO - actual date: 1467941763 18:36:03 INFO - starting webserver on 'localhost:53767' 18:36:03 INFO - SUITE-START | Running 2 tests 18:36:03 INFO - TEST-START | dromaeo_css 18:36:03 INFO - operating with platform_type : linux_ 18:36:03 INFO - Initialising browser for dromaeo_css test... 18:36:03 INFO - TEST-INFO | started process 18770 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprjFKWl/profile http://localhost:53767/getInfo.html) 18:36:07 INFO - PROCESS | 18770 | __metrics Screen width/height:1600/1200 18:36:07 INFO - PROCESS | 18770 | colorDepth:24 18:36:07 INFO - PROCESS | 18770 | Browser inner width/height: 1024/697 18:36:07 INFO - PROCESS | 18770 | __metrics 18:36:08 INFO - PROCESS | 18770 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:36:09 INFO - TEST-INFO | 18770: exit 0 18:36:09 INFO - Browser initialized. 18:36:09 INFO - Running cycle 1/1 for dromaeo_css test... 18:36:09 INFO - TEST-INFO | started process 18850 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprjFKWl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:36:21 INFO - PROCESS | 18850 | RSS: Main: 158928896 18:36:21 INFO - PROCESS | 18850 | 18:37:13 INFO - PROCESS | 18850 | 1467941833429 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:25 INFO - PROCESS | 18850 | Cycle 1(1): loaded http://localhost:53767/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53767/tests/dromaeo/cssquery-ext.html) 18:39:26 INFO - PROCESS | 18850 | RSS: Main: 259551232 18:39:26 INFO - PROCESS | 18850 | 18:42:28 INFO - PROCESS | 18850 | Cycle 1(1): loaded http://localhost:53767/tests/dromaeo/cssquery-ext.html (next: http://localhost:53767/tests/dromaeo/cssquery-jquery.html) 18:42:29 INFO - PROCESS | 18850 | RSS: Main: 246108160 18:42:29 INFO - PROCESS | 18850 | 18:45:31 INFO - PROCESS | 18850 | Cycle 1(1): loaded http://localhost:53767/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53767/tests/dromaeo/cssquery-mootools.html) 18:45:32 INFO - PROCESS | 18850 | RSS: Main: 252837888 18:45:32 INFO - PROCESS | 18850 | 18:48:34 INFO - PROCESS | 18850 | Cycle 1(1): loaded http://localhost:53767/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53767/tests/dromaeo/cssquery-prototype.html) 18:48:35 INFO - PROCESS | 18850 | RSS: Main: 246222848 18:48:35 INFO - PROCESS | 18850 | 18:51:38 INFO - PROCESS | 18850 | Cycle 1(1): loaded http://localhost:53767/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53767/tests/dromaeo/cssquery-yui.html) 18:51:38 INFO - PROCESS | 18850 | RSS: Main: 218877952 18:51:38 INFO - PROCESS | 18850 | 18:54:41 INFO - PROCESS | 18850 | Cycle 1(1): loaded http://localhost:53767/tests/dromaeo/cssquery-yui.html (next: http://localhost:53767/tests/dromaeo/cssquery-dojo.html) 18:54:42 INFO - PROCESS | 18850 | RSS: Main: 330932224 18:54:42 INFO - PROCESS | 18850 | 18:54:42 INFO - PROCESS | 18850 | __start_tp_report 18:54:42 INFO - PROCESS | 18850 | _x_x_mozilla_page_load 18:54:42 INFO - PROCESS | 18850 | _x_x_mozilla_page_load_details 18:54:42 INFO - PROCESS | 18850 | |i|pagename|runs| 18:54:42 INFO - PROCESS | 18850 | |0;dojo.html;2553.310606136342;2563.1029139801067;2589.689237291524;2598.3374239568907;2603.1799983005353;4589.8164073437065;4594.127115847987;4602.907941841166;4619.445666520018;4676.602488788457;4619.2609182530805;4638.536146385368;4666.043461090477;4676.438827340716;4693.296005599162;4247.426597409341;4259.70182087254;4259.893502662443;4271.039016221349;4392.033752574429;4305.440292761937;4349.847755328564;4391.604755571998;4398.64810815134;4399.340098985162;4216.64158546524;4333.306670932667;4358;4377.321515165155;4381.78091095444;4242.554531774181;4248.192843359751;4262.7655478948645;4266.210751011073;4268.210381079511;4212.304969679999;4278.058827058042;4286.485621725382;4286.61420472159;4336.089421221547;4592.05862798129;4669.789859456333;4714.882127946795;4734.928976065362;4735.905281894377;4947.802087916479;4949.7772600233075;4950.950490495121;5007.399112106534;5014.2979982802435;5030.748462576857;5053.5957123430035;5076.111680455905;5084.110280700899;5098.082345177866;4575.313702944519;4593.517680643551;4666.65000124992;4707.152712511746;4718.197906355927;4998.050370429607;5012.573931215888;5030.3963524377305;5051.924221136685;5061.746912654353;4785;4796.232602783538;4799.256115302133;4839.588634965997;4849.321095046696;4889.731064791399;4895.902081958412;4935.481774413706;4964.2305442655725;4980.103581355391;4952.504749525018;4958.181899986534;4969.577585905238;4971.353724015855;5002.074616196015;4956.553910148032;4958.380202474691;4970.826021089245;4971.900561988812;5008.098542262428;4093.1199792044854;4113.547509773923;4136.627703506699;4139.97930010348;4227.577242275809;3682.226732386175;3683.4106542953;3758.7556808807885;3766.7551609145316;3771.132639492932;4277.144571085795;4303.483581970184;4308.80610372534;4310.051788606502;4353.4122893408985;4881.780319885614;5045.167547354646;5049.5707864831165;5050.242463630485;5092.770825312869;4202.159568086334;4211.157768446323;4244.3209086546;4246.5116511600945;4252.128313695685;4431.069475410135;4434.600885920283;4441.045175287329;4478.149151661174;4480.887977800581;4584.587387135174;4591.747453890068;4636.188666983332;4646.117237724821;4694.8591542252425;4956.10790057793;4986.12742770021;5035.748212589283;5046.545810877039;5050.267711181931;4624.699394539344;4649.442066951988;4655.906881862412;4656.4412270527755;4701.694389864648;4841.927371089366;4871.244957031666;4889.413270407574;4892.339534162842;4948.8762780930765;4941.135301322326;4963.131451995959;4997.750112494434;5013.097642424253;5014.323066385991;4875.146849301429;4875.7074575525585;4884.267359896044;4885.096257192431;4930.654854160318;4720.433547974265;4790.5448982346625;4872.123017856678;4878.512148785235;4926.482719314564;4739.218029025173;4746.9525304747895;4774.092922344744;4815.374001379798;4824.6863953842885;4867.464578896389;4868.9756551217015;4870.659053866196;4909.77905994224;4924.950750492592;4707.788149533348;4755.429348478205;4766.380370551806;4768.380110585602;4858.198397264412 18:54:42 INFO - PROCESS | 18850 | |1;ext.html;572.0418299348592;573.6644063223015;579.3800633322347;582.9446202610751;583.4457265597682;26216.737832621668;28557.286067848316;38705.80647096764;39855;40025.59974400255;39531.80234098825;39965.60034399655;40009.59990400095;40038;40051.59948400515;7761.689532418711;7896.289333959942;7904.170062143478;7906;7910.723124690637;7793.103793063785;7863.960680196591;7867.1739467355965;7872.724454644089;7873.566953817538;7836.059672839238;7851.803704907395;7871.252231038042;7886;7892.723754668587;7841.686332546691;7866.6460009299435;7867.842643147163;7882.605869706549;7897.210278972057;7762.961185194038;7842.451028428012;7849.4897831640765;7851.293383595446;7853.685852565891;37099.443508347125;37268;37407.81296093529;37517.24965500702;37590.81204593987;2754.73829986151;2771.7782577393964;2804.7475727184446;2908.6800451950267;3186.964236623107;28459;29009.7392051731;29427.411451770844;29646.851765741034;30253.546196807067;3530.523379343807;3548.503209550665;3617.5478065241846;3637.618050104754;3678.9448158277646;263190;263406;264454;265197;265327.6733616339;31069;50400.24399634008;50692.23961640579;50743;50792.74603627032;31862.08827470359;33846.15384615404;33854.32291354159;33899;33912.32175356479;11871.643850684493;11943.984761295213;11989.160758746804;11994;12012.819807702892;9478.668246611336;9533.189678877234;9535.046495350549;9536.046395360408;9538.761530961781;7878.251566101211;7891.526508409514;7932.444728869039;7962.6416811243635;7996.720114795954;3026.546018097303;3087.336222712128;3087.428825667259;3106.50295952651;3169.952450713241;847.7499137754254;947.507296205969;950.9952450237705;957.3920560444029;961.5865177973399;25225;25810.225693229233;26401;26410.207693769218;26465;937.3719607862748;976.272676855747;983.7294743945472;995.8904520502739;1017.730301470111;13501.527446539323;13897.235652039235;14143.636508442032;14178.787318190236;14280.428782848778;401091;404453;405295;405913;406543;48179.4593621731;48604.513954860704;48691;48798.756006219744;48863.755681221366;1171.3264872698232;1177.8939895409283;1179.8584169899666;1187.4953144913377;1190.2858285028913;26237.475250495267;27407.86296068507;27607.723922761317;27988.300292492037;28225;40120.59879401168;41384.58615413807;41785.582144178166;41787.7910610445;44949;361479;363118;363129;363154;363981;37455.25089498249;37639;38034.239315214094;38049;38129.428058579695;41316;41595.7920210397;41895.7905210472;42612.36081458843;42616.360754589325;35594.28811423705;36365.63634363622;36877;36893.63106368902;37101.25797483981;35962;36053.09867253339;36082.45876311805;36412.4538131923;36472.452913205794;30037.84981075168;30671.2332191697;34697.653023470455;35033.474497883064;36106.27787444289;26041.609375859;30616.540751888293;30665;32755;32884;24769.4229328004;25182.370440739127;25359.746402536475;25771;25776.61335080013 18:54:42 INFO - PROCESS | 18850 | |2;jquery.html;351.41664836371626;373.5592001438302;375.195206282524;381.48690011933945;389.36922186058587;13080.869191308084;16357.182140892952;16644.91677541612;17483.213255403505;18273;16552.50342489724;16909.492715218534;17515;17534.29862805486;17807.82192178081;5174.172132458798;6892.138482689664;7252.891206631904;7258.0927384076995;7271.0547628808445;4067.3492241241406;6865.965670171642;7086.114235720535;7216.963915180417;7226.096737907762;7075.46933979951;7210.134783825948;7354.448416368767;7358.632068396586;7367.152777430584;7320.597367144805;7321.926780732178;7332.266773322705;7344.632768361561;7347.926520734831;6640.833979150511;7083.468739844532;7086.149662040537;7087.291270872872;7089.71641134354;22836;23326.183583574664;23525.88237058804;23930.042798288046;23970.640440393407;2075.3670130610158;2101.936941891746;2165.1880544795704;2182.1489619048584;2306.97693023071;13556.254406007665;13700.862991370059;14246.857531424657;14650.340734666966;14901.180435076067;1906.74258975038;1921.2795201799324;1941.1264930781065;1981.8909959952198;2007.5382661987678;79070.60464697698;83354.58322708348;84615.57692211561;86184;87536;14329.137212162352;15302.540923772305;16187.352505899868;16627;16755.162241887858;29290;29655.85172074126;29714.257143571584;29796.553051704243;29881.252968675955;8185.3042491387705;8356.916430835614;8395.28640065589;8470.745877623682;8490.391583576955;6782.253952065269;6851.931480685229;6886.208086070166;6914.515983881181;7135.036770036082;8431.620577074047;8570.528620925908;8606.82786344282;8626.6787286895;8650.52422116777;3137.748980081588;3144.9371012580077;3265.461198902202;3301.3562355340478;3344.9331013380083;734.1777209525259;830.4145577367941;833.5957060825494;839.4375768235298;896.3098414221014;16533.83466165347;17530.561735956704;17627.82372176262;17639.823601764074;17974.91012544955;832.883396324515;849.3163003782015;849.864021756516;853.1511146409239;862.5299211929513;9473.28950328728;9642.855357169648;9735.41587504752;9859;10012.299139060196;376941;379208;379271;382188;384927;80604;84533;86763.13236867677;87490;88093.55953220192;910.7859652981545;919.0625561926797;936.8126374725082;948.5541795356172;950.0736781637847;12071.456784444545;15596.298166582757;15817.367305308118;16505.422310219084;16864.976202855247;38169.045773855876;38533.614663854125;38567.42148867825;39425.2114957705;40045.39931900966;51216.23175652294;51714.22428663648;52047.73976130095;52077.21884171665;52358.73820630873;7670.0795904491815;7737.613119344122;7761.417893658111;7794.571298578632;7848.9215107848195;11320.716982075513;11680.94159529197;11785.823212651645;11790.174687771774;12221.511139554674;10272.948635256776;10323.122534584645;10473.633422830164;10552.577896884039;10666.626668066581;9947.801043979225;10205.948970255102;10422.218333624856;10733.463326833784;10810.027097561257;10477.68566942993;10655.680329590125;10744.946275268887;10835.51240194209;10896.945515272373;7450.96274518624;7517.361024312776;7600.46796724224;7690.346320562815;7823.530588164728;8391.95804020976;10629.309094908805;10724.088452481314;10737.463126843782;10922.726931826768 18:54:42 INFO - PROCESS | 18850 | |3;mootools.html;1205.7528206717623;1240.1752834365147;1312.632462910385;1476.630842289427;1482.7331080405522;7654.387648988081;8032.759017229485;8118.91881081189;8128.91871081289;8131.268185863271;6971.6165610891385;7469.514481558695;7669.194734552875;7687.3850091992645;7999.320057795095;2180.694702741617;2216.512367279196;2219.8224142068675;2223.1107556977177;2223.188536184289;1842.8065053169357;2075.937721868346;2096.5806838632257;2106.3575609439113;2106.5681535285307;2117.95764084719;2185.4864106934856;2191.802737753602;2200.7689192634784;2201.987085940469;2204.4599073227164;2207.9558408831736;2216.6342553478657;2217.1020736601704;2226.7327920649545;2157.471419502216;2163.891805409739;2164.1559791681257;2165.6426689596196;2170.6201414752513;7757.146713861471;7806.687732490694;7809.570473623949;7813.882791758128;7818.609069546556;4467.218236808578;4475.686701930867;4481.327800829869;4488.7531185784765;4575.9771201143785;2873.7557307628877;2965.673775884651;2982.537706655472;3012.6836682148496;3016.185629879942;913.4610579757974;915.890093188815;924.8335299646061;948.042477098129;949.7957939043139;10924.180686448468;10934.179936504794;10934.289271197267;10961.177911656578;10963;4131.421600975866;4196.265653510684;4261.808218630169;4417;4417.712848664826;8680.218780309677;8749.25631321332;8793.252573531321;8827.16141966512;8838.513881736437;4696.131215725101;4712.835050773207;4715;4715.151272770934;4717.080169366941;4259.914801703949;4371.69398142127;4377.9781101094295;4378.540253273424;4390.100029493946;3360.647132051148;3419.6238413774463;3460.3079384123275;3466.3933811582874;3494.0915362005553;972.8540718892223;1001.689476262361;1014.3204053284318;1016.6289304403839;1046.0951277145366;666.3503084492678;698.2877464985787;724.5145752345835;738.117949050879;740.7703611880335;4820.156472617348;5083.61872859537;5215.452377500384;5311;5331.306930099062;887.3744010472601;899.7390756680489;933.4632586262926;961.8982523186859;975.687779910436;3489.267253876714;3664.798436086041;3722.622629627001;3755.7183211259266;3811.4663947047434;9590.232781377612;9895.406275623485;9904.55429505674;9905.405675659484;9990.150837178775;8729.170728780755;9326.440413575072;9873.308868379145;9898.356606820533;9914.107730304308;7366.00558924549;7555.357794587411;7560.886586701094;7577;7579.393648508106;5512.3660779010925;5628.690422026828;5660.603757736919;5728.396049106257;5842.298924129132;9196.356255062348;9335.159835614828;9346.485943273185;9349.298802589698;9351.48566828831;9121.361504694607;9260.53697315118;9596.472194029395;9603.759906002406;9603.90396096058;6328;6353.428191462791;6454.354564543508;6481.930481470505;6526.021096835512;7339.9633001834645;7348.301911318416;7353.338199561851;7360.668769905475;7392.223816499405;6659.101021362054;6782.626955517494;6806.523543351917;6872.484563657646;6889.689963951534;6617.569857959217;6673.733050678113;6726.899096513458;6733.494987875831;6795.660216989229;6088.695565221809;6121.938780612137;6152.661603611844;6160.075988601746;6218.751249950133;4427;4464.55354464551;4477.8208871646075;4574.245249533789;4575.450945886515;4587.8623641290815;4613.723176609415;4616.399868017136;4651;4679.836205732783 18:54:42 INFO - PROCESS | 18850 | |4;prototype.html;304.4003313472459;304.8216793175992;311.70543836074916;312.0264773905416;312.13538498359554;4761.333413322138;4768.403949506303;4792.976035119824;4794.256890182019;4821.300911367854;4723.102610504002;4740.525947405266;4745.549172828576;4749.073930583538;4782.497837727041;3590.138366791971;3698.6671199592033;3709.962900370989;3806.0865392305786;3866;3787.6780473659633;3792.317382871082;3810.428435734634;3829.965909204513;3861.7296789224765;3605.719969410861;3754.1177823211524;3781.1303400217967;3781.2815565042556;3810.161764411825;3607.891763247094;3723.5717892442176;3725.869594564177;3732.6267373262726;3761.3981762918074;3294.1435226840954;3298.835058247078;3327.351166522529;3328.118048717092;3336.215989242526;4670.758036142636;4683.601893839028;4683.658170914543;4683.765811709401;4689.226277664181;4171.311733563989;4202.621764041221;4269.978650106761;4278.935815962763;4288.721233119868;4959.851204463872;4979.950200497985;4989.55094041538;4994.202087248587;5009.398872135331;3631.092226943264;3642.7250462338234;3649.4525821126776;3649.4708267301094;3649.872254471107;4986.925196122061;5192.910218420034;5224.387806096952;5233.816816411408;5236.162214045772;3654.0499470137956;3668.8899333019517;3698.3158115748674;3704.6665800077585;3709.27669104522;3724.8137593120236;3757.5866654667966;3770.4155855842387;3775.414810704345;3782;4267.039916018933;4271.3592961055465;4272.97448612337;4276.379924910871;4282.550332215073;4758.833440829554;4923.384576927884;4932.827351042696;4954.628402869727;5004.249362595567;1299.6685845109437;1312.4881296294452;1313.3236383262627;1322.484231149833;1322.8478724946754;842.9757844219181;853.7438768369465;874.2219424712011;908.169025341818;910.3809409601403;4347.456567929009;4360.389545463638;4365.126974605028;4371.890702732457;4377.737335759864;5081.662435279813;5089.923651145235;5096.311997880312;5099.4390617032095;5182.97408512955;4216.978915105405;4334.219840428753;4336.479622445327;4355.891102722394;4386;2740.739629735172;2752.8575641108714;2762.378464845434;2766.5988431677292;2771.182501162162;4720.858374248778;4806.279058141306;4806.639502037361;4816.229403295526;4818.68678535894;5028.874278143076;5208.583313334924;5273.813391986772;5283.709395983181;5284.81503147388;4772.284157376422;4783.976080119647;4786.353842231254;4796.904061918812;4805.7985503624095;5109.386873575195;5117.5394214520875;5122.103631864484;5135.6874815742885;5136.9743151284;4905.558499735041;4980.950190498049;5027.522385373383;5164.3802743671;5171.3535808024;4867.90264194707;4905.435874874435;4907.141250281258;4912.975435122801;4918.213085906238;3714.888553343404;3720.8139593020783;3725.515682961198;3727.4781530586283;3734.831932562987;5107.208382700687;5252.842414727565;5265.736713164403;5270.8945821084135;5287.4976877196605;5060.6842221023535;5076.284187959424;5093.770780314969;5096.923546146737;5098.705582487821;5078.746062696777;5079.136546786981;5123.948760512496;5127;5127.230915362726;4874.2201247800185;5000.349954505891;5013.222950442687;5059.822906198266;5102.285680004728;4851.80592776285;4955;5067.592893375617;5103.413107492686;5110.112786275742;4994.925076123934;4996.251312040757;4997.101681024924;5007.84976450707;5009.5491405773655 18:54:42 INFO - PROCESS | 18850 | |5;yui.html;546.6556069676103;591.3111225422382;600.1238192239327;650.1058658634776;677.8712044711505;11314.151438642104;11684.941575292112;12109.27344359339;12118.151729378947;12118.394080295982;11772.941135294312;11913.642590722271;11932.70168245792;11951.043916486682;11954.222975506585;614.5390956782413;743.4981387563373;749.321863713339;766.1419210484265;768.7424712721245;766.4404984361391;766.4558163703776;768.2509553185628;768.69636493585;771.2827070824131;812.9065157506903;816.0819078536646;816.4285000499644;816.6365967144623;816.8693009118542;632.7152781248434;784.1335324466496;798.7483942558134;802.2498963469117;809.6599428240153;581.8429024163495;582.2576215325452;582.6125626458401;582.8164128299572;582.8746819433842;11825.231359961575;11881.94059029708;11884.702882427922;11887.643370698894;11902.642920712393;12620.116591838574;13159.473621055145;13261.535846245431;13266.336683165802;13372.130811497222;8962.891062495346;9383.296252781;9598.376105553116;9610.471424071673;9920.851187232198;4120.464339635858;4146.3158578834455;4228.936565951513;4250.851220207278;4366.541513141106;62436.37563624397;62440.68779656118;63124.68437657828;63417.68291158561;63604.68197658982;10231.846522302172;10290.588376465008;10416.739581510523;10514.316569422963;10605.893941060645;17760.55598610045;17790.55523611894;17856.910715446338;17907.910460447616;18417.907910460362;6303.968480157661;6392.264889537762;6474.773382931669;6564.80305590833;6641.833954151185;3449;3455.930881382358;3515.5605549306338;3538.9469157962653;3638.3450978824067;2709.9322516937236;2791.553351463756;2795.4688609164195;2798.8320700758018;2812.3250419899487;474.4875534422815;475.431858928577;484.8739327774804;491.8204855227888;491.8942427378131;507.72329080651133;517.1647788821027;518.7821115131654;536.2224774077603;547.7179252684871;7381.446391520657;7388.187299397062;7568.659410326439;7671.34793542544;7758.456908016385;432.362265658158;522.1280461629088;522.9973850130725;547.5209191957038;553.8643032457073;3503.1242189452637;3588.5334906461994;3737.3459644562636;3785.0348161218712;3935.7244992850797;56947.14579281314;79200.60399697964;81145.59427202826;81922.18077819145;96506;81999.18000819915;82062.58968705118;82323.29797126335;82376;83518.58240708758;45828.3125753114;57473.71263143741;70809;73940;74903.62548187224;8775.297976162019;8845.159709827556;9144.908550914672;9186;9402.764930876783;31579.684203158595;39333.40999884947;39624.811255662375;42410.93972650709;45107.77446112748;40716.59283407128;54675.45324546703;55442;57311;58463.70768146132;11101.333919964827;11155.330680159217;11199.440027998731;11202.719932001764;11605.6518304451;12222.083343749076;12752.107352485236;12965.286909219707;13468.393922273326;13610.727785444433;12254.264744115382;12348;12475.625731228078;12605.87394126047;13232.735345292847;11396.829047564459;11718.589849355232;12099.395030248628;12130.953388038195;12340.568080117153;10598.31110977784;10639.14886809069;10761.892381076403;11010.449477526252;11029;9930.314451702978;10272.531448819787;10474.371537707762;10567.52446139941;10599.947000264949;9697.6605818796;10296.382217067;10448.843267350843;10474.947625261824;10520.736981575521 18:54:42 INFO - PROCESS | 18850 | __end_tp_report 18:54:42 INFO - PROCESS | 18850 | __start_cc_report 18:54:42 INFO - PROCESS | 18850 | _x_x_mozilla_cycle_collect,955 18:54:42 INFO - PROCESS | 18850 | __end_cc_report 18:54:42 INFO - PROCESS | 18850 | __startTimestamp1467942882017__endTimestamp 18:54:42 INFO - PROCESS | 18850 | 18:54:42 INFO - PROCESS | 18850 | ------- Summary: start ------- 18:54:42 INFO - PROCESS | 18850 | Number of tests: 6 18:54:42 INFO - PROCESS | 18850 | 18:54:42 INFO - PROCESS | 18850 | [#0] dojo.html Cycles:165 Average:4597.81 Median:4714.88 stddev:482.51 (10.2%) stddev-sans-first:456.55 18:54:42 INFO - PROCESS | 18850 | Values: 2553.3 2563.1 2589.7 2598.3 2603.2 4589.8 4594.1 4602.9 4619.4 4676.6 4619.3 4638.5 4666.0 4676.4 4693.3 4247.4 4259.7 4259.9 4271.0 4392.0 4305.4 4349.8 4391.6 4398.6 4399.3 4216.6 4333.3 4358.0 4377.3 4381.8 4242.6 4248.2 4262.8 4266.2 4268.2 4212.3 4278.1 4286.5 4286.6 4336.1 4592.1 4669.8 4714.9 4734.9 4735.9 4947.8 4949.8 4951.0 5007.4 5014.3 5030.7 5053.6 5076.1 5084.1 5098.1 4575.3 4593.5 4666.7 4707.2 4718.2 4998.1 5012.6 5030.4 5051.9 5061.7 4785.0 4796.2 4799.3 4839.6 4849.3 4889.7 4895.9 4935.5 4964.2 4980.1 4952.5 4958.2 4969.6 4971.4 5002.1 4956.6 4958.4 4970.8 4971.9 5008.1 4093.1 4113.5 4136.6 4140.0 4227.6 3682.2 3683.4 3758.8 3766.8 3771.1 4277.1 4303.5 4308.8 4310.1 4353.4 4881.8 5045.2 5049.6 5050.2 5092.8 4202.2 4211.2 4244.3 4246.5 4252.1 4431.1 4434.6 4441.0 4478.1 4480.9 4584.6 4591.7 4636.2 4646.1 4694.9 4956.1 4986.1 5035.7 5046.5 5050.3 4624.7 4649.4 4655.9 4656.4 4701.7 4841.9 4871.2 4889.4 4892.3 4948.9 4941.1 4963.1 4997.8 5013.1 5014.3 4875.1 4875.7 4884.3 4885.1 4930.7 4720.4 4790.5 4872.1 4878.5 4926.5 4739.2 4747.0 4774.1 4815.4 4824.7 4867.5 4869.0 4870.7 4909.8 4925.0 4707.8 4755.4 4766.4 4768.4 4858.2 18:54:42 INFO - PROCESS | 18850 | 18:54:42 INFO - PROCESS | 18850 | [#1] ext.html Cycles:180 Average:48209.99 Median:37337.91 stddev:92317.11 (247.2%) stddev-sans-first:92506.79 18:54:42 INFO - PROCESS | 18850 | Values: 572.0 573.7 579.4 582.9 583.4 26216.7 28557.3 38705.8 39855.0 40025.6 39531.8 39965.6 40009.6 40038.0 40051.6 7761.7 7896.3 7904.2 7906.0 7910.7 7793.1 7864.0 7867.2 7872.7 7873.6 7836.1 7851.8 7871.3 7886.0 7892.7 7841.7 7866.6 7867.8 7882.6 7897.2 7763.0 7842.5 7849.5 7851.3 7853.7 37099.4 37268.0 37407.8 37517.2 37590.8 2754.7 2771.8 2804.7 2908.7 3187.0 28459.0 29009.7 29427.4 29646.9 30253.5 3530.5 3548.5 3617.5 3637.6 3678.9 263190.0 263406.0 264454.0 265197.0 265327.7 31069.0 50400.2 50692.2 50743.0 50792.7 31862.1 33846.2 33854.3 33899.0 33912.3 11871.6 11944.0 11989.2 11994.0 12012.8 9478.7 9533.2 9535.0 9536.0 9538.8 7878.3 7891.5 7932.4 7962.6 7996.7 3026.5 3087.3 3087.4 3106.5 3170.0 847.7 947.5 951.0 957.4 961.6 25225.0 25810.2 26401.0 26410.2 26465.0 937.4 976.3 983.7 995.9 1017.7 13501.5 13897.2 14143.6 14178.8 14280.4 401091.0 404453.0 405295.0 405913.0 406543.0 48179.5 48604.5 48691.0 48798.8 48863.8 1171.3 1177.9 1179.9 1187.5 1190.3 26237.5 27407.9 27607.7 27988.3 28225.0 40120.6 41384.6 41785.6 41787.8 44949.0 361479.0 363118.0 363129.0 363154.0 363981.0 37455.3 37639.0 38034.2 38049.0 38129.4 41316.0 41595.8 41895.8 42612.4 42616.4 35594.3 36365.6 36877.0 36893.6 37101.3 35962.0 36053.1 36082.5 36412.5 36472.5 30037.8 30671.2 34697.7 35033.5 36106.3 26041.6 30616.5 30665.0 32755.0 32884.0 24769.4 25182.4 25359.7 25771.0 25776.6 18:54:42 INFO - PROCESS | 18850 | 18:54:42 INFO - PROCESS | 18850 | [#2] jquery.html Cycles:180 Average:26070.38 Median:19478.40 stddev:63244.05 (324.7%) stddev-sans-first:63391.99 18:54:42 INFO - PROCESS | 18850 | Values: 351.4 373.6 375.2 381.5 389.4 13080.9 16357.2 16644.9 17483.2 18273.0 16552.5 16909.5 17515.0 17534.3 17807.8 5174.2 6892.1 7252.9 7258.1 7271.1 4067.3 6866.0 7086.1 7217.0 7226.1 7075.5 7210.1 7354.4 7358.6 7367.2 7320.6 7321.9 7332.3 7344.6 7347.9 6640.8 7083.5 7086.1 7087.3 7089.7 22836.0 23326.2 23525.9 23930.0 23970.6 2075.4 2101.9 2165.2 2182.1 2307.0 13556.3 13700.9 14246.9 14650.3 14901.2 1906.7 1921.3 1941.1 1981.9 2007.5 79070.6 83354.6 84615.6 86184.0 87536.0 14329.1 15302.5 16187.4 16627.0 16755.2 29290.0 29655.9 29714.3 29796.6 29881.3 8185.3 8356.9 8395.3 8470.7 8490.4 6782.3 6851.9 6886.2 6914.5 7135.0 8431.6 8570.5 8606.8 8626.7 8650.5 3137.7 3144.9 3265.5 3301.4 3344.9 734.2 830.4 833.6 839.4 896.3 16533.8 17530.6 17627.8 17639.8 17974.9 832.9 849.3 849.9 853.2 862.5 9473.3 9642.9 9735.4 9859.0 10012.3 376941.0 379208.0 379271.0 382188.0 384927.0 80604.0 84533.0 86763.1 87490.0 88093.6 910.8 919.1 936.8 948.6 950.1 12071.5 15596.3 15817.4 16505.4 16865.0 38169.0 38533.6 38567.4 39425.2 40045.4 51216.2 51714.2 52047.7 52077.2 52358.7 7670.1 7737.6 7761.4 7794.6 7848.9 11320.7 11680.9 11785.8 11790.2 12221.5 10272.9 10323.1 10473.6 10552.6 10666.6 9947.8 10205.9 10422.2 10733.5 10810.0 10477.7 10655.7 10744.9 10835.5 10896.9 7451.0 7517.4 7600.5 7690.3 7823.5 8392.0 10629.3 10724.1 10737.5 10922.7 18:54:42 INFO - PROCESS | 18850 | 18:54:42 INFO - PROCESS | 18850 | [#3] mootools.html Cycles:180 Average:5163.45 Median:5644.65 stddev:2934.01 (52.0%) stddev-sans-first:2927.16 18:54:42 INFO - PROCESS | 18850 | Values: 1205.8 1240.2 1312.6 1476.6 1482.7 7654.4 8032.8 8118.9 8128.9 8131.3 6971.6 7469.5 7669.2 7687.4 7999.3 2180.7 2216.5 2219.8 2223.1 2223.2 1842.8 2075.9 2096.6 2106.4 2106.6 2118.0 2185.5 2191.8 2200.8 2202.0 2204.5 2208.0 2216.6 2217.1 2226.7 2157.5 2163.9 2164.2 2165.6 2170.6 7757.1 7806.7 7809.6 7813.9 7818.6 4467.2 4475.7 4481.3 4488.8 4576.0 2873.8 2965.7 2982.5 3012.7 3016.2 913.5 915.9 924.8 948.0 949.8 10924.2 10934.2 10934.3 10961.2 10963.0 4131.4 4196.3 4261.8 4417.0 4417.7 8680.2 8749.3 8793.3 8827.2 8838.5 4696.1 4712.8 4715.0 4715.2 4717.1 4259.9 4371.7 4378.0 4378.5 4390.1 3360.6 3419.6 3460.3 3466.4 3494.1 972.9 1001.7 1014.3 1016.6 1046.1 666.4 698.3 724.5 738.1 740.8 4820.2 5083.6 5215.5 5311.0 5331.3 887.4 899.7 933.5 961.9 975.7 3489.3 3664.8 3722.6 3755.7 3811.5 9590.2 9895.4 9904.6 9905.4 9990.2 8729.2 9326.4 9873.3 9898.4 9914.1 7366.0 7555.4 7560.9 7577.0 7579.4 5512.4 5628.7 5660.6 5728.4 5842.3 9196.4 9335.2 9346.5 9349.3 9351.5 9121.4 9260.5 9596.5 9603.8 9603.9 6328.0 6353.4 6454.4 6481.9 6526.0 7340.0 7348.3 7353.3 7360.7 7392.2 6659.1 6782.6 6806.5 6872.5 6889.7 6617.6 6673.7 6726.9 6733.5 6795.7 6088.7 6121.9 6152.7 6160.1 6218.8 4427.0 4464.6 4477.8 4574.2 4575.5 4587.9 4613.7 4616.4 4651.0 4679.8 18:54:42 INFO - PROCESS | 18850 | 18:54:42 INFO - PROCESS | 18850 | [#4] prototype.html Cycles:180 Average:4176.30 Median:4760.08 stddev:1199.56 (25.2%) stddev-sans-first:1167.19 18:54:42 INFO - PROCESS | 18850 | Values: 304.4 304.8 311.7 312.0 312.1 4761.3 4768.4 4793.0 4794.3 4821.3 4723.1 4740.5 4745.5 4749.1 4782.5 3590.1 3698.7 3710.0 3806.1 3866.0 3787.7 3792.3 3810.4 3830.0 3861.7 3605.7 3754.1 3781.1 3781.3 3810.2 3607.9 3723.6 3725.9 3732.6 3761.4 3294.1 3298.8 3327.4 3328.1 3336.2 4670.8 4683.6 4683.7 4683.8 4689.2 4171.3 4202.6 4270.0 4278.9 4288.7 4959.9 4980.0 4989.6 4994.2 5009.4 3631.1 3642.7 3649.5 3649.5 3649.9 4986.9 5192.9 5224.4 5233.8 5236.2 3654.0 3668.9 3698.3 3704.7 3709.3 3724.8 3757.6 3770.4 3775.4 3782.0 4267.0 4271.4 4273.0 4276.4 4282.6 4758.8 4923.4 4932.8 4954.6 5004.2 1299.7 1312.5 1313.3 1322.5 1322.8 843.0 853.7 874.2 908.2 910.4 4347.5 4360.4 4365.1 4371.9 4377.7 5081.7 5089.9 5096.3 5099.4 5183.0 4217.0 4334.2 4336.5 4355.9 4386.0 2740.7 2752.9 2762.4 2766.6 2771.2 4720.9 4806.3 4806.6 4816.2 4818.7 5028.9 5208.6 5273.8 5283.7 5284.8 4772.3 4784.0 4786.4 4796.9 4805.8 5109.4 5117.5 5122.1 5135.7 5137.0 4905.6 4981.0 5027.5 5164.4 5171.4 4867.9 4905.4 4907.1 4913.0 4918.2 3714.9 3720.8 3725.5 3727.5 3734.8 5107.2 5252.8 5265.7 5270.9 5287.5 5060.7 5076.3 5093.8 5096.9 5098.7 5078.7 5079.1 5123.9 5127.0 5127.2 4874.2 5000.3 5013.2 5059.8 5102.3 4851.8 4955.0 5067.6 5103.4 5110.1 4994.9 4996.3 4997.1 5007.8 5009.5 18:54:42 INFO - PROCESS | 18850 | 18:54:42 INFO - PROCESS | 18850 | [#5] yui.html Cycles:180 Average:16448.42 Median:23151.40 stddev:22738.03 (98.2%) stddev-sans-first:22770.47 18:54:42 INFO - PROCESS | 18850 | Values: 546.7 591.3 600.1 650.1 677.9 11314.2 11684.9 12109.3 12118.2 12118.4 11772.9 11913.6 11932.7 11951.0 11954.2 614.5 743.5 749.3 766.1 768.7 766.4 766.5 768.3 768.7 771.3 812.9 816.1 816.4 816.6 816.9 632.7 784.1 798.7 802.2 809.7 581.8 582.3 582.6 582.8 582.9 11825.2 11881.9 11884.7 11887.6 11902.6 12620.1 13159.5 13261.5 13266.3 13372.1 8962.9 9383.3 9598.4 9610.5 9920.9 4120.5 4146.3 4228.9 4250.9 4366.5 62436.4 62440.7 63124.7 63417.7 63604.7 10231.8 10290.6 10416.7 10514.3 10605.9 17760.6 17790.6 17856.9 17907.9 18417.9 6304.0 6392.3 6474.8 6564.8 6641.8 3449.0 3455.9 3515.6 3538.9 3638.3 2709.9 2791.6 2795.5 2798.8 2812.3 474.5 475.4 484.9 491.8 491.9 507.7 517.2 518.8 536.2 547.7 7381.4 7388.2 7568.7 7671.3 7758.5 432.4 522.1 523.0 547.5 553.9 3503.1 3588.5 3737.3 3785.0 3935.7 56947.1 79200.6 81145.6 81922.2 96506.0 81999.2 82062.6 82323.3 82376.0 83518.6 45828.3 57473.7 70809.0 73940.0 74903.6 8775.3 8845.2 9144.9 9186.0 9402.8 31579.7 39333.4 39624.8 42410.9 45107.8 40716.6 54675.5 55442.0 57311.0 58463.7 11101.3 11155.3 11199.4 11202.7 11605.7 12222.1 12752.1 12965.3 13468.4 13610.7 12254.3 12348.0 12475.6 12605.9 13232.7 11396.8 11718.6 12099.4 12131.0 12340.6 10598.3 10639.1 10761.9 11010.4 11029.0 9930.3 10272.5 10474.4 10567.5 10599.9 9697.7 10296.4 10448.8 10474.9 10520.7 18:54:42 INFO - PROCESS | 18850 | -------- Summary: end -------- 18:54:42 INFO - PROCESS | 18850 | 18:54:42 INFO - TEST-INFO | 18850: exit 0 18:54:42 INFO - TEST-OK | dromaeo_css | took 1119709ms 18:54:42 INFO - TEST-START | kraken 18:54:42 INFO - operating with platform_type : linux_ 18:54:42 INFO - Initialising browser for kraken test... 18:54:42 INFO - TEST-INFO | started process 19039 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp_SA4q/profile http://localhost:53767/getInfo.html) 18:54:47 INFO - PROCESS | 19039 | __metrics Screen width/height:1600/1200 18:54:47 INFO - PROCESS | 19039 | colorDepth:24 18:54:47 INFO - PROCESS | 19039 | Browser inner width/height: 1024/697 18:54:47 INFO - PROCESS | 19039 | __metrics 18:54:48 INFO - PROCESS | 19039 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:54:49 INFO - TEST-INFO | 19039: exit 0 18:54:49 INFO - Browser initialized. 18:54:49 INFO - Running cycle 1/1 for kraken test... 18:54:49 INFO - TEST-INFO | started process 19121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpp_SA4q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:55:01 INFO - PROCESS | 19121 | RSS: Main: 158437376 18:55:01 INFO - PROCESS | 19121 | 18:55:04 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53767/tests/kraken/driver.html?testName=audio-beat-detection) 18:55:04 INFO - PROCESS | 19121 | RSS: Main: 216768512 18:55:04 INFO - PROCESS | 19121 | 18:55:07 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53767/tests/kraken/driver.html?testName=audio-dft) 18:55:08 INFO - PROCESS | 19121 | RSS: Main: 201965568 18:55:08 INFO - PROCESS | 19121 | 18:55:11 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53767/tests/kraken/driver.html?testName=audio-fft) 18:55:12 INFO - PROCESS | 19121 | RSS: Main: 271044608 18:55:12 INFO - PROCESS | 19121 | 18:55:14 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53767/tests/kraken/driver.html?testName=audio-oscillator) 18:55:15 INFO - PROCESS | 19121 | RSS: Main: 181739520 18:55:15 INFO - PROCESS | 19121 | 18:55:17 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53767/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:55:17 INFO - PROCESS | 19121 | RSS: Main: 185585664 18:55:17 INFO - PROCESS | 19121 | 18:55:21 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53767/tests/kraken/driver.html?testName=imaging-darkroom) 18:55:21 INFO - PROCESS | 19121 | RSS: Main: 221470720 18:55:21 INFO - PROCESS | 19121 | 18:55:25 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53767/tests/kraken/driver.html?testName=imaging-desaturate) 18:55:25 INFO - PROCESS | 19121 | RSS: Main: 221589504 18:55:25 INFO - PROCESS | 19121 | 18:55:28 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53767/tests/kraken/driver.html?testName=json-parse-financial) 18:55:29 INFO - PROCESS | 19121 | RSS: Main: 222437376 18:55:29 INFO - PROCESS | 19121 | 18:55:31 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53767/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:55:31 INFO - PROCESS | 19121 | RSS: Main: 210329600 18:55:31 INFO - PROCESS | 19121 | 18:55:33 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53767/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:55:34 INFO - PROCESS | 19121 | RSS: Main: 214188032 18:55:34 INFO - PROCESS | 19121 | 18:55:36 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53767/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:55:36 INFO - PROCESS | 19121 | RSS: Main: 212967424 18:55:36 INFO - PROCESS | 19121 | 18:55:39 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:55:40 INFO - PROCESS | 19121 | RSS: Main: 224247808 18:55:40 INFO - PROCESS | 19121 | 18:55:43 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:55:43 INFO - PROCESS | 19121 | RSS: Main: 226070528 18:55:43 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | Cycle 1(1): loaded http://localhost:53767/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53767/tests/kraken/driver.html?testName=ai-astar) 18:55:45 INFO - PROCESS | 19121 | RSS: Main: 268525568 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | __start_tp_report 18:55:45 INFO - PROCESS | 19121 | _x_x_mozilla_page_load 18:55:45 INFO - PROCESS | 19121 | _x_x_mozilla_page_load_details 18:55:45 INFO - PROCESS | 19121 | |i|pagename|runs| 18:55:45 INFO - PROCESS | 19121 | |0;ai-astar;103;113;113;114;113;113;113;112;112;113 18:55:45 INFO - PROCESS | 19121 | |1;audio-beat-detection;145;124;123;177;123;131;156;129;153;123 18:55:45 INFO - PROCESS | 19121 | |2;audio-dft;163;161;160;161;163;162;161;161;161;163 18:55:45 INFO - PROCESS | 19121 | |3;audio-fft;76;77;77;111;78;76;76;76;105;77 18:55:45 INFO - PROCESS | 19121 | |4;audio-oscillator;85;85;125;87;86;86;121;85;85;144 18:55:45 INFO - PROCESS | 19121 | |5;imaging-gaussian-blur;116;117;116;117;116;117;117;117;118;117 18:55:45 INFO - PROCESS | 19121 | |6;imaging-darkroom;146;147;147;146;146;146;147;147;146;147 18:55:45 INFO - PROCESS | 19121 | |7;imaging-desaturate;94;94;95;95;95;95;96;96;95;95 18:55:45 INFO - PROCESS | 19121 | |8;json-parse-financial;65;68;65;64;64;65;64;65;65;64 18:55:45 INFO - PROCESS | 19121 | |9;json-stringify-tinderbox;65;65;65;65;64;64;64;65;65;65 18:55:45 INFO - PROCESS | 19121 | |10;stanford-crypto-aes;79;80;84;79;78;79;79;79;78;83 18:55:45 INFO - PROCESS | 19121 | |11;stanford-crypto-ccm;128;139;124;127;139;126;126;128;175;143 18:55:45 INFO - PROCESS | 19121 | |12;stanford-crypto-pbkdf2;172;166;164;164;165;164;163;167;165;166 18:55:45 INFO - PROCESS | 19121 | |13;stanford-crypto-sha256-iterative;66;66;66;74;66;65;66;67;65;66 18:55:45 INFO - PROCESS | 19121 | __end_tp_report 18:55:45 INFO - PROCESS | 19121 | __start_cc_report 18:55:45 INFO - PROCESS | 19121 | _x_x_mozilla_cycle_collect,1920 18:55:45 INFO - PROCESS | 19121 | __end_cc_report 18:55:45 INFO - PROCESS | 19121 | __startTimestamp1467942945741__endTimestamp 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | ------- Summary: start ------- 18:55:45 INFO - PROCESS | 19121 | Number of tests: 14 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#0] ai-astar Cycles:10 Average:111.90 Median:113.00 stddev:3.18 (2.8%) stddev-sans-first:0.60 18:55:45 INFO - PROCESS | 19121 | Values: 103.0 113.0 113.0 114.0 113.0 113.0 113.0 112.0 112.0 113.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#1] audio-beat-detection Cycles:10 Average:138.40 Median:138.00 stddev:18.61 (13.5%) stddev-sans-first:19.59 18:55:45 INFO - PROCESS | 19121 | Values: 145.0 124.0 123.0 177.0 123.0 131.0 156.0 129.0 153.0 123.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.07 (0.7%) stddev-sans-first:1.01 18:55:45 INFO - PROCESS | 19121 | Values: 163.0 161.0 160.0 161.0 163.0 162.0 161.0 161.0 161.0 163.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#3] audio-fft Cycles:10 Average:82.90 Median:76.50 stddev:13.32 (17.4%) stddev-sans-first:13.89 18:55:45 INFO - PROCESS | 19121 | Values: 76.0 77.0 77.0 111.0 78.0 76.0 76.0 76.0 105.0 77.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#4] audio-oscillator Cycles:10 Average:98.90 Median:85.00 stddev:22.24 (26.2%) stddev-sans-first:23.01 18:55:45 INFO - PROCESS | 19121 | Values: 85.0 85.0 125.0 87.0 86.0 86.0 121.0 85.0 85.0 144.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 18:55:45 INFO - PROCESS | 19121 | Values: 116.0 117.0 116.0 117.0 116.0 117.0 117.0 117.0 118.0 117.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 18:55:45 INFO - PROCESS | 19121 | Values: 146.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.60 18:55:45 INFO - PROCESS | 19121 | Values: 94.0 94.0 95.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:65.00 stddev:1.20 (1.8%) stddev-sans-first:1.27 18:55:45 INFO - PROCESS | 19121 | Values: 65.0 68.0 65.0 64.0 64.0 65.0 64.0 65.0 65.0 64.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#9] json-stringify-tinderbox Cycles:10 Average:64.70 Median:65.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 18:55:45 INFO - PROCESS | 19121 | Values: 65.0 65.0 65.0 65.0 64.0 64.0 64.0 65.0 65.0 65.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.00 stddev:2.04 (2.6%) stddev-sans-first:2.15 18:55:45 INFO - PROCESS | 19121 | Values: 79.0 80.0 84.0 79.0 78.0 79.0 79.0 79.0 78.0 83.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#11] stanford-crypto-ccm Cycles:10 Average:135.50 Median:133.50 stddev:15.41 (11.5%) stddev-sans-first:16.11 18:55:45 INFO - PROCESS | 19121 | Values: 128.0 139.0 124.0 127.0 139.0 126.0 126.0 128.0 175.0 143.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.60 Median:165.50 stddev:2.55 (1.5%) stddev-sans-first:1.27 18:55:45 INFO - PROCESS | 19121 | Values: 172.0 166.0 164.0 164.0 165.0 164.0 163.0 167.0 165.0 166.0 18:55:45 INFO - PROCESS | 19121 | 18:55:45 INFO - PROCESS | 19121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:66.00 stddev:2.63 (4.0%) stddev-sans-first:2.77 18:55:45 INFO - PROCESS | 19121 | Values: 66.0 66.0 66.0 74.0 66.0 65.0 66.0 67.0 65.0 66.0 18:55:45 INFO - PROCESS | 19121 | -------- Summary: end -------- 18:55:45 INFO - PROCESS | 19121 | 18:55:46 INFO - TEST-INFO | 19121: exit 0 18:55:47 INFO - TEST-OK | kraken | took 64082ms 18:55:47 INFO - SUITE-END | took 1183s 18:55:47 INFO - Completed test suite (00:19:44) 18:55:47 INFO - javascript benchmark 18:55:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2553.310606136342, 2563.1029139801067, 2589.689237291524, 2598.3374239568907, 2603.1799983005353, 4589.8164073437065, 4594.127115847987, 4602.907941841166, 4619.445666520018, 4676.602488788457, 4619.2609182530805, 4638.536146385368, 4666.043461090477, 4676.438827340716, 4693.296005599162, 4247.426597409341, 4259.70182087254, 4259.893502662443, 4271.039016221349, 4392.033752574429, 4305.440292761937, 4349.847755328564, 4391.604755571998, 4398.64810815134, 4399.340098985162, 4216.64158546524, 4333.306670932667, 4358.0, 4377.321515165155, 4381.78091095444, 4242.554531774181, 4248.192843359751, 4262.7655478948645, 4266.210751011073, 4268.210381079511, 4212.304969679999, 4278.058827058042, 4286.485621725382, 4286.61420472159, 4336.089421221547, 4592.05862798129, 4669.789859456333, 4714.882127946795, 4734.928976065362, 4735.905281894377, 4947.802087916479, 4949.7772600233075, 4950.950490495121, 5007.399112106534, 5014.2979982802435, 5030.748462576857, 5053.5957123430035, 5076.111680455905, 5084.110280700899, 5098.082345177866, 4575.313702944519, 4593.517680643551, 4666.65000124992, 4707.152712511746, 4718.197906355927, 4998.050370429607, 5012.573931215888, 5030.3963524377305, 5051.924221136685, 5061.746912654353, 4785.0, 4796.232602783538, 4799.256115302133, 4839.588634965997, 4849.321095046696, 4889.731064791399, 4895.902081958412, 4935.481774413706, 4964.2305442655725, 4980.103581355391, 4952.504749525018, 4958.181899986534, 4969.577585905238, 4971.353724015855, 5002.074616196015, 4956.553910148032, 4958.380202474691, 4970.826021089245, 4971.900561988812, 5008.098542262428, 4093.1199792044854, 4113.547509773923, 4136.627703506699, 4139.97930010348, 4227.577242275809, 3682.226732386175, 3683.4106542953, 3758.7556808807885, 3766.7551609145316, 3771.132639492932, 4277.144571085795, 4303.483581970184, 4308.80610372534, 4310.051788606502, 4353.4122893408985, 4881.780319885614, 5045.167547354646, 5049.5707864831165, 5050.242463630485, 5092.770825312869, 4202.159568086334, 4211.157768446323, 4244.3209086546, 4246.5116511600945, 4252.128313695685, 4431.069475410135, 4434.600885920283, 4441.045175287329, 4478.149151661174, 4480.887977800581, 4584.587387135174, 4591.747453890068, 4636.188666983332, 4646.117237724821, 4694.8591542252425, 4956.10790057793, 4986.12742770021, 5035.748212589283, 5046.545810877039, 5050.267711181931, 4624.699394539344, 4649.442066951988, 4655.906881862412, 4656.4412270527755, 4701.694389864648, 4841.927371089366, 4871.244957031666, 4889.413270407574, 4892.339534162842, 4948.8762780930765, 4941.135301322326, 4963.131451995959, 4997.750112494434, 5013.097642424253, 5014.323066385991, 4875.146849301429, 4875.7074575525585, 4884.267359896044, 4885.096257192431, 4930.654854160318, 4720.433547974265, 4790.5448982346625, 4872.123017856678, 4878.512148785235, 4926.482719314564, 4739.218029025173, 4746.9525304747895, 4774.092922344744, 4815.374001379798, 4824.6863953842885, 4867.464578896389, 4868.9756551217015, 4870.659053866196, 4909.77905994224, 4924.950750492592, 4707.788149533348, 4755.429348478205, 4766.380370551806, 4768.380110585602, 4858.198397264412], "value": 4566.796328919942, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.0418299348592, 573.6644063223015, 579.3800633322347, 582.9446202610751, 583.4457265597682, 26216.737832621668, 28557.286067848316, 38705.80647096764, 39855.0, 40025.59974400255, 39531.80234098825, 39965.60034399655, 40009.59990400095, 40038.0, 40051.59948400515, 7761.689532418711, 7896.289333959942, 7904.170062143478, 7906.0, 7910.723124690637, 7793.103793063785, 7863.960680196591, 7867.1739467355965, 7872.724454644089, 7873.566953817538, 7836.059672839238, 7851.803704907395, 7871.252231038042, 7886.0, 7892.723754668587, 7841.686332546691, 7866.6460009299435, 7867.842643147163, 7882.605869706549, 7897.210278972057, 7762.961185194038, 7842.451028428012, 7849.4897831640765, 7851.293383595446, 7853.685852565891, 37099.443508347125, 37268.0, 37407.81296093529, 37517.24965500702, 37590.81204593987, 2754.73829986151, 2771.7782577393964, 2804.7475727184446, 2908.6800451950267, 3186.964236623107, 28459.0, 29009.7392051731, 29427.411451770844, 29646.851765741034, 30253.546196807067, 3530.523379343807, 3548.503209550665, 3617.5478065241846, 3637.618050104754, 3678.9448158277646, 263190.0, 263406.0, 264454.0, 265197.0, 265327.6733616339, 31069.0, 50400.24399634008, 50692.23961640579, 50743.0, 50792.74603627032, 31862.08827470359, 33846.15384615404, 33854.32291354159, 33899.0, 33912.32175356479, 11871.643850684493, 11943.984761295213, 11989.160758746804, 11994.0, 12012.819807702892, 9478.668246611336, 9533.189678877234, 9535.046495350549, 9536.046395360408, 9538.761530961781, 7878.251566101211, 7891.526508409514, 7932.444728869039, 7962.6416811243635, 7996.720114795954, 3026.546018097303, 3087.336222712128, 3087.428825667259, 3106.50295952651, 3169.952450713241, 847.7499137754254, 947.507296205969, 950.9952450237705, 957.3920560444029, 961.5865177973399, 25225.0, 25810.225693229233, 26401.0, 26410.207693769218, 26465.0, 937.3719607862748, 976.272676855747, 983.7294743945472, 995.8904520502739, 1017.730301470111, 13501.527446539323, 13897.235652039235, 14143.636508442032, 14178.787318190236, 14280.428782848778, 401091.0, 404453.0, 405295.0, 405913.0, 406543.0, 48179.4593621731, 48604.513954860704, 48691.0, 48798.756006219744, 48863.755681221366, 1171.3264872698232, 1177.8939895409283, 1179.8584169899666, 1187.4953144913377, 1190.2858285028913, 26237.475250495267, 27407.86296068507, 27607.723922761317, 27988.300292492037, 28225.0, 40120.59879401168, 41384.58615413807, 41785.582144178166, 41787.7910610445, 44949.0, 361479.0, 363118.0, 363129.0, 363154.0, 363981.0, 37455.25089498249, 37639.0, 38034.239315214094, 38049.0, 38129.428058579695, 41316.0, 41595.7920210397, 41895.7905210472, 42612.36081458843, 42616.360754589325, 35594.28811423705, 36365.63634363622, 36877.0, 36893.63106368902, 37101.25797483981, 35962.0, 36053.09867253339, 36082.45876311805, 36412.4538131923, 36472.452913205794, 30037.84981075168, 30671.2332191697, 34697.653023470455, 35033.474497883064, 36106.27787444289, 26041.609375859, 30616.540751888293, 30665.0, 32755.0, 32884.0, 24769.4229328004, 25182.370440739127, 25359.746402536475, 25771.0, 25776.61335080013], "value": 16418.38895396337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [351.41664836371626, 373.5592001438302, 375.195206282524, 381.48690011933945, 389.36922186058587, 13080.869191308084, 16357.182140892952, 16644.91677541612, 17483.213255403505, 18273.0, 16552.50342489724, 16909.492715218534, 17515.0, 17534.29862805486, 17807.82192178081, 5174.172132458798, 6892.138482689664, 7252.891206631904, 7258.0927384076995, 7271.0547628808445, 4067.3492241241406, 6865.965670171642, 7086.114235720535, 7216.963915180417, 7226.096737907762, 7075.46933979951, 7210.134783825948, 7354.448416368767, 7358.632068396586, 7367.152777430584, 7320.597367144805, 7321.926780732178, 7332.266773322705, 7344.632768361561, 7347.926520734831, 6640.833979150511, 7083.468739844532, 7086.149662040537, 7087.291270872872, 7089.71641134354, 22836.0, 23326.183583574664, 23525.88237058804, 23930.042798288046, 23970.640440393407, 2075.3670130610158, 2101.936941891746, 2165.1880544795704, 2182.1489619048584, 2306.97693023071, 13556.254406007665, 13700.862991370059, 14246.857531424657, 14650.340734666966, 14901.180435076067, 1906.74258975038, 1921.2795201799324, 1941.1264930781065, 1981.8909959952198, 2007.5382661987678, 79070.60464697698, 83354.58322708348, 84615.57692211561, 86184.0, 87536.0, 14329.137212162352, 15302.540923772305, 16187.352505899868, 16627.0, 16755.162241887858, 29290.0, 29655.85172074126, 29714.257143571584, 29796.553051704243, 29881.252968675955, 8185.3042491387705, 8356.916430835614, 8395.28640065589, 8470.745877623682, 8490.391583576955, 6782.253952065269, 6851.931480685229, 6886.208086070166, 6914.515983881181, 7135.036770036082, 8431.620577074047, 8570.528620925908, 8606.82786344282, 8626.6787286895, 8650.52422116777, 3137.748980081588, 3144.9371012580077, 3265.461198902202, 3301.3562355340478, 3344.9331013380083, 734.1777209525259, 830.4145577367941, 833.5957060825494, 839.4375768235298, 896.3098414221014, 16533.83466165347, 17530.561735956704, 17627.82372176262, 17639.823601764074, 17974.91012544955, 832.883396324515, 849.3163003782015, 849.864021756516, 853.1511146409239, 862.5299211929513, 9473.28950328728, 9642.855357169648, 9735.41587504752, 9859.0, 10012.299139060196, 376941.0, 379208.0, 379271.0, 382188.0, 384927.0, 80604.0, 84533.0, 86763.13236867677, 87490.0, 88093.55953220192, 910.7859652981545, 919.0625561926797, 936.8126374725082, 948.5541795356172, 950.0736781637847, 12071.456784444545, 15596.298166582757, 15817.367305308118, 16505.422310219084, 16864.976202855247, 38169.045773855876, 38533.614663854125, 38567.42148867825, 39425.2114957705, 40045.39931900966, 51216.23175652294, 51714.22428663648, 52047.73976130095, 52077.21884171665, 52358.73820630873, 7670.0795904491815, 7737.613119344122, 7761.417893658111, 7794.571298578632, 7848.9215107848195, 11320.716982075513, 11680.94159529197, 11785.823212651645, 11790.174687771774, 12221.511139554674, 10272.948635256776, 10323.122534584645, 10473.633422830164, 10552.577896884039, 10666.626668066581, 9947.801043979225, 10205.948970255102, 10422.218333624856, 10733.463326833784, 10810.027097561257, 10477.68566942993, 10655.680329590125, 10744.946275268887, 10835.51240194209, 10896.945515272373, 7450.96274518624, 7517.361024312776, 7600.46796724224, 7690.346320562815, 7823.530588164728, 8391.95804020976, 10629.309094908805, 10724.088452481314, 10737.463126843782, 10922.726931826768], "value": 9482.736745497808, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1205.7528206717623, 1240.1752834365147, 1312.632462910385, 1476.630842289427, 1482.7331080405522, 7654.387648988081, 8032.759017229485, 8118.91881081189, 8128.91871081289, 8131.268185863271, 6971.6165610891385, 7469.514481558695, 7669.194734552875, 7687.3850091992645, 7999.320057795095, 2180.694702741617, 2216.512367279196, 2219.8224142068675, 2223.1107556977177, 2223.188536184289, 1842.8065053169357, 2075.937721868346, 2096.5806838632257, 2106.3575609439113, 2106.5681535285307, 2117.95764084719, 2185.4864106934856, 2191.802737753602, 2200.7689192634784, 2201.987085940469, 2204.4599073227164, 2207.9558408831736, 2216.6342553478657, 2217.1020736601704, 2226.7327920649545, 2157.471419502216, 2163.891805409739, 2164.1559791681257, 2165.6426689596196, 2170.6201414752513, 7757.146713861471, 7806.687732490694, 7809.570473623949, 7813.882791758128, 7818.609069546556, 4467.218236808578, 4475.686701930867, 4481.327800829869, 4488.7531185784765, 4575.9771201143785, 2873.7557307628877, 2965.673775884651, 2982.537706655472, 3012.6836682148496, 3016.185629879942, 913.4610579757974, 915.890093188815, 924.8335299646061, 948.042477098129, 949.7957939043139, 10924.180686448468, 10934.179936504794, 10934.289271197267, 10961.177911656578, 10963.0, 4131.421600975866, 4196.265653510684, 4261.808218630169, 4417.0, 4417.712848664826, 8680.218780309677, 8749.25631321332, 8793.252573531321, 8827.16141966512, 8838.513881736437, 4696.131215725101, 4712.835050773207, 4715.0, 4715.151272770934, 4717.080169366941, 4259.914801703949, 4371.69398142127, 4377.9781101094295, 4378.540253273424, 4390.100029493946, 3360.647132051148, 3419.6238413774463, 3460.3079384123275, 3466.3933811582874, 3494.0915362005553, 972.8540718892223, 1001.689476262361, 1014.3204053284318, 1016.6289304403839, 1046.0951277145366, 666.3503084492678, 698.2877464985787, 724.5145752345835, 738.117949050879, 740.7703611880335, 4820.156472617348, 5083.61872859537, 5215.452377500384, 5311.0, 5331.306930099062, 887.3744010472601, 899.7390756680489, 933.4632586262926, 961.8982523186859, 975.687779910436, 3489.267253876714, 3664.798436086041, 3722.622629627001, 3755.7183211259266, 3811.4663947047434, 9590.232781377612, 9895.406275623485, 9904.55429505674, 9905.405675659484, 9990.150837178775, 8729.170728780755, 9326.440413575072, 9873.308868379145, 9898.356606820533, 9914.107730304308, 7366.00558924549, 7555.357794587411, 7560.886586701094, 7577.0, 7579.393648508106, 5512.3660779010925, 5628.690422026828, 5660.603757736919, 5728.396049106257, 5842.298924129132, 9196.356255062348, 9335.159835614828, 9346.485943273185, 9349.298802589698, 9351.48566828831, 9121.361504694607, 9260.53697315118, 9596.472194029395, 9603.759906002406, 9603.90396096058, 6328.0, 6353.428191462791, 6454.354564543508, 6481.930481470505, 6526.021096835512, 7339.9633001834645, 7348.301911318416, 7353.338199561851, 7360.668769905475, 7392.223816499405, 6659.101021362054, 6782.626955517494, 6806.523543351917, 6872.484563657646, 6889.689963951534, 6617.569857959217, 6673.733050678113, 6726.899096513458, 6733.494987875831, 6795.660216989229, 6088.695565221809, 6121.938780612137, 6152.661603611844, 6160.075988601746, 6218.751249950133, 4427.0, 4464.55354464551, 4477.8208871646075, 4574.245249533789, 4575.450945886515, 4587.8623641290815, 4613.723176609415, 4616.399868017136, 4651.0, 4679.836205732783], "value": 4119.172180478941, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.4003313472459, 304.8216793175992, 311.70543836074916, 312.0264773905416, 312.13538498359554, 4761.333413322138, 4768.403949506303, 4792.976035119824, 4794.256890182019, 4821.300911367854, 4723.102610504002, 4740.525947405266, 4745.549172828576, 4749.073930583538, 4782.497837727041, 3590.138366791971, 3698.6671199592033, 3709.962900370989, 3806.0865392305786, 3866.0, 3787.6780473659633, 3792.317382871082, 3810.428435734634, 3829.965909204513, 3861.7296789224765, 3605.719969410861, 3754.1177823211524, 3781.1303400217967, 3781.2815565042556, 3810.161764411825, 3607.891763247094, 3723.5717892442176, 3725.869594564177, 3732.6267373262726, 3761.3981762918074, 3294.1435226840954, 3298.835058247078, 3327.351166522529, 3328.118048717092, 3336.215989242526, 4670.758036142636, 4683.601893839028, 4683.658170914543, 4683.765811709401, 4689.226277664181, 4171.311733563989, 4202.621764041221, 4269.978650106761, 4278.935815962763, 4288.721233119868, 4959.851204463872, 4979.950200497985, 4989.55094041538, 4994.202087248587, 5009.398872135331, 3631.092226943264, 3642.7250462338234, 3649.4525821126776, 3649.4708267301094, 3649.872254471107, 4986.925196122061, 5192.910218420034, 5224.387806096952, 5233.816816411408, 5236.162214045772, 3654.0499470137956, 3668.8899333019517, 3698.3158115748674, 3704.6665800077585, 3709.27669104522, 3724.8137593120236, 3757.5866654667966, 3770.4155855842387, 3775.414810704345, 3782.0, 4267.039916018933, 4271.3592961055465, 4272.97448612337, 4276.379924910871, 4282.550332215073, 4758.833440829554, 4923.384576927884, 4932.827351042696, 4954.628402869727, 5004.249362595567, 1299.6685845109437, 1312.4881296294452, 1313.3236383262627, 1322.484231149833, 1322.8478724946754, 842.9757844219181, 853.7438768369465, 874.2219424712011, 908.169025341818, 910.3809409601403, 4347.456567929009, 4360.389545463638, 4365.126974605028, 4371.890702732457, 4377.737335759864, 5081.662435279813, 5089.923651145235, 5096.311997880312, 5099.4390617032095, 5182.97408512955, 4216.978915105405, 4334.219840428753, 4336.479622445327, 4355.891102722394, 4386.0, 2740.739629735172, 2752.8575641108714, 2762.378464845434, 2766.5988431677292, 2771.182501162162, 4720.858374248778, 4806.279058141306, 4806.639502037361, 4816.229403295526, 4818.68678535894, 5028.874278143076, 5208.583313334924, 5273.813391986772, 5283.709395983181, 5284.81503147388, 4772.284157376422, 4783.976080119647, 4786.353842231254, 4796.904061918812, 4805.7985503624095, 5109.386873575195, 5117.5394214520875, 5122.103631864484, 5135.6874815742885, 5136.9743151284, 4905.558499735041, 4980.950190498049, 5027.522385373383, 5164.3802743671, 5171.3535808024, 4867.90264194707, 4905.435874874435, 4907.141250281258, 4912.975435122801, 4918.213085906238, 3714.888553343404, 3720.8139593020783, 3725.515682961198, 3727.4781530586283, 3734.831932562987, 5107.208382700687, 5252.842414727565, 5265.736713164403, 5270.8945821084135, 5287.4976877196605, 5060.6842221023535, 5076.284187959424, 5093.770780314969, 5096.923546146737, 5098.705582487821, 5078.746062696777, 5079.136546786981, 5123.948760512496, 5127.0, 5127.230915362726, 4874.2201247800185, 5000.349954505891, 5013.222950442687, 5059.822906198266, 5102.285680004728, 4851.80592776285, 4955.0, 5067.592893375617, 5103.413107492686, 5110.112786275742, 4994.925076123934, 4996.251312040757, 4997.101681024924, 5007.84976450707, 5009.5491405773655], "value": 3800.5266870280357, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.6556069676103, 591.3111225422382, 600.1238192239327, 650.1058658634776, 677.8712044711505, 11314.151438642104, 11684.941575292112, 12109.27344359339, 12118.151729378947, 12118.394080295982, 11772.941135294312, 11913.642590722271, 11932.70168245792, 11951.043916486682, 11954.222975506585, 614.5390956782413, 743.4981387563373, 749.321863713339, 766.1419210484265, 768.7424712721245, 766.4404984361391, 766.4558163703776, 768.2509553185628, 768.69636493585, 771.2827070824131, 812.9065157506903, 816.0819078536646, 816.4285000499644, 816.6365967144623, 816.8693009118542, 632.7152781248434, 784.1335324466496, 798.7483942558134, 802.2498963469117, 809.6599428240153, 581.8429024163495, 582.2576215325452, 582.6125626458401, 582.8164128299572, 582.8746819433842, 11825.231359961575, 11881.94059029708, 11884.702882427922, 11887.643370698894, 11902.642920712393, 12620.116591838574, 13159.473621055145, 13261.535846245431, 13266.336683165802, 13372.130811497222, 8962.891062495346, 9383.296252781, 9598.376105553116, 9610.471424071673, 9920.851187232198, 4120.464339635858, 4146.3158578834455, 4228.936565951513, 4250.851220207278, 4366.541513141106, 62436.37563624397, 62440.68779656118, 63124.68437657828, 63417.68291158561, 63604.68197658982, 10231.846522302172, 10290.588376465008, 10416.739581510523, 10514.316569422963, 10605.893941060645, 17760.55598610045, 17790.55523611894, 17856.910715446338, 17907.910460447616, 18417.907910460362, 6303.968480157661, 6392.264889537762, 6474.773382931669, 6564.80305590833, 6641.833954151185, 3449.0, 3455.930881382358, 3515.5605549306338, 3538.9469157962653, 3638.3450978824067, 2709.9322516937236, 2791.553351463756, 2795.4688609164195, 2798.8320700758018, 2812.3250419899487, 474.4875534422815, 475.431858928577, 484.8739327774804, 491.8204855227888, 491.8942427378131, 507.72329080651133, 517.1647788821027, 518.7821115131654, 536.2224774077603, 547.7179252684871, 7381.446391520657, 7388.187299397062, 7568.659410326439, 7671.34793542544, 7758.456908016385, 432.362265658158, 522.1280461629088, 522.9973850130725, 547.5209191957038, 553.8643032457073, 3503.1242189452637, 3588.5334906461994, 3737.3459644562636, 3785.0348161218712, 3935.7244992850797, 56947.14579281314, 79200.60399697964, 81145.59427202826, 81922.18077819145, 96506.0, 81999.18000819915, 82062.58968705118, 82323.29797126335, 82376.0, 83518.58240708758, 45828.3125753114, 57473.71263143741, 70809.0, 73940.0, 74903.62548187224, 8775.297976162019, 8845.159709827556, 9144.908550914672, 9186.0, 9402.764930876783, 31579.684203158595, 39333.40999884947, 39624.811255662375, 42410.93972650709, 45107.77446112748, 40716.59283407128, 54675.45324546703, 55442.0, 57311.0, 58463.70768146132, 11101.333919964827, 11155.330680159217, 11199.440027998731, 11202.719932001764, 11605.6518304451, 12222.083343749076, 12752.107352485236, 12965.286909219707, 13468.393922273326, 13610.727785444433, 12254.264744115382, 12348.0, 12475.625731228078, 12605.87394126047, 13232.735345292847, 11396.829047564459, 11718.589849355232, 12099.395030248628, 12130.953388038195, 12340.568080117153, 10598.31110977784, 10639.14886809069, 10761.892381076403, 11010.449477526252, 11029.0, 9930.314451702978, 10272.531448819787, 10474.371537707762, 10567.52446139941, 10599.947000264949, 9697.6605818796, 10296.382217067, 10448.843267350843, 10474.947625261824, 10520.736981575521], "value": 6308.288090481346, "unit": "score"}], "name": "dromaeo_css", "value": 6423.157253202064, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 113.0, 114.0, 113.0, 113.0, 113.0, 112.0, 112.0, 113.0], "value": 111.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 124.0, 123.0, 177.0, 123.0, 131.0, 156.0, 129.0, 153.0, 123.0], "value": 138.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 161.0, 160.0, 161.0, 163.0, 162.0, 161.0, 161.0, 161.0, 163.0], "value": 161.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 111.0, 78.0, 76.0, 76.0, 76.0, 105.0, 77.0], "value": 82.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 125.0, 87.0, 86.0, 86.0, 121.0, 85.0, 85.0, 144.0], "value": 98.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 116.0, 117.0, 116.0, 117.0, 117.0, 117.0, 118.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 95.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 68.0, 65.0, 64.0, 64.0, 65.0, 64.0, 65.0, 65.0, 64.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0, 65.0], "value": 64.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 80.0, 84.0, 79.0, 78.0, 79.0, 79.0, 79.0, 78.0, 83.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 139.0, 124.0, 127.0, 139.0, 126.0, 126.0, 128.0, 175.0, 143.0], "value": 135.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 166.0, 164.0, 164.0, 165.0, 164.0, 163.0, 167.0, 165.0, 166.0], "value": 165.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 74.0, 66.0, 65.0, 66.0, 67.0, 65.0, 66.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1529.1999999999998, "alertThreshold": 2.0}]} 18:55:47 INFO - Return code: 0 18:55:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 18:55:47 INFO - # TBPL SUCCESS # 18:55:47 INFO - Running post-action listener: _resource_record_post_action 18:55:47 INFO - ##### 18:55:47 INFO - ##### Finished run-tests step (success) 18:55:47 INFO - ##### 18:55:47 INFO - Running post-run listener: _resource_record_post_run 18:55:47 INFO - Total resource usage - Wall time: 1201s; CPU: 13.0%; Read bytes: 0; Write bytes: 556335104; Read time: 0; Write time: 673964 18:55:47 INFO - TinderboxPrint: CPU usage
13.0% 18:55:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 18:55:47 INFO - TinderboxPrint: I/O write bytes / time
556,335,104 / 673,964 18:55:47 INFO - TinderboxPrint: CPU idle
8,341.4 (87.0%) 18:55:47 INFO - TinderboxPrint: CPU user
1,200.6 (12.5%) 18:55:47 INFO - TinderboxPrint: Swap in / out
0 / 0 18:55:47 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 258117632; Read time: 0; Write time: 325296 18:55:47 INFO - run-tests - Wall time: 1185s; CPU: 13.0%; Read bytes: 0; Write bytes: 298217472; Read time: 0; Write time: 348668 18:55:48 INFO - Running post-run listener: _upload_blobber_files 18:55:48 INFO - Blob upload gear active. 18:55:48 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:55:48 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:48 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:48 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:48 INFO - (blobuploader) - INFO - Open directory for files ... 18:55:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_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_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 - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 18:55:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:55:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:55:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 18:55:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:55:52 INFO - (blobuploader) - INFO - Done attempting. 18:55:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:55:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:55:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:55:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:55:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:55:53 INFO - (blobuploader) - INFO - Done attempting. 18:55:53 INFO - (blobuploader) - INFO - Iteration through files over. 18:55:53 INFO - Return code: 0 18:55:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:55:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:55:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3aa4f77c3d829808bc8d613662f38a34d5bdd5415d8fd706db62f0dfa74e8d16b437415eb983b44a5508d05de64c775d8d8c3f8597158dd0867021592f1c26db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c27c9cf4fe8da7a1619eaf40d24e362363169b280c26462703c7b09ed76d343c8aad56109005eea0cf4c9a33d97dee4dc4ccdbe2e4194cc22582f8581fb9cbe9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23f257ea12a494b7965aea641555fd40d4f11da99457b4e4c8786b1b0b7832ff934bdc4a827f07dedb73908155f17497eec1fd69c3d90b381dcb927259a7041d"} 18:55:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:55:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:55:53 INFO - Contents: 18:55:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3aa4f77c3d829808bc8d613662f38a34d5bdd5415d8fd706db62f0dfa74e8d16b437415eb983b44a5508d05de64c775d8d8c3f8597158dd0867021592f1c26db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c27c9cf4fe8da7a1619eaf40d24e362363169b280c26462703c7b09ed76d343c8aad56109005eea0cf4c9a33d97dee4dc4ccdbe2e4194cc22582f8581fb9cbe9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23f257ea12a494b7965aea641555fd40d4f11da99457b4e4c8786b1b0b7832ff934bdc4a827f07dedb73908155f17497eec1fd69c3d90b381dcb927259a7041d"} 18:55:53 INFO - Running post-run listener: copy_logs_to_upload_dir 18:55:53 INFO - Copying logs to upload dir... 18:55:53 INFO - mkdir: /builds/slave/test/build/upload/logs 18:55:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1242.826813 ========= master_lag: -0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 42 secs) (at 2016-07-07 18:55:52.580586) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 18:55:52.583614) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3aa4f77c3d829808bc8d613662f38a34d5bdd5415d8fd706db62f0dfa74e8d16b437415eb983b44a5508d05de64c775d8d8c3f8597158dd0867021592f1c26db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c27c9cf4fe8da7a1619eaf40d24e362363169b280c26462703c7b09ed76d343c8aad56109005eea0cf4c9a33d97dee4dc4ccdbe2e4194cc22582f8581fb9cbe9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23f257ea12a494b7965aea641555fd40d4f11da99457b4e4c8786b1b0b7832ff934bdc4a827f07dedb73908155f17497eec1fd69c3d90b381dcb927259a7041d"} 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.011256 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/3aa4f77c3d829808bc8d613662f38a34d5bdd5415d8fd706db62f0dfa74e8d16b437415eb983b44a5508d05de64c775d8d8c3f8597158dd0867021592f1c26db", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/c27c9cf4fe8da7a1619eaf40d24e362363169b280c26462703c7b09ed76d343c8aad56109005eea0cf4c9a33d97dee4dc4ccdbe2e4194cc22582f8581fb9cbe9", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/23f257ea12a494b7965aea641555fd40d4f11da99457b4e4c8786b1b0b7832ff934bdc4a827f07dedb73908155f17497eec1fd69c3d90b381dcb927259a7041d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 18:55:52.608109) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:55:52.608411) ========= 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=05b19d94dfa9f3ce7b6e62cc000001f7-1467937147.910625-1408737068 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 18:55:52.694264) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 18:55:52.694576) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 18:55:52.694858) ========= ========= Total master_lag: 0.17 =========