builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1467675064.85 results: success (0) buildid: 20160704150324 builduid: 4e86acde70c8419fbc661dbebb014130 revision: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:04.847842) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:04.848631) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:04.848935) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:04.912635) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:04.912914) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 16:31:04-- 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% 224M=0s 2016-07-04 16:31:04 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.117737 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:05.057166) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:05.057478) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020726 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:05.118229) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:05.118702) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 --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 c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 --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=03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 16:31:05,137 truncating revision to first 12 chars 2016-07-04 16:31:05,137 Setting DEBUG logging. 2016-07-04 16:31:05,137 attempt 1/10 2016-07-04 16:31:05,137 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c9a70b64f2fa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 16:31:05,449 unpacking tar archive at: mozilla-central-c9a70b64f2fa/testing/mozharness/ program finished with exit code 0 elapsedTime=0.645554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:05.783453) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:05.786906) ========= script_repo_revision: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:05.787390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:05.787684) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 16:31:05.803645) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-04 16:31:05.804043) ========= /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=03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:31:05 INFO - MultiFileLogger online at 20160704 16:31:05 in /builds/slave/test 16:31:05 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 16:31:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:31:05 INFO - {'append_to_log': False, 16:31:05 INFO - 'base_work_dir': '/builds/slave/test', 16:31:05 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 16:31:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:31:05 INFO - 'branch': 'Firefox-Non-PGO', 16:31:05 INFO - 'buildbot_json_path': 'buildprops.json', 16:31:05 INFO - 'config_files': ('talos/linux_config.py',), 16:31:05 INFO - 'default_actions': ('clobber', 16:31:05 INFO - 'read-buildbot-config', 16:31:05 INFO - 'download-and-extract', 16:31:05 INFO - 'populate-webroot', 16:31:05 INFO - 'create-virtualenv', 16:31:05 INFO - 'install', 16:31:05 INFO - 'run-tests'), 16:31:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:31:05 INFO - 'download_minidump_stackwalk': True, 16:31:05 INFO - 'download_symbols': 'ondemand', 16:31:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:31:05 INFO - 'tooltool.py': '/tools/tooltool.py', 16:31:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:31:05 INFO - '/tools/misc-python/virtualenv.py')}, 16:31:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:31:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:31:05 INFO - 'installer_path': 'installer.exe', 16:31:05 INFO - 'log_level': 'info', 16:31:05 INFO - 'log_name': 'talos', 16:31:05 INFO - 'log_to_console': True, 16:31:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:31:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:31:05 INFO - 'opt_config_files': (), 16:31:05 INFO - 'pip_index': False, 16:31:05 INFO - 'sps_profile': False, 16:31:05 INFO - 'sps_profile_interval': 0, 16:31:05 INFO - 'suite': 'dromaeojs', 16:31:05 INFO - 'system_bits': '32', 16:31:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:31:05 INFO - 'title': 'talos-linux64-ix-047', 16:31:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:31:05 INFO - 'use_talos_json': True, 16:31:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:31:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:31:05 INFO - 'work_dir': 'build'} 16:31:05 INFO - ##### 16:31:05 INFO - ##### Running clobber step. 16:31:05 INFO - ##### 16:31:05 INFO - Running pre-action listener: _resource_record_pre_action 16:31:05 INFO - Running main action method: clobber 16:31:05 INFO - rmtree: /builds/slave/test/build 16:31:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:31:06 INFO - Running post-action listener: _resource_record_post_action 16:31:06 INFO - ##### 16:31:06 INFO - ##### Finished clobber step (success) 16:31:06 INFO - ##### 16:31:06 INFO - ##### 16:31:06 INFO - ##### Running read-buildbot-config step. 16:31:06 INFO - ##### 16:31:06 INFO - Running pre-action listener: _resource_record_pre_action 16:31:06 INFO - Running main action method: read_buildbot_config 16:31:06 INFO - Using buildbot properties: 16:31:06 INFO - { 16:31:06 INFO - "project": "", 16:31:06 INFO - "product": "firefox", 16:31:06 INFO - "script_repo_revision": "production", 16:31:06 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 16:31:06 INFO - "repository": "", 16:31:06 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 16:31:06 INFO - "buildid": "20160704150324", 16:31:06 INFO - "pgo_build": "False", 16:31:06 INFO - "basedir": "/builds/slave/test", 16:31:06 INFO - "buildnumber": 137, 16:31:06 INFO - "slavename": "talos-linux64-ix-047", 16:31:06 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 16:31:06 INFO - "platform": "ubuntu64_hw", 16:31:06 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 16:31:06 INFO - "branch": "mozilla-central", 16:31:06 INFO - "repo_path": "mozilla-central", 16:31:06 INFO - "revision": "c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5", 16:31:06 INFO - "stage_platform": "linux64", 16:31:06 INFO - "builduid": "4e86acde70c8419fbc661dbebb014130", 16:31:06 INFO - "slavebuilddir": "test" 16:31:06 INFO - } 16:31:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 16:31:06 INFO - Running post-action listener: _resource_record_post_action 16:31:06 INFO - ##### 16:31:06 INFO - ##### Finished read-buildbot-config step (success) 16:31:06 INFO - ##### 16:31:06 INFO - ##### 16:31:06 INFO - ##### Running download-and-extract step. 16:31:06 INFO - ##### 16:31:06 INFO - Running pre-action listener: _resource_record_pre_action 16:31:06 INFO - Running main action method: download_and_extract 16:31:06 INFO - mkdir: /builds/slave/test/build/tests 16:31:06 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')]} 16:31:06 INFO - https://queue.taskcluster.net/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 16:31:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:31:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:31:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/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 16:31:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/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 16:31:09 INFO - Downloaded 1361 bytes. 16:31:09 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 16:31:09 INFO - Using the following test package requirements: 16:31:09 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:31:09 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:31:09 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 16:31:09 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:09 INFO - u'jsshell-linux-x86_64.zip'], 16:31:09 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:31:09 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 16:31:09 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:31:09 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:31:09 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:31:09 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 16:31:09 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:31:09 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:31:09 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')]} 16:31:09 INFO - https://queue.taskcluster.net/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:31:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:31:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:31:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/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 16:31:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/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 16:31:10 INFO - Downloaded 22728597 bytes. 16:31:10 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'] 16:31:10 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 16:31:11 INFO - Return code: 0 16:31:11 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 16:31: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')]} 16:31:11 INFO - https://queue.taskcluster.net/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:31:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:31:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 16:31:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/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 16:31:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/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 16:31:13 INFO - Downloaded 22728597 bytes. 16:31:13 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'] 16:31:13 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 16:31:15 INFO - Return code: 0 16:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 16:31:15 INFO - https://queue.taskcluster.net/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:31:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 16:31:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/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 16:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/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 16:31:16 INFO - Downloaded 14403333 bytes. 16:31:16 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'] 16:31:16 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 16:31:16 INFO - Return code: 0 16:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:16 INFO - https://queue.taskcluster.net/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:31:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/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 16:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SRJ5e4FVRmytB0-VejKzjA/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 16:31:17 INFO - Downloaded 56489530 bytes. 16:31:17 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:17 INFO - mkdir: /builds/slave/test/properties 16:31:17 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:31:17 INFO - Writing to file /builds/slave/test/properties/build_url 16:31:17 INFO - Contents: 16:31:17 INFO - build_url:https://queue.taskcluster.net/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 16:31:18 INFO - Running post-action listener: _resource_record_post_action 16:31:18 INFO - Running post-action listener: set_extra_try_arguments 16:31:18 INFO - ##### 16:31:18 INFO - ##### Finished download-and-extract step (success) 16:31:18 INFO - ##### 16:31:18 INFO - ##### 16:31:18 INFO - ##### Running populate-webroot step. 16:31:18 INFO - ##### 16:31:18 INFO - Running pre-action listener: _resource_record_pre_action 16:31:18 INFO - Running main action method: populate_webroot 16:31:18 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:31:18 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:31:18 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:31:18 INFO - '--tppagecycles', 16:31:18 INFO - '7'], 16:31:18 INFO - 'tests': ['tsvgm']}}, 16:31:18 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 16:31:18 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:31:18 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 16:31:18 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 16:31:18 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:31:18 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 16:31:18 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:18 INFO - 'talos_options': ['--disable-e10s'], 16:31:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:18 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:18 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:31:18 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:18 INFO - 'talos_options': ['--disable-e10s'], 16:31:18 INFO - 'tests': ['damp', 'tps']}, 16:31:18 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:18 INFO - 'tests': ['damp', 'tps']}, 16:31:18 INFO - 'g3': {'talos_options': ['--disable-e10s'], 16:31:18 INFO - 'tests': ['dromaeo_dom']}, 16:31:18 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:31:18 INFO - 'g4': {'talos_options': ['--disable-e10s'], 16:31:18 INFO - 'tests': ['basic_compositor_video']}, 16:31:18 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 16:31:18 INFO - 'other': {'talos_options': ['--disable-e10s'], 16:31:18 INFO - 'tests': ['a11yr', 16:31:18 INFO - 'ts_paint', 16:31:18 INFO - 'tpaint', 16:31:18 INFO - 'sessionrestore', 16:31:18 INFO - 'sessionrestore_no_auto_restore', 16:31:18 INFO - 'tabpaint']}, 16:31:18 INFO - 'other-e10s': {'tests': ['a11yr', 16:31:18 INFO - 'ts_paint', 16:31:18 INFO - 'tpaint', 16:31:18 INFO - 'sessionrestore', 16:31:18 INFO - 'sessionrestore_no_auto_restore', 16:31:18 INFO - 'tabpaint']}, 16:31:18 INFO - 'other-e10s_l64': {'tests': ['a11yr', 16:31:18 INFO - 'ts_paint', 16:31:18 INFO - 'tpaint', 16:31:18 INFO - 'sessionrestore', 16:31:18 INFO - 'sessionrestore_no_auto_restore', 16:31:18 INFO - 'tabpaint']}, 16:31:18 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 16:31:18 INFO - 'ts_paint', 16:31:18 INFO - 'tpaint', 16:31:18 INFO - 'sessionrestore', 16:31:18 INFO - 'sessionrestore_no_auto_restore', 16:31:18 INFO - 'tabpaint']}, 16:31:18 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 16:31:18 INFO - 'tests': ['a11yr', 16:31:18 INFO - 'ts_paint', 16:31:18 INFO - 'tpaint', 16:31:18 INFO - 'sessionrestore', 16:31:18 INFO - 'sessionrestore_no_auto_restore', 16:31:18 INFO - 'tabpaint']}, 16:31:18 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 16:31:18 INFO - 'tests': ['a11yr', 16:31:18 INFO - 'ts_paint', 16:31:18 INFO - 'tpaint', 16:31:18 INFO - 'sessionrestore', 16:31:18 INFO - 'sessionrestore_no_auto_restore', 16:31:18 INFO - 'tabpaint']}, 16:31:18 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 16:31:18 INFO - 'tests': ['tsvgx', 16:31:18 INFO - 'tsvgr_opacity', 16:31:18 INFO - 'tart', 16:31:18 INFO - 'tscrollx', 16:31:18 INFO - 'cart']}, 16:31:18 INFO - 'svgr-e10s': {'tests': ['tsvgx', 16:31:18 INFO - 'tsvgr_opacity', 16:31:18 INFO - 'tart', 16:31:18 INFO - 'tscrollx', 16:31:18 INFO - 'cart']}, 16:31:18 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:18 INFO - 'talos_options': ['--disable-e10s'], 16:31:18 INFO - 'tests': ['tp5o']}, 16:31:18 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:18 INFO - 'tests': ['tp5o']}, 16:31:18 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:18 INFO - 'talos_options': ['--disable-e10s', 16:31:18 INFO - '--xperf_path', 16:31:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:18 INFO - 'tests': ['tp5n']}, 16:31:18 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:31:18 INFO - 'talos_options': ['--xperf_path', 16:31:18 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:31:18 INFO - 'tests': ['tp5n']}}, 16:31:18 INFO - 'talos.zip': {'path': '', 16:31:18 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:31:18 INFO - Running post-action listener: _resource_record_post_action 16:31:18 INFO - ##### 16:31:18 INFO - ##### Finished populate-webroot step (success) 16:31:18 INFO - ##### 16:31:18 INFO - ##### 16:31:18 INFO - ##### Running create-virtualenv step. 16:31:18 INFO - ##### 16:31:18 INFO - Running pre-action listener: _resource_record_pre_action 16:31:18 INFO - Running main action method: create_virtualenv 16:31:18 INFO - Creating virtualenv /builds/slave/test/build/venv 16:31:18 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 16:31:18 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:31:18 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:31:18 INFO - Using real prefix '/usr' 16:31:18 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:31:19 INFO - Installing distribute.............................................................................................................................................................................................done. 16:31:21 INFO - Installing pip.................done. 16:31:21 INFO - Return code: 0 16:31:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:21 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 0x229b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a3b0>, '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 0x255b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', '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 16:31:21 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 16:31:21 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 16:31:21 INFO - Using env: {'DISPLAY': ':0', 16:31:21 INFO - 'HOME': '/home/cltbld', 16:31:21 INFO - 'LANG': 'en_US.UTF-8', 16:31:21 INFO - 'LANGUAGE': 'en_US:en', 16:31:21 INFO - 'LOGNAME': 'cltbld', 16:31:21 INFO - 'MAIL': '/var/mail/cltbld', 16:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:21 INFO - 'MOZ_NO_REMOTE': '1', 16:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:21 INFO - 'NO_EM_RESTART': '1', 16:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:21 INFO - 'PWD': '/builds/slave/test', 16:31:21 INFO - 'SHELL': '/bin/bash', 16:31:21 INFO - 'SHLVL': '1', 16:31:21 INFO - 'TERM': 'linux', 16:31:21 INFO - 'TMOUT': '86400', 16:31:21 INFO - 'USER': 'cltbld', 16:31:21 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', 16:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:21 INFO - '_': '/tools/buildbot/bin/python'} 16:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:21 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 16:31:21 INFO - Cleaning up... 16:31:21 INFO - Return code: 0 16:31:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:21 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 0x229b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a3b0>, '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 0x255b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', '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 16:31:21 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 16:31:21 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 16:31:21 INFO - Using env: {'DISPLAY': ':0', 16:31:21 INFO - 'HOME': '/home/cltbld', 16:31:21 INFO - 'LANG': 'en_US.UTF-8', 16:31:21 INFO - 'LANGUAGE': 'en_US:en', 16:31:21 INFO - 'LOGNAME': 'cltbld', 16:31:21 INFO - 'MAIL': '/var/mail/cltbld', 16:31:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:21 INFO - 'MOZ_NO_REMOTE': '1', 16:31:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:21 INFO - 'NO_EM_RESTART': '1', 16:31:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:21 INFO - 'PWD': '/builds/slave/test', 16:31:21 INFO - 'SHELL': '/bin/bash', 16:31:21 INFO - 'SHLVL': '1', 16:31:21 INFO - 'TERM': 'linux', 16:31:21 INFO - 'TMOUT': '86400', 16:31:21 INFO - 'USER': 'cltbld', 16:31:21 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', 16:31:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:21 INFO - '_': '/tools/buildbot/bin/python'} 16:31:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:21 INFO - Downloading/unpacking psutil>=3.1.1 16:31:21 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 16:31:21 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 16:31:21 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 16:31:21 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 16:31:21 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 16:31:21 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 16:31:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:31:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:23 INFO - Installing collected packages: psutil 16:31:23 INFO - Running setup.py install for psutil 16:31:23 INFO - building 'psutil._psutil_linux' extension 16:31:23 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 16:31:23 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 16:31:23 INFO - building 'psutil._psutil_posix' extension 16:31:23 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 16:31:23 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 16:31:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:31:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:31:24 INFO - Successfully installed psutil 16:31:24 INFO - Cleaning up... 16:31:24 INFO - Return code: 0 16:31:24 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 16:31:24 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')]} 16:31:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:24 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')]} 16:31:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:24 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 0x229b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a3b0>, '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 0x255b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', '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 16:31:24 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 16:31:24 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 16:31:24 INFO - Using env: {'DISPLAY': ':0', 16:31:24 INFO - 'HOME': '/home/cltbld', 16:31:24 INFO - 'LANG': 'en_US.UTF-8', 16:31:24 INFO - 'LANGUAGE': 'en_US:en', 16:31:24 INFO - 'LOGNAME': 'cltbld', 16:31:24 INFO - 'MAIL': '/var/mail/cltbld', 16:31:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:24 INFO - 'MOZ_NO_REMOTE': '1', 16:31:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:24 INFO - 'NO_EM_RESTART': '1', 16:31:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:24 INFO - 'PWD': '/builds/slave/test', 16:31:24 INFO - 'SHELL': '/bin/bash', 16:31:24 INFO - 'SHLVL': '1', 16:31:24 INFO - 'TERM': 'linux', 16:31:24 INFO - 'TMOUT': '86400', 16:31:24 INFO - 'USER': 'cltbld', 16:31:24 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', 16:31:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:24 INFO - '_': '/tools/buildbot/bin/python'} 16:31:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:24 INFO - Downloading/unpacking mozsystemmonitor==0.3 16:31:24 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 16:31:24 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 16:31:24 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 16:31:24 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 16:31:24 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 16:31:24 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 16:31:26 INFO - Downloading mozsystemmonitor-0.3.tar.gz 16:31:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:31:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 16:31:26 INFO - Installing collected packages: mozsystemmonitor 16:31:26 INFO - Running setup.py install for mozsystemmonitor 16:31:26 INFO - Successfully installed mozsystemmonitor 16:31:26 INFO - Cleaning up... 16:31:26 INFO - Return code: 0 16:31:26 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 16:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x229b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a3b0>, '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 0x255b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', '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 16:31:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 16:31:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 16:31:26 INFO - Using env: {'DISPLAY': ':0', 16:31:26 INFO - 'HOME': '/home/cltbld', 16:31:26 INFO - 'LANG': 'en_US.UTF-8', 16:31:26 INFO - 'LANGUAGE': 'en_US:en', 16:31:26 INFO - 'LOGNAME': 'cltbld', 16:31:26 INFO - 'MAIL': '/var/mail/cltbld', 16:31:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:26 INFO - 'MOZ_NO_REMOTE': '1', 16:31:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:26 INFO - 'NO_EM_RESTART': '1', 16:31:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:26 INFO - 'PWD': '/builds/slave/test', 16:31:26 INFO - 'SHELL': '/bin/bash', 16:31:26 INFO - 'SHLVL': '1', 16:31:26 INFO - 'TERM': 'linux', 16:31:26 INFO - 'TMOUT': '86400', 16:31:26 INFO - 'USER': 'cltbld', 16:31:26 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', 16:31:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:26 INFO - '_': '/tools/buildbot/bin/python'} 16:31:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:26 INFO - Downloading/unpacking jsonschema==2.5.1 16:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:28 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:31:28 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 16:31:28 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 16:31:28 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 16:31:28 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 16:31:28 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 16:31:28 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 16:31:28 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 16:31:29 INFO - Downloading functools32-3.2.3-2.tar.gz 16:31:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:31:29 INFO - warning: no files found matching '*.txt' 16:31:29 INFO - no previously-included directories found matching 'build' 16:31:29 INFO - no previously-included directories found matching 'dist' 16:31:29 INFO - no previously-included directories found matching '.git*' 16:31:29 INFO - Installing collected packages: jsonschema, functools32 16:31:29 INFO - Running setup.py install for functools32 16:31:29 INFO - warning: no files found matching '*.txt' 16:31:29 INFO - no previously-included directories found matching 'build' 16:31:29 INFO - no previously-included directories found matching 'dist' 16:31:29 INFO - no previously-included directories found matching '.git*' 16:31:29 INFO - Successfully installed jsonschema functools32 16:31:29 INFO - Cleaning up... 16:31:29 INFO - Return code: 0 16:31:29 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x229b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a3b0>, '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 0x255b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', '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 16:31:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:31:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:31:29 INFO - Using env: {'DISPLAY': ':0', 16:31:29 INFO - 'HOME': '/home/cltbld', 16:31:29 INFO - 'LANG': 'en_US.UTF-8', 16:31:29 INFO - 'LANGUAGE': 'en_US:en', 16:31:29 INFO - 'LOGNAME': 'cltbld', 16:31:29 INFO - 'MAIL': '/var/mail/cltbld', 16:31:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:29 INFO - 'MOZ_NO_REMOTE': '1', 16:31:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:29 INFO - 'NO_EM_RESTART': '1', 16:31:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:29 INFO - 'PWD': '/builds/slave/test', 16:31:29 INFO - 'SHELL': '/bin/bash', 16:31:29 INFO - 'SHLVL': '1', 16:31:29 INFO - 'TERM': 'linux', 16:31:29 INFO - 'TMOUT': '86400', 16:31:29 INFO - 'USER': 'cltbld', 16:31:29 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', 16:31:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:29 INFO - '_': '/tools/buildbot/bin/python'} 16:31:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:29 INFO - Downloading/unpacking blobuploader==1.2.4 16:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:31:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:31:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:31:31 INFO - Downloading blobuploader-1.2.4.tar.gz 16:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:31:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:31:31 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 16:31:31 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 16:31:31 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 16:31:31 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 16:31:31 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 16:31:31 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 16:31:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:31:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:32 INFO - Downloading docopt-0.6.1.tar.gz 16:31:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:31:32 INFO - Installing collected packages: blobuploader, requests, docopt 16:31:32 INFO - Running setup.py install for blobuploader 16:31:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:31:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:31:32 INFO - Running setup.py install for requests 16:31:32 INFO - Running setup.py install for docopt 16:31:32 INFO - Successfully installed blobuploader requests docopt 16:31:32 INFO - Cleaning up... 16:31:32 INFO - Return code: 0 16:31:32 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31: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')]} 16:31:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31: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')]} 16:31:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:32 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 0x229b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a3b0>, '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 0x255b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', '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 16:31:32 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 16:31:32 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 16:31:32 INFO - Using env: {'DISPLAY': ':0', 16:31:32 INFO - 'HOME': '/home/cltbld', 16:31:32 INFO - 'LANG': 'en_US.UTF-8', 16:31:32 INFO - 'LANGUAGE': 'en_US:en', 16:31:32 INFO - 'LOGNAME': 'cltbld', 16:31:32 INFO - 'MAIL': '/var/mail/cltbld', 16:31:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:32 INFO - 'MOZ_NO_REMOTE': '1', 16:31:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:32 INFO - 'NO_EM_RESTART': '1', 16:31:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:32 INFO - 'PWD': '/builds/slave/test', 16:31:32 INFO - 'SHELL': '/bin/bash', 16:31:32 INFO - 'SHLVL': '1', 16:31:32 INFO - 'TERM': 'linux', 16:31:32 INFO - 'TMOUT': '86400', 16:31:32 INFO - 'USER': 'cltbld', 16:31:32 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', 16:31:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:32 INFO - '_': '/tools/buildbot/bin/python'} 16:31:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:33 INFO - Running setup.py (path:/tmp/pip-V_hVmN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:33 INFO - Running setup.py (path:/tmp/pip-XJhfzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:33 INFO - Running setup.py (path:/tmp/pip-yYRwB3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:33 INFO - Running setup.py (path:/tmp/pip-beU_jW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:33 INFO - Running setup.py (path:/tmp/pip-Dsu_AQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:33 INFO - Running setup.py (path:/tmp/pip-NPTBOd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:33 INFO - Running setup.py (path:/tmp/pip-TRTra4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:33 INFO - Running setup.py (path:/tmp/pip-suEPBP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:33 INFO - Running setup.py (path:/tmp/pip-YQmYoL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:33 INFO - Running setup.py (path:/tmp/pip-nyhcqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:33 INFO - Running setup.py (path:/tmp/pip-K_Y_v0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:33 INFO - Running setup.py (path:/tmp/pip-8Yjj9I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:33 INFO - Running setup.py (path:/tmp/pip-B_EPjC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:34 INFO - Running setup.py (path:/tmp/pip-DNTug3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:34 INFO - Running setup.py (path:/tmp/pip-6i02va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:34 INFO - Running setup.py (path:/tmp/pip-l5VUzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:34 INFO - Running setup.py (path:/tmp/pip-rtSfsn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:34 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:31:34 INFO - Running setup.py install for manifestparser 16:31:34 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:31:34 INFO - Running setup.py install for mozcrash 16:31:34 INFO - Running setup.py install for mozdebug 16:31:34 INFO - Running setup.py install for mozdevice 16:31:34 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:31:34 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:31:34 INFO - Running setup.py install for mozfile 16:31:34 INFO - Running setup.py install for mozhttpd 16:31:34 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:31:34 INFO - Running setup.py install for mozinfo 16:31:34 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:31:34 INFO - Running setup.py install for mozInstall 16:31:35 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Running setup.py install for mozleak 16:31:35 INFO - Running setup.py install for mozlog 16:31:35 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Running setup.py install for moznetwork 16:31:35 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Running setup.py install for mozprocess 16:31:35 INFO - Running setup.py install for mozprofile 16:31:35 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Running setup.py install for mozrunner 16:31:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:31:35 INFO - Running setup.py install for mozscreenshot 16:31:35 INFO - Running setup.py install for moztest 16:31:35 INFO - Running setup.py install for mozversion 16:31:36 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:31:36 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:31:36 INFO - Cleaning up... 16:31:36 INFO - Return code: 0 16:31:36 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:36 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')]} 16:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:36 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')]} 16:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:36 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 0x229b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a3b0>, '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 0x255b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', '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 16:31:36 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 16:31:36 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 16:31:36 INFO - Using env: {'DISPLAY': ':0', 16:31:36 INFO - 'HOME': '/home/cltbld', 16:31:36 INFO - 'LANG': 'en_US.UTF-8', 16:31:36 INFO - 'LANGUAGE': 'en_US:en', 16:31:36 INFO - 'LOGNAME': 'cltbld', 16:31:36 INFO - 'MAIL': '/var/mail/cltbld', 16:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:36 INFO - 'MOZ_NO_REMOTE': '1', 16:31:36 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:36 INFO - 'NO_EM_RESTART': '1', 16:31:36 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:36 INFO - 'PWD': '/builds/slave/test', 16:31:36 INFO - 'SHELL': '/bin/bash', 16:31:36 INFO - 'SHLVL': '1', 16:31:36 INFO - 'TERM': 'linux', 16:31:36 INFO - 'TMOUT': '86400', 16:31:36 INFO - 'USER': 'cltbld', 16:31:36 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', 16:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:36 INFO - '_': '/tools/buildbot/bin/python'} 16:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:31:36 INFO - Running setup.py (path:/tmp/pip-NyxFA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:31:36 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)) 16:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:31:36 INFO - Running setup.py (path:/tmp/pip-O85yz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:31:36 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)) 16:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:31:36 INFO - Running setup.py (path:/tmp/pip-ZgGZEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:31:36 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)) 16:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:31:36 INFO - Running setup.py (path:/tmp/pip-6KuOxE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:31:36 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)) 16:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:31:36 INFO - Running setup.py (path:/tmp/pip-xcSGwN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:31:36 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)) 16:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:31:36 INFO - Running setup.py (path:/tmp/pip-mPqCey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:31:36 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)) 16:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:31:36 INFO - Running setup.py (path:/tmp/pip-YTwd_6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:31:36 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)) 16:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:31:36 INFO - Running setup.py (path:/tmp/pip-VTT_ia-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:31:36 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)) 16:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:31:36 INFO - Running setup.py (path:/tmp/pip-zMj92c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:31:36 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)) 16:31:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:31:36 INFO - Running setup.py (path:/tmp/pip-MOKXgv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:31:37 INFO - Running setup.py (path:/tmp/pip-vqPLY_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:31:37 INFO - Running setup.py (path:/tmp/pip-njDsSk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:31:37 INFO - Running setup.py (path:/tmp/pip-kHBNw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:31:37 INFO - Running setup.py (path:/tmp/pip-Tjpvd5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:31:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:37 INFO - Running setup.py (path:/tmp/pip-mXWYAz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:31:37 INFO - Running setup.py (path:/tmp/pip-Wh9DxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:31:37 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)) 16:31:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:31:37 INFO - Running setup.py (path:/tmp/pip-vxzQBy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:31:37 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)) 16:31:37 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)) 16:31:37 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)) 16:31:37 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)) 16:31:37 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)) 16:31:37 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)) 16:31:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31: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 16:31:39 INFO - Downloading blessings-1.6.tar.gz 16:31:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:31:39 INFO - Installing collected packages: blessings 16:31:39 INFO - Running setup.py install for blessings 16:31:39 INFO - Successfully installed blessings 16:31:39 INFO - Cleaning up... 16:31:39 INFO - Return code: 0 16:31:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:31:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:39 INFO - Reading from file tmpfile_stdout 16:31:39 INFO - Current package versions: 16:31:39 INFO - argparse == 1.2.1 16:31:39 INFO - blessings == 1.6 16:31:39 INFO - blobuploader == 1.2.4 16:31:39 INFO - docopt == 0.6.1 16:31:39 INFO - functools32 == 3.2.3-2 16:31:39 INFO - jsonschema == 2.5.1 16:31:39 INFO - manifestparser == 1.1 16:31:39 INFO - mozInstall == 1.12 16:31:39 INFO - mozcrash == 0.17 16:31:39 INFO - mozdebug == 0.1 16:31:39 INFO - mozdevice == 0.48 16:31:39 INFO - mozfile == 1.2 16:31:39 INFO - mozhttpd == 0.7 16:31:39 INFO - mozinfo == 0.9 16:31:39 INFO - mozleak == 0.1 16:31:39 INFO - mozlog == 3.2 16:31:39 INFO - moznetwork == 0.27 16:31:39 INFO - mozprocess == 0.22 16:31:39 INFO - mozprofile == 0.28 16:31:39 INFO - mozrunner == 6.11 16:31:39 INFO - mozscreenshot == 0.1 16:31:39 INFO - mozsystemmonitor == 0.3 16:31:39 INFO - moztest == 0.7 16:31:39 INFO - mozversion == 1.4 16:31:39 INFO - psutil == 3.1.1 16:31:39 INFO - requests == 1.2.3 16:31:39 INFO - wsgiref == 0.1.2 16:31:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:31:39 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')]} 16:31:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:39 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')]} 16:31:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:39 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 0x229b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a3b0>, '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 0x255b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', '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 16:31:39 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 16:31:39 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 16:31:39 INFO - Using env: {'DISPLAY': ':0', 16:31:39 INFO - 'HOME': '/home/cltbld', 16:31:39 INFO - 'LANG': 'en_US.UTF-8', 16:31:39 INFO - 'LANGUAGE': 'en_US:en', 16:31:39 INFO - 'LOGNAME': 'cltbld', 16:31:39 INFO - 'MAIL': '/var/mail/cltbld', 16:31:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:39 INFO - 'MOZ_NO_REMOTE': '1', 16:31:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:39 INFO - 'NO_EM_RESTART': '1', 16:31:39 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:39 INFO - 'PWD': '/builds/slave/test', 16:31:39 INFO - 'SHELL': '/bin/bash', 16:31:39 INFO - 'SHLVL': '1', 16:31:39 INFO - 'TERM': 'linux', 16:31:39 INFO - 'TMOUT': '86400', 16:31:39 INFO - 'USER': 'cltbld', 16:31:39 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', 16:31:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:39 INFO - '_': '/tools/buildbot/bin/python'} 16:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:40 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)) 16:31:40 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)) 16:31:40 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)) 16:31:40 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)) 16:31:40 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)) 16:31:40 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)) 16:31:40 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)) 16:31:40 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)) 16:31:40 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)) 16:31:40 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)) 16:31:40 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)) 16:31:40 INFO - Cleaning up... 16:31:40 INFO - Return code: 0 16:31:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:31:40 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')]} 16:31:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:31:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:40 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')]} 16:31:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:31:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:31:40 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 0x229b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23fe8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x255c180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x255a3b0>, '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 0x255b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b740>, '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': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', '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 16:31:40 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 16:31:40 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 16:31:40 INFO - Using env: {'DISPLAY': ':0', 16:31:40 INFO - 'HOME': '/home/cltbld', 16:31:40 INFO - 'LANG': 'en_US.UTF-8', 16:31:40 INFO - 'LANGUAGE': 'en_US:en', 16:31:40 INFO - 'LOGNAME': 'cltbld', 16:31:40 INFO - 'MAIL': '/var/mail/cltbld', 16:31:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:40 INFO - 'MOZ_NO_REMOTE': '1', 16:31:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:40 INFO - 'NO_EM_RESTART': '1', 16:31:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:40 INFO - 'PWD': '/builds/slave/test', 16:31:40 INFO - 'SHELL': '/bin/bash', 16:31:40 INFO - 'SHLVL': '1', 16:31:40 INFO - 'TERM': 'linux', 16:31:40 INFO - 'TMOUT': '86400', 16:31:40 INFO - 'USER': 'cltbld', 16:31:40 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', 16:31:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:40 INFO - '_': '/tools/buildbot/bin/python'} 16:31:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:31:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 16:31:40 INFO - Cleaning up... 16:31:40 INFO - Return code: 0 16:31:40 INFO - Running post-action listener: _resource_record_post_action 16:31:40 INFO - Running post-action listener: _start_resource_monitoring 16:31:40 INFO - Starting resource monitoring. 16:31:40 INFO - ##### 16:31:40 INFO - ##### Finished create-virtualenv step (success) 16:31:40 INFO - ##### 16:31:40 INFO - ##### 16:31:40 INFO - ##### Running install step. 16:31:40 INFO - ##### 16:31:40 INFO - Running pre-action listener: _resource_record_pre_action 16:31:40 INFO - Running main action method: install 16:31:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:31:40 INFO - Reading from file tmpfile_stdout 16:31:40 INFO - Detecting whether we're running mozinstall >=1.0... 16:31:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:31:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:31:40 INFO - Reading from file tmpfile_stdout 16:31:40 INFO - Output received: 16:31:40 INFO - Usage: mozinstall [options] installer 16:31:40 INFO - Options: 16:31:40 INFO - -h, --help show this help message and exit 16:31:40 INFO - -d DEST, --destination=DEST 16:31:40 INFO - Directory to install application into. [default: 16:31:40 INFO - "/builds/slave/test"] 16:31:40 INFO - --app=APP Application being installed. [default: firefox] 16:31:40 INFO - mkdir: /builds/slave/test/build/application 16:31:40 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'] 16:31:40 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 16:31:56 INFO - Reading from file tmpfile_stdout 16:31:56 INFO - Output received: 16:31:56 INFO - /builds/slave/test/build/application/firefox/firefox 16:31:56 INFO - Running post-action listener: _resource_record_post_action 16:31:56 INFO - ##### 16:31:56 INFO - ##### Finished install step (success) 16:31:56 INFO - ##### 16:31:56 INFO - ##### 16:31:56 INFO - ##### Running run-tests step. 16:31:56 INFO - ##### 16:31:56 INFO - Running pre-action listener: _resource_record_pre_action 16:31:56 INFO - Running main action method: run_tests 16:31:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:31:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:31:56 INFO - Python 2.7.3 16:31:56 INFO - Return code: 0 16:31:56 INFO - grabbing minidump binary from tooltool 16:31:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:31:56 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 0x255a3b0>, '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 0x255b2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x255b740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:31:56 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 16:31:56 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 16:31:56 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 16:31:56 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:31:56 INFO - Return code: 0 16:31:56 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:31:56 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:31:56 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:31:56 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:31:56 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:31:56 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/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 16:31:56 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/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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 16:31:56 INFO - Using env: {'DISPLAY': ':0', 16:31:56 INFO - 'HOME': '/home/cltbld', 16:31:56 INFO - 'LANG': 'en_US.UTF-8', 16:31:56 INFO - 'LANGUAGE': 'en_US:en', 16:31:56 INFO - 'LOGNAME': 'cltbld', 16:31:56 INFO - 'MAIL': '/var/mail/cltbld', 16:31:56 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:31:56 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:31:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:31:56 INFO - 'MOZ_NO_REMOTE': '1', 16:31:56 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:31:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:31:56 INFO - 'NO_EM_RESTART': '1', 16:31:56 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:31:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:31:56 INFO - 'PWD': '/builds/slave/test', 16:31:56 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:31:56 INFO - 'SHELL': '/bin/bash', 16:31:56 INFO - 'SHLVL': '1', 16:31:56 INFO - 'TERM': 'linux', 16:31:56 INFO - 'TMOUT': '86400', 16:31:56 INFO - 'USER': 'cltbld', 16:31:56 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138', 16:31:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:31:56 INFO - '_': '/tools/buildbot/bin/python'} 16:31:56 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/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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 16:31:57 INFO - mozversion application_buildid: 20160704150324 16:31:57 INFO - mozversion application_changeset: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 16:31:57 INFO - mozversion application_display_name: Nightly 16:31:57 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:31:57 INFO - mozversion application_name: Firefox 16:31:57 INFO - mozversion application_remotingname: firefox 16:31:57 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:31:57 INFO - mozversion application_vendor: Mozilla 16:31:57 INFO - mozversion application_version: 50.0a1 16:31:57 INFO - mozversion platform_buildid: 20160704150324 16:31:57 INFO - mozversion platform_changeset: c9a70b64f2faa264296f0cc90d68a2ee2bac6ac5 16:31:57 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:31:57 INFO - mozversion platform_version: 50.0a1 16:31:57 INFO - using testdate: 1467675117 16:31:57 INFO - actual date: 1467675117 16:31:57 INFO - starting webserver on 'localhost:58774' 16:31:57 INFO - SUITE-START | Running 2 tests 16:31:57 INFO - TEST-START | dromaeo_css 16:31:57 INFO - operating with platform_type : linux_ 16:31:57 INFO - Initialising browser for dromaeo_css test... 16:31:57 INFO - TEST-INFO | started process 3844 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppp76Gg/profile http://localhost:58774/getInfo.html) 16:32:01 INFO - PROCESS | 3844 | __metrics Screen width/height:1600/1200 16:32:01 INFO - PROCESS | 3844 | colorDepth:24 16:32:01 INFO - PROCESS | 3844 | Browser inner width/height: 1024/697 16:32:01 INFO - PROCESS | 3844 | __metrics 16:32:03 INFO - PROCESS | 3844 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:32:04 INFO - TEST-INFO | 3844: exit 0 16:32:04 INFO - Browser initialized. 16:32:04 INFO - Running cycle 1/1 for dromaeo_css test... 16:32:04 INFO - TEST-INFO | started process 3930 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmppp76Gg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:32:16 INFO - PROCESS | 3930 | RSS: Main: 158580736 16:32:16 INFO - PROCESS | 3930 | 16:33:07 INFO - PROCESS | 3930 | 1467675187331 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] 16:35:20 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:58774/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58774/tests/dromaeo/cssquery-ext.html) 16:35:21 INFO - PROCESS | 3930 | RSS: Main: 271106048 16:35:21 INFO - PROCESS | 3930 | 16:38:24 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:58774/tests/dromaeo/cssquery-ext.html (next: http://localhost:58774/tests/dromaeo/cssquery-jquery.html) 16:38:24 INFO - PROCESS | 3930 | RSS: Main: 240459776 16:38:24 INFO - PROCESS | 3930 | 16:41:26 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:58774/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58774/tests/dromaeo/cssquery-mootools.html) 16:41:27 INFO - PROCESS | 3930 | RSS: Main: 241233920 16:41:27 INFO - PROCESS | 3930 | 16:44:29 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:58774/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58774/tests/dromaeo/cssquery-prototype.html) 16:44:30 INFO - PROCESS | 3930 | RSS: Main: 234770432 16:44:30 INFO - PROCESS | 3930 | 16:47:33 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:58774/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58774/tests/dromaeo/cssquery-yui.html) 16:47:34 INFO - PROCESS | 3930 | RSS: Main: 216813568 16:47:34 INFO - PROCESS | 3930 | 16:50:37 INFO - PROCESS | 3930 | Cycle 1(1): loaded http://localhost:58774/tests/dromaeo/cssquery-yui.html (next: http://localhost:58774/tests/dromaeo/cssquery-dojo.html) 16:50:37 INFO - PROCESS | 3930 | RSS: Main: 263917568 16:50:37 INFO - PROCESS | 3930 | 16:50:37 INFO - PROCESS | 3930 | __start_tp_report 16:50:37 INFO - PROCESS | 3930 | _x_x_mozilla_page_load 16:50:37 INFO - PROCESS | 3930 | _x_x_mozilla_page_load_details 16:50:37 INFO - PROCESS | 3930 | |i|pagename|runs| 16:50:37 INFO - PROCESS | 3930 | |0;dojo.html;2640.247529454106;2656.853873036983;2677.277135173503;2682.3026013236554;2686.7984901132413;4667.533246675331;4722.24444088945;4788.569028787409;4830.468648448672;4851.975740121295;4695.882602934928;4700.835470758524;4705.435347758265;4743.857684269469;4790.616750659948;4341.305391137419;4399.406080179183;4434.312681534351;4467.754273514972;4527.660425468087;4436.889077773049;4464.441944756905;4485.327200919855;4485.663575231854;4515.232410490208;4325.697201195918;4345.543717909637;4350.956490435086;4385.079133381993;4385.539518350559;4370.934435983431;4389.495208051083;4438.267685831834;4449.844255451076;4451.043025749479;4413.315936029889;4442.62237709795;4449.443819522559;4477.552244775529;4479.372887795711;4636.4899861015265;4756.762161891927;4835.178019736653;4858.222684370519;4898;5240.109181439165;5250.7637156328055;5261.105612045923;5268.394134674523;5276.3932147802725;5036.521530454601;5250.921236181461;5291.3650361956425;5297.205419187114;5300.496452836975;4790.592799612037;4852.951470485321;4855.927161092586;4901.1913034349645;4917.139500587455;5376.059189641797;5386.326709161355;5395.352557693023;5395.81114660985;5400.270963419966;5060.898782024339;5088.160453525127;5106.642535022513;5107.897842043139;5115.130427827278;5015.423226328946;5115.130427827278;5174.896502069938;5204.869878252998;5220.738963051832;5146.330976972969;5146.588272938156;5167.328247327899;5174.09453345663;5228;5020.071286811952;5133.589312854962;5144.228365745168;5146.639735218499;5149.253358263106;4347.543507931685;4353.216421044179;4387.648988080946;4391.802368893407;4416.933745993812;3813.9427908581392;3815.904602384907;3820.2168555446065;3856.845726170922;3862.478565393692;4462.44219472566;4468.061707041557;4470.351798989128;4475.4181956345465;4519.502854685982;5018.146915024455;5095.8980820383385;5129.051125541712;5149.897002059938;5203.713795741195;4422.358757980075;4431.40176076232;4435.356873253425;4436.423264975597;4469.754163520973;4605.6085232755595;4640.466346370143;4651.2557990721325;4657.836975705902;4696.459907110726;4736.8342108026745;4800.831970881002;4854.854354369375;4854.902901942012;4872.244802055687;5161.974190129175;5171.974140129275;5184.688918664892;5189.040027594907;5244.265802787689;4739.976300118477;4862.927056094232;4876.731779752147;4876.756162191948;4926.655134140576;5049;5085.694858308513;5101;5111.309973153725;5113.233015047773;5184.092783762751;5184.585233181261;5198.012377648235;5198.584113271005;5200.869978250574;4907.68100073494;4975.875603109951;5029.9245511318095;5046.571041461517;5048.1165795984825;4981.452040275639;5026.045051440215;5039.143345631325;5044.1424957756535;5096.541311281854;4926.827561035347;4957.876053098701;5000.6249531284575;5012.997400519837;5013.448520662797;4913.877153071202;4973.52751488608;5031.295618613324;5060.114479966065;5064.44291127983;4928.383952005999;4944.357233559758;4947.6536642434685;4948.826791062295;4983.551480366785 16:50:37 INFO - PROCESS | 3930 | |1;ext.html;546.5873690172755;581.5667327840756;588.1207594646004;588.5497594340328;599.3826358850383;39948.00129996748;40574.79712601437;40735.185296294054;40767.388489172685;41631;38005;42285.15429691404;42418;42453.57546424543;42495.36256956148;7489.251074892494;7921.801954951115;8063.354931605487;8066.475679080871;10259.281850270485;10051.346662466916;10409.843852342183;10411.479426028705;10419.895801042006;10421.322614030101;10459.00639439252;10513.316634418776;10513.789724205511;10528.947355263252;10533.473326333691;10420.63527776528;10465.424401657867;10470.633527826489;10473.47632618366;10476.633317833915;10234.078932896075;10245.641402550875;10312.071913527818;10312.278140530167;10315.948420257926;39261.411078833844;39525.80237098796;39645.20709585821;39676.80161599174;39730;2971.747401470878;2989.5515672649058;3230.2893363460003;3633.5458067741533;3715.4241092630414;29796.70707292047;29991.550126748116;30328.393432131455;30352.241193970105;31550.211244718837;3291.917702057444;3324.6841550052704;3391.9830400848086;3415.163284995167;3461.5846098468346;268003;269756;270410;271030.999999998;271089;52626.73686631543;53347.466525335025;53366;53396.46603533992;53438.73280633572;55683;55821.720891395285;55918;55922;55951;13678.589642310746;14063.367148478343;14150.29248537569;14151.080179788281;14167.079139855876;9656.75858103539;10233.641822536176;10383.94808025955;10447.268691191544;10597.152227821756;15964;16022.359105635876;16066.839331606769;16076.517704468884;16143.273552690158;4905.053812823249;5612.494875461228;5651.4348565143155;5959.910601340984;5984.461398474158;807.4670717326653;822.3256929318021;873.8988874018655;939.9441410314471;953.5422996961497;27179.184624461297;27992;28110.85944570264;28460.715392845806;28689;953.2469349214182;962.8026254617787;977.372142903352;986.8519722041751;1062.7024433158729;14371.568852934428;14759.77860332096;14767.852321476863;15133.621659458382;15141.621459463602;384557;388518;394671;395126;395726;50373;50485.24272135921;50538.241926371134;50605.24092138621;50612;1085.8751243606928;1113.9665810025713;1158.247139359423;1183.7691650128143;1210.8365370675021;24969.500609988063;27492.862535687193;28024;28024.29939251535;28420.85789571039;43076.56923430726;43638.12723745571;43704.344434834136;43705;43730.562694372646;314219;314343;315538;315959;318570;22222;22934.770652293264;24699.135530256353;25316.367090822878;25460.49079018372;42339.364909525764;42386.788066059475;42501.574984251;43223.13553728971;43538.34692479679;36052.639473604926;36381;36433.81783091067;36856.81571592125;37246.88259352224;34790;37126.814365927996;37778.43332349962;37922.62077379191;38084;36703.81648091743;36731.44902826513;36985.260294793414;37451.625483744814;37568.81215593904;32619.415251282375;34062.31875362429;34236;34392.656073439946;34704;25663.230103096936;25982.22053338403;26165;26234.86882565575;26595.468090638467 16:50:37 INFO - PROCESS | 3930 | |2;jquery.html;370.4387852403609;372.9030452082459;375.791435753157;380.4863434363611;390.4982098004065;17141.914290428547;17481.213345399457;18088.728669069973;18292.81707182928;18304.084795760224;17316.913415432937;17868.55328616785;18143.27426902922;18176.545586360313;18216;4869.707817530951;5049.368828896388;5073.112205364065;5093.923591146136;5096.821611243608;3702.2040261343805;3824.063104539378;4960.60315174787;4986;6026.819195424122;6049.455549000589;6055.2430946131735;6073.969630151865;6085.665288409135;6085.908711369333;5771.105478650795;5937.762489500415;5939.554533410012;5944.524438044946;5945.167676525247;3404.7446441516986;4910.705357678515;5212.50481204285;5249.370075590915;5255.02781985334;21119.788802111936;21516.677249841265;21804.563908721895;21807.345779626638;22003.22988695388;1857.1921214271836;1987.5428651410111;2021.2521367094123;2088.6136064828056;2439.3901524618846;13284.202947823162;13869.306534673226;13929.442822287197;13968.58094257174;14236;1735.9132043397906;1800.9909950450165;1817.7546031285872;1819.7088465845534;1863.3943968210385;68276;70952.64523677349;71646.283537165;72101;72743.63628181878;9370.85943710845;9379.24966002718;9659.275554333453;9830.115289623967;9920.065587210569;13325.400356983959;13451.32743362828;13496.865031349756;13515.053946223867;13541.458341666223;7208.459365547605;7227.819304517429;7312.378447831994;7417.369523590555;7432.368248698813;6915.723371065101;6921;6973.755918542928;7052.012718219454;7068.222495525488;6162.691865406712;6183.505319574513;6219.100177348896;6331;6391.712372943229;1619.4574817436292;1663.3928616055296;1752.835248468141;1812.755278037448;1828.2047309420445;822.6668199379261;875.8773771671971;901.6528636475005;942.58997336159;991.127807529384;17371.131443427777;17981.640367192584;18222.544436389195;18482.630347392977;18550.16524256412;883.9337049721297;912.4798864647088;927.8376284150247;935.7941252924346;964.1178321835582;10246.077852993118;10376.688699339033;10447.738806529745;10511.369317840954;10539.314944528582;379479;381003.8046385589;384611;387860;388835;51398.486015140115;60125.69937150374;72453.63773181206;88846.55576722205;89461.9999999987;916.5417291354323;929.5677509957767;940.2290122099812;944.0276515189366;952.7808604021114;16342.346306147621;16342.754858677366;16537.090460024334;16537.83462165411;16715.83284167143;37753.24493510059;38010.42984355292;38494.80752596219;39237;40247.79876100601;52810.471895280556;53935.46064539305;54214.728926355114;54874.451255486936;55350.72324638351;7522.962385188039;7678.8080297993;7825.569593672402;7863.488873223222;7921.485103468256;10602.681919542427;11659.067274618179;11685.883141168479;11898.405079746151;12026.098042647012;9743.756406089904;10093.5457904393;10236.795264094528;10619.256652034283;10971.890281097087;11038.668839934815;11172.664820055412;11175.441227938409;11208.103351732005;11390.715232119263;10345.793084138426;10864.185186111232;10898.727531811768;11136.554537818396;11303.095752339628;6946.687399067156;7144.821379465555;7182.712691492282;7371.078615173104;7905.169957154646;7884.448088633741;10452.790944181226;11006.724831879266;11046.950539698715;11108.389038602954 16:50:37 INFO - PROCESS | 3930 | |3;mootools.html;1247.7317376763995;1394.3864699532207;1409.8096756937814;1523.6495606010617;1717.5276798880313;6528.934710652892;7376.7418140365035;7644.541327520339;7661.080670319556;7669.884951725729;7316.414686825055;7561.962190189055;7615.9619201903915;7815.687372505107;7827.960860195691;2178.2593918067855;2223.2552095048177;2225.521512874732;2226.5880812049822;2226.7327920649545;2174.5650869826018;2198.0218802632835;2217.46780772615;2226.487907781211;2229.442639340165;2176.1621775616422;2180.7710190429934;2184.7487538932987;2188.5841690078832;2226.755056943735;2148.5488047510044;2160.4166874943758;2166.1876796201423;2168.382011126829;2168.728908886389;2120.162535798351;2163.0482587661536;2163.2104281937136;2164.0802658869916;2165.7725938776357;7470.925290747132;7676.884846727304;7734.922650773477;7813.453058285922;7821.335186509154;4550.271956486979;4649.465311489154;4659.930101048487;4660.231061874821;4667.369905062807;2851.3584443500254;2911.737943585066;2942.2938494761315;2949.159489545469;2963.7777166712367;936.1200471556715;950.334765664038;956.3401253135384;960.7646126699003;969.7042402067367;10319.638812641597;10537.78924421515;10546.947265263701;10574.471276436147;10600.469976501145;3994.8801535953967;4181.97909010453;4186.644135248477;4240.1307731914885;4333.739975601474;9091.227245684058;9139;9140.268778497704;9143.451392916446;9173.77065573366;4638.0491999140095;4651.139539185261;4653.371794807726;4656.3713898623255;4657.767111644472;3722;3819.961800382016;4219.641330486882;4230.809613567397;4241.024564350217;3708.517892673989;3742.66316031553;3785.205106927521;3808.923821523554;3945.1320709443876;1180.6812160716559;1194.035811090751;1200.9579664711694;1206.029146537046;1227.643983244849;742.2058397514716;752.4845480845638;809.688270016048;810.6392655268467;882.245679943639;5195.350581177353;5287.576993840484;5294.92057619136;5338.065838478251;5479.863003424946;864.4337958637103;878.5607196401799;936.5223735894742;947.275334369208;950.1828427552299;3512.8594856205978;3624.5469316335457;3657.707383409374;3685.4656074868994;3744.64425879541;9543.522823858779;9597.32818702698;9642.132208101304;9706.514674266258;9767;8949.239314658196;9337.206337461255;9341.20599749029;9632.75918102053;9654.372465789702;7173.7130514779865;7286.599237041907;7294.635268236673;7367.300106489982;7369;5263.578913686973;5278;5327.9200811987075;5419.132938729785;5468.589855760754;9061;9172;9292.62829486813;9304.534773261445;9311.208547273558;8020.83958320842;8739.475631462132;9142.63429462814;9146.039665835258;9254.398464099811;6541.8691626168165;6713.899291510534;6736.124303840469;6897.55165914214;6897.793066208022;7312.817179570553;7385.556866588022;7415.703371865281;7422;7457.179710231979;6683.398494135551;6720.260771315249;6797.538529216242;6879.759208427881;6886.8622627546165;6597.27429982692;6639.170103737033;6669.633170175687;6685.431738302299;6742.898856517254;6248.937510625017;6324.588901721373;6328.240611126695;6329.968350158404;6330.873382532415;4581.106684196549;4630.143423466669;4702.083093796677;4715.740634265148;4759.50025247344;4696.577308042292;4702.553257440538;4708.646851486221;4743.407074115736;4808.6153107752 16:50:37 INFO - PROCESS | 3930 | |4;prototype.html;305.16689437834714;308.1756301892437;312.8170020537985;315.0548354935194;317.70612183730043;4834.129856625806;4850.660453768238;4851.902961940764;4857.222844344897;4870.975645121774;4779.35478710374;4802.471728109905;4806.975965120169;4814.301926220696;4847.497275844491;3675.852965881368;3748.6063963283873;3792.2415516896594;3849.499565056539;3917.6278253565865;3829.3490106681793;3856.1709232515004;3869.8839034829;3892.143728379752;3896.454496370496;3631.5279013728177;3836.808159592023;3840.404737265714;3847.499825022743;3856.6914646828186;3684.2631473705233;3783.9621603783885;3814.6376094271277;3826.1391186982705;3839.1361943562756;3388.3731509670542;3402.5406570112964;3418.453047512386;3423.8288085595623;3426.5716785401823;4680.321353403771;4695.859124226278;4727.361806156159;4740;4742.146413645542;4257.998740591916;4341.5007274163245;4389.407429996942;4390.682795161439;4393.857597024797;4995.8509542804995;5044.319016932704;5051.520105589963;5065.594752419797;5078.187490001582;3718.1819999600043;3736.9252614947823;3747.7938713370754;3753.2118255166447;3762.9811850940846;5112.667676601009;5228.529432351069;5272.393674727378;5336.359636843565;5348.679079255257;3773.6792372648083;3787.0910981364273;3789.374753165697;3792.6965842732516;3797.0697179190724;3847.249786291646;3848.2111167210655;3860.2665493556133;3862.343401621731;3864.3237433449035;4333.609975102193;4355.695101342939;4384.364267181305;4385.144896745104;4394.472663280427;4858.7570621468785;5097.974510127426;5100.5409513143995;5102.591792656579;5117.155669314521;1290.5547586082787;1308.1562392256942;1311.2853494845333;1313.7897936330141;1322.1141834970592;818.3167055508598;824.1058451580103;860.8708693695995;890.3589415620743;897.9685711000084;4435.977820110943;4443.977780111143;4451.310046942729;4463.910721785611;4465.843695470643;5173.22401639757;5188.610854185876;5192.844214673566;5200.63595548308;5229.790808367623;4272.871813845528;4428.070105277863;4457;4457.459248228479;4508.18852606534;2750.3674154944474;2755.5453350196995;2765.184270640166;2765.889364425441;2779.9722002779713;4848.733319667452;4867.756612169448;4873.366462359871;4877.341558889504;4895.534924182197;5098.527214301061;5239.42817154852;5262.973685131627;5287.867803304948;5318.468153184728;4833.154198015333;4841.176999909953;4842.7820748065715;4859.1496488114435;4868.610511159028;5169.940162266802;5173.689578625294;5179.559737422211;5203.349581302337;5203.921941170961;4964.280179374043;5049.419316778617;5090.49095090488;5092.134337162617;5138;4805.711657300573;4834.444038935568;4849.636277279147;4851.539103785135;4852.320675105418;3721.7022638189424;3733.1973625669525;3737.177820879402;3738.607446218217;3752.981235093807;4941.678790878582;5112.284280200849;5144.742762861917;5204.947950520446;5209.47905209476;4966.503349665005;4979.278004689228;4982.601391888567;4993.975030124826;5002.949380629962;4965.950340496694;4988.600911926965;4989.750512474435;4993.27597498368;5010.624203184849;4708.915660242546;4813.518648135158;4853.150698627655;4915.827946021872;5017.297578339108;5016.473270306566;5132.9743351283005;5136.30659860914;5140.46025167352;5146.948530514647;5007.674501157413;5013.473585273494;5018.498150185098;5035.230623157322;5087.364079490064 16:50:37 INFO - PROCESS | 3930 | |5;yui.html;664.3754870421803;665.4210836572183;675.0886303490287;690.9827254318639;697.0380874393336;13050.086493945428;13322.46710131596;13549.59351219465;13601.795973060413;13624;13473.865261347384;13607.659808504792;13616;13629.454821807116;13646.317684115804;626.9435750782452;644.5842431631595;649.1301655781252;766.2720415605183;793.175097898188;638.1289539778215;640.4588123036027;780.1613265739325;803.1245941923303;809.8258874342015;826.1614461321764;827.3133299361516;829.0548774397162;830.0951962361025;831.8585840407115;838.0948575538404;838.4298676899706;838.6058552480355;838.828040251747;839.983200335996;488.6921239619053;491.86965454154677;495.96528243023005;496.7342471777618;593.2169536212201;13496.392662330121;14037.64905877351;14090.295485225697;14119.435222591084;14138.08102473336;13247.138935969131;13679.24764137972;13771.655708607264;13826.30868456573;13923.86076139246;11278.266912650652;11490.195686301962;11808.46861891217;11984.70038249042;12306.507739690402;4273.337632666941;4285.678574106954;4377.255866502702;4516.16450956574;4518.502964673883;64218.789060546784;64799;65472.67263663699;65641.343586564;67657.3234267656;10992.395418251914;11213.887861121284;11257;11547.307161570332;11676.766464670829;20568.691469627967;20733.170673173205;20757.481062973548;20765.065572049294;21075.78924210769;6456.806295811133;6752.831179220559;7069.434445244368;7131.144262688511;7261.346478816932;3622.1487950331652;3630.8729194478065;3641.089727568108;3670.6329367063613;3678.8528458861883;2996.4007198560375;3091.7372023377816;3102.612173478315;3122.640896296955;3125.3905488429536;530.4827792901967;533.2028617217208;534.0280689145718;537.5430883748783;552.5607142321863;448.76439869069;448.88777805548614;514.8827045311608;539.4605394605395;561.0602241245897;7798.844023119505;7949.205079492004;8109.310708589836;8349.248567628943;8553.914460855312;539.6708008115125;540.41635034163;552.4061633743661;559.4154108956151;567.5998421113188;3777.320082385197;3883.7475564088245;3929.7052721045466;3992.4210989406956;4041.333180025322;51679.7416012925;51961.50925792671;52314.47685523172;52341.47658523442;52367;80295;85024;85177.57411213029;85878;85944;65501.67249163723;66976.66511667508;72833.6358318205;74266;76217.23782762101;8595.957020214859;9219.354645174773;9406.905930940877;9535.897194361907;9544;42514.36228456638;42952.57047429486;43124;46733.532664672915;47272;43672;55025.44974550203;64282.357176427635;65667.67166164139;65947.67026164838;10701.732456688645;11182.88817111851;11199.384033877888;11529.192956492965;11635.243709158878;12652.683682908;12659.430325635552;13034.804477932648;13414.731705366034;13580.93209533946;12565.308908009782;12704.110712250054;13110.737785244433;13432.126911750705;13492.392842322315;12901.677458063623;12909.289989050692;13304.667383315495;13440.529581464602;13514.59456216315;11764.647060588197;12219.144659873724;12416.441260143134;13216.801747973595;13345.065845391118;10259.230557708352;10302;10345.224108192066;10427.061564459234;10851.620193293196;9594.603347001079;10135.647316975805;10139.481498116244;10160.745981350525;10247.231457640855 16:50:37 INFO - PROCESS | 3930 | __end_tp_report 16:50:37 INFO - PROCESS | 3930 | __start_cc_report 16:50:37 INFO - PROCESS | 3930 | _x_x_mozilla_cycle_collect,1140 16:50:37 INFO - PROCESS | 3930 | __end_cc_report 16:50:37 INFO - PROCESS | 3930 | __startTimestamp1467676237299__endTimestamp 16:50:37 INFO - PROCESS | 3930 | 16:50:37 INFO - PROCESS | 3930 | ------- Summary: start ------- 16:50:37 INFO - PROCESS | 3930 | Number of tests: 6 16:50:37 INFO - PROCESS | 3930 | 16:50:37 INFO - PROCESS | 3930 | [#0] dojo.html Cycles:165 Average:4770.54 Median:4901.19 stddev:510.45 (10.4%) stddev-sans-first:483.88 16:50:37 INFO - PROCESS | 3930 | Values: 2640.2 2656.9 2677.3 2682.3 2686.8 4667.5 4722.2 4788.6 4830.5 4852.0 4695.9 4700.8 4705.4 4743.9 4790.6 4341.3 4399.4 4434.3 4467.8 4527.7 4436.9 4464.4 4485.3 4485.7 4515.2 4325.7 4345.5 4351.0 4385.1 4385.5 4370.9 4389.5 4438.3 4449.8 4451.0 4413.3 4442.6 4449.4 4477.6 4479.4 4636.5 4756.8 4835.2 4858.2 4898.0 5240.1 5250.8 5261.1 5268.4 5276.4 5036.5 5250.9 5291.4 5297.2 5300.5 4790.6 4853.0 4855.9 4901.2 4917.1 5376.1 5386.3 5395.4 5395.8 5400.3 5060.9 5088.2 5106.6 5107.9 5115.1 5015.4 5115.1 5174.9 5204.9 5220.7 5146.3 5146.6 5167.3 5174.1 5228.0 5020.1 5133.6 5144.2 5146.6 5149.3 4347.5 4353.2 4387.6 4391.8 4416.9 3813.9 3815.9 3820.2 3856.8 3862.5 4462.4 4468.1 4470.4 4475.4 4519.5 5018.1 5095.9 5129.1 5149.9 5203.7 4422.4 4431.4 4435.4 4436.4 4469.8 4605.6 4640.5 4651.3 4657.8 4696.5 4736.8 4800.8 4854.9 4854.9 4872.2 5162.0 5172.0 5184.7 5189.0 5244.3 4740.0 4862.9 4876.7 4876.8 4926.7 5049.0 5085.7 5101.0 5111.3 5113.2 5184.1 5184.6 5198.0 5198.6 5200.9 4907.7 4975.9 5029.9 5046.6 5048.1 4981.5 5026.0 5039.1 5044.1 5096.5 4926.8 4957.9 5000.6 5013.0 5013.4 4913.9 4973.5 5031.3 5060.1 5064.4 4928.4 4944.4 4947.7 4948.8 4983.6 16:50:37 INFO - PROCESS | 3930 | 16:50:37 INFO - PROCESS | 3930 | [#1] ext.html Cycles:180 Average:48537.13 Median:34314.33 stddev:86648.87 (252.5%) stddev-sans-first:86817.02 16:50:37 INFO - PROCESS | 3930 | Values: 546.6 581.6 588.1 588.5 599.4 39948.0 40574.8 40735.2 40767.4 41631.0 38005.0 42285.2 42418.0 42453.6 42495.4 7489.3 7921.8 8063.4 8066.5 10259.3 10051.3 10409.8 10411.5 10419.9 10421.3 10459.0 10513.3 10513.8 10528.9 10533.5 10420.6 10465.4 10470.6 10473.5 10476.6 10234.1 10245.6 10312.1 10312.3 10315.9 39261.4 39525.8 39645.2 39676.8 39730.0 2971.7 2989.6 3230.3 3633.5 3715.4 29796.7 29991.6 30328.4 30352.2 31550.2 3291.9 3324.7 3392.0 3415.2 3461.6 268003.0 269756.0 270410.0 271031.0 271089.0 52626.7 53347.5 53366.0 53396.5 53438.7 55683.0 55821.7 55918.0 55922.0 55951.0 13678.6 14063.4 14150.3 14151.1 14167.1 9656.8 10233.6 10383.9 10447.3 10597.2 15964.0 16022.4 16066.8 16076.5 16143.3 4905.1 5612.5 5651.4 5959.9 5984.5 807.5 822.3 873.9 939.9 953.5 27179.2 27992.0 28110.9 28460.7 28689.0 953.2 962.8 977.4 986.9 1062.7 14371.6 14759.8 14767.9 15133.6 15141.6 384557.0 388518.0 394671.0 395126.0 395726.0 50373.0 50485.2 50538.2 50605.2 50612.0 1085.9 1114.0 1158.2 1183.8 1210.8 24969.5 27492.9 28024.0 28024.3 28420.9 43076.6 43638.1 43704.3 43705.0 43730.6 314219.0 314343.0 315538.0 315959.0 318570.0 22222.0 22934.8 24699.1 25316.4 25460.5 42339.4 42386.8 42501.6 43223.1 43538.3 36052.6 36381.0 36433.8 36856.8 37246.9 34790.0 37126.8 37778.4 37922.6 38084.0 36703.8 36731.4 36985.3 37451.6 37568.8 32619.4 34062.3 34236.0 34392.7 34704.0 25663.2 25982.2 26165.0 26234.9 26595.5 16:50:37 INFO - PROCESS | 3930 | 16:50:37 INFO - PROCESS | 3930 | [#2] jquery.html Cycles:180 Average:24601.01 Median:213177.40 stddev:63474.26 (29.8%) stddev-sans-first:63626.25 16:50:37 INFO - PROCESS | 3930 | Values: 370.4 372.9 375.8 380.5 390.5 17141.9 17481.2 18088.7 18292.8 18304.1 17316.9 17868.6 18143.3 18176.5 18216.0 4869.7 5049.4 5073.1 5093.9 5096.8 3702.2 3824.1 4960.6 4986.0 6026.8 6049.5 6055.2 6074.0 6085.7 6085.9 5771.1 5937.8 5939.6 5944.5 5945.2 3404.7 4910.7 5212.5 5249.4 5255.0 21119.8 21516.7 21804.6 21807.3 22003.2 1857.2 1987.5 2021.3 2088.6 2439.4 13284.2 13869.3 13929.4 13968.6 14236.0 1735.9 1801.0 1817.8 1819.7 1863.4 68276.0 70952.6 71646.3 72101.0 72743.6 9370.9 9379.2 9659.3 9830.1 9920.1 13325.4 13451.3 13496.9 13515.1 13541.5 7208.5 7227.8 7312.4 7417.4 7432.4 6915.7 6921.0 6973.8 7052.0 7068.2 6162.7 6183.5 6219.1 6331.0 6391.7 1619.5 1663.4 1752.8 1812.8 1828.2 822.7 875.9 901.7 942.6 991.1 17371.1 17981.6 18222.5 18482.6 18550.2 883.9 912.5 927.8 935.8 964.1 10246.1 10376.7 10447.7 10511.4 10539.3 379479.0 381003.8 384611.0 387860.0 388835.0 51398.5 60125.7 72453.6 88846.6 89462.0 916.5 929.6 940.2 944.0 952.8 16342.3 16342.8 16537.1 16537.8 16715.8 37753.2 38010.4 38494.8 39237.0 40247.8 52810.5 53935.5 54214.7 54874.5 55350.7 7523.0 7678.8 7825.6 7863.5 7921.5 10602.7 11659.1 11685.9 11898.4 12026.1 9743.8 10093.5 10236.8 10619.3 10971.9 11038.7 11172.7 11175.4 11208.1 11390.7 10345.8 10864.2 10898.7 11136.6 11303.1 6946.7 7144.8 7182.7 7371.1 7905.2 7884.4 10452.8 11006.7 11047.0 11108.4 16:50:37 INFO - PROCESS | 3930 | 16:50:37 INFO - PROCESS | 3930 | [#3] mootools.html Cycles:180 Average:5137.38 Median:5332.99 stddev:2845.90 (53.4%) stddev-sans-first:2838.87 16:50:37 INFO - PROCESS | 3930 | Values: 1247.7 1394.4 1409.8 1523.6 1717.5 6528.9 7376.7 7644.5 7661.1 7669.9 7316.4 7562.0 7616.0 7815.7 7828.0 2178.3 2223.3 2225.5 2226.6 2226.7 2174.6 2198.0 2217.5 2226.5 2229.4 2176.2 2180.8 2184.7 2188.6 2226.8 2148.5 2160.4 2166.2 2168.4 2168.7 2120.2 2163.0 2163.2 2164.1 2165.8 7470.9 7676.9 7734.9 7813.5 7821.3 4550.3 4649.5 4659.9 4660.2 4667.4 2851.4 2911.7 2942.3 2949.2 2963.8 936.1 950.3 956.3 960.8 969.7 10319.6 10537.8 10546.9 10574.5 10600.5 3994.9 4182.0 4186.6 4240.1 4333.7 9091.2 9139.0 9140.3 9143.5 9173.8 4638.0 4651.1 4653.4 4656.4 4657.8 3722.0 3820.0 4219.6 4230.8 4241.0 3708.5 3742.7 3785.2 3808.9 3945.1 1180.7 1194.0 1201.0 1206.0 1227.6 742.2 752.5 809.7 810.6 882.2 5195.4 5287.6 5294.9 5338.1 5479.9 864.4 878.6 936.5 947.3 950.2 3512.9 3624.5 3657.7 3685.5 3744.6 9543.5 9597.3 9642.1 9706.5 9767.0 8949.2 9337.2 9341.2 9632.8 9654.4 7173.7 7286.6 7294.6 7367.3 7369.0 5263.6 5278.0 5327.9 5419.1 5468.6 9061.0 9172.0 9292.6 9304.5 9311.2 8020.8 8739.5 9142.6 9146.0 9254.4 6541.9 6713.9 6736.1 6897.6 6897.8 7312.8 7385.6 7415.7 7422.0 7457.2 6683.4 6720.3 6797.5 6879.8 6886.9 6597.3 6639.2 6669.6 6685.4 6742.9 6248.9 6324.6 6328.2 6330.0 6330.9 4581.1 4630.1 4702.1 4715.7 4759.5 4696.6 4702.6 4708.6 4743.4 4808.6 16:50:37 INFO - PROCESS | 3930 | 16:50:37 INFO - PROCESS | 3930 | [#4] prototype.html Cycles:180 Average:4215.00 Median:4813.91 stddev:1201.24 (25.0%) stddev-sans-first:1168.22 16:50:37 INFO - PROCESS | 3930 | Values: 305.2 308.2 312.8 315.1 317.7 4834.1 4850.7 4851.9 4857.2 4871.0 4779.4 4802.5 4807.0 4814.3 4847.5 3675.9 3748.6 3792.2 3849.5 3917.6 3829.3 3856.2 3869.9 3892.1 3896.5 3631.5 3836.8 3840.4 3847.5 3856.7 3684.3 3784.0 3814.6 3826.1 3839.1 3388.4 3402.5 3418.5 3423.8 3426.6 4680.3 4695.9 4727.4 4740.0 4742.1 4258.0 4341.5 4389.4 4390.7 4393.9 4995.9 5044.3 5051.5 5065.6 5078.2 3718.2 3736.9 3747.8 3753.2 3763.0 5112.7 5228.5 5272.4 5336.4 5348.7 3773.7 3787.1 3789.4 3792.7 3797.1 3847.2 3848.2 3860.3 3862.3 3864.3 4333.6 4355.7 4384.4 4385.1 4394.5 4858.8 5098.0 5100.5 5102.6 5117.2 1290.6 1308.2 1311.3 1313.8 1322.1 818.3 824.1 860.9 890.4 898.0 4436.0 4444.0 4451.3 4463.9 4465.8 5173.2 5188.6 5192.8 5200.6 5229.8 4272.9 4428.1 4457.0 4457.5 4508.2 2750.4 2755.5 2765.2 2765.9 2780.0 4848.7 4867.8 4873.4 4877.3 4895.5 5098.5 5239.4 5263.0 5287.9 5318.5 4833.2 4841.2 4842.8 4859.1 4868.6 5169.9 5173.7 5179.6 5203.3 5203.9 4964.3 5049.4 5090.5 5092.1 5138.0 4805.7 4834.4 4849.6 4851.5 4852.3 3721.7 3733.2 3737.2 3738.6 3753.0 4941.7 5112.3 5144.7 5204.9 5209.5 4966.5 4979.3 4982.6 4994.0 5002.9 4966.0 4988.6 4989.8 4993.3 5010.6 4708.9 4813.5 4853.2 4915.8 5017.3 5016.5 5133.0 5136.3 5140.5 5146.9 5007.7 5013.5 5018.5 5035.2 5087.4 16:50:37 INFO - PROCESS | 3930 | 16:50:37 INFO - PROCESS | 3930 | [#5] yui.html Cycles:180 Average:16786.00 Median:2413.01 stddev:22012.23 (912.2%) stddev-sans-first:22040.70 16:50:37 INFO - PROCESS | 3930 | Values: 664.4 665.4 675.1 691.0 697.0 13050.1 13322.5 13549.6 13601.8 13624.0 13473.9 13607.7 13616.0 13629.5 13646.3 626.9 644.6 649.1 766.3 793.2 638.1 640.5 780.2 803.1 809.8 826.2 827.3 829.1 830.1 831.9 838.1 838.4 838.6 838.8 840.0 488.7 491.9 496.0 496.7 593.2 13496.4 14037.6 14090.3 14119.4 14138.1 13247.1 13679.2 13771.7 13826.3 13923.9 11278.3 11490.2 11808.5 11984.7 12306.5 4273.3 4285.7 4377.3 4516.2 4518.5 64218.8 64799.0 65472.7 65641.3 67657.3 10992.4 11213.9 11257.0 11547.3 11676.8 20568.7 20733.2 20757.5 20765.1 21075.8 6456.8 6752.8 7069.4 7131.1 7261.3 3622.1 3630.9 3641.1 3670.6 3678.9 2996.4 3091.7 3102.6 3122.6 3125.4 530.5 533.2 534.0 537.5 552.6 448.8 448.9 514.9 539.5 561.1 7798.8 7949.2 8109.3 8349.2 8553.9 539.7 540.4 552.4 559.4 567.6 3777.3 3883.7 3929.7 3992.4 4041.3 51679.7 51961.5 52314.5 52341.5 52367.0 80295.0 85024.0 85177.6 85878.0 85944.0 65501.7 66976.7 72833.6 74266.0 76217.2 8596.0 9219.4 9406.9 9535.9 9544.0 42514.4 42952.6 43124.0 46733.5 47272.0 43672.0 55025.4 64282.4 65667.7 65947.7 10701.7 11182.9 11199.4 11529.2 11635.2 12652.7 12659.4 13034.8 13414.7 13580.9 12565.3 12704.1 13110.7 13432.1 13492.4 12901.7 12909.3 13304.7 13440.5 13514.6 11764.6 12219.1 12416.4 13216.8 13345.1 10259.2 10302.0 10345.2 10427.1 10851.6 9594.6 10135.6 10139.5 10160.7 10247.2 16:50:37 INFO - PROCESS | 3930 | -------- Summary: end -------- 16:50:37 INFO - PROCESS | 3930 | 16:50:38 INFO - TEST-INFO | 3930: exit 0 16:50:38 INFO - TEST-OK | dromaeo_css | took 1120856ms 16:50:38 INFO - TEST-START | kraken 16:50:38 INFO - operating with platform_type : linux_ 16:50:38 INFO - Initialising browser for kraken test... 16:50:38 INFO - TEST-INFO | started process 4118 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWIBHts/profile http://localhost:58774/getInfo.html) 16:50:41 INFO - PROCESS | 4118 | __metrics Screen width/height:1600/1200 16:50:41 INFO - PROCESS | 4118 | colorDepth:24 16:50:41 INFO - PROCESS | 4118 | Browser inner width/height: 1024/697 16:50:41 INFO - PROCESS | 4118 | __metrics 16:50:42 INFO - PROCESS | 4118 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:50:43 INFO - TEST-INFO | 4118: exit 0 16:50:43 INFO - Browser initialized. 16:50:43 INFO - Running cycle 1/1 for kraken test... 16:50:43 INFO - TEST-INFO | started process 4200 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWIBHts/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:50:55 INFO - PROCESS | 4200 | RSS: Main: 158646272 16:50:55 INFO - PROCESS | 4200 | 16:50:58 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58774/tests/kraken/driver.html?testName=audio-beat-detection) 16:50:59 INFO - PROCESS | 4200 | RSS: Main: 216977408 16:50:59 INFO - PROCESS | 4200 | 16:51:02 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58774/tests/kraken/driver.html?testName=audio-dft) 16:51:02 INFO - PROCESS | 4200 | RSS: Main: 204296192 16:51:02 INFO - PROCESS | 4200 | 16:51:05 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58774/tests/kraken/driver.html?testName=audio-fft) 16:51:06 INFO - PROCESS | 4200 | RSS: Main: 271241216 16:51:06 INFO - PROCESS | 4200 | 16:51:08 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58774/tests/kraken/driver.html?testName=audio-oscillator) 16:51:09 INFO - PROCESS | 4200 | RSS: Main: 181501952 16:51:09 INFO - PROCESS | 4200 | 16:51:11 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58774/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:51:12 INFO - PROCESS | 4200 | RSS: Main: 186105856 16:51:12 INFO - PROCESS | 4200 | 16:51:15 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58774/tests/kraken/driver.html?testName=imaging-darkroom) 16:51:15 INFO - PROCESS | 4200 | RSS: Main: 221831168 16:51:15 INFO - PROCESS | 4200 | 16:51:19 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58774/tests/kraken/driver.html?testName=imaging-desaturate) 16:51:19 INFO - PROCESS | 4200 | RSS: Main: 217952256 16:51:19 INFO - PROCESS | 4200 | 16:51:22 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58774/tests/kraken/driver.html?testName=json-parse-financial) 16:51:23 INFO - PROCESS | 4200 | RSS: Main: 220356608 16:51:23 INFO - PROCESS | 4200 | 16:51:25 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58774/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:51:25 INFO - PROCESS | 4200 | RSS: Main: 207384576 16:51:25 INFO - PROCESS | 4200 | 16:51:27 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58774/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:51:28 INFO - PROCESS | 4200 | RSS: Main: 212439040 16:51:28 INFO - PROCESS | 4200 | 16:51:30 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58774/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:51:31 INFO - PROCESS | 4200 | RSS: Main: 211111936 16:51:31 INFO - PROCESS | 4200 | 16:51:33 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:51:34 INFO - PROCESS | 4200 | RSS: Main: 225525760 16:51:34 INFO - PROCESS | 4200 | 16:51:37 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:51:37 INFO - PROCESS | 4200 | RSS: Main: 226746368 16:51:37 INFO - PROCESS | 4200 | 16:51:39 INFO - PROCESS | 4200 | Cycle 1(1): loaded http://localhost:58774/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58774/tests/kraken/driver.html?testName=ai-astar) 16:51:39 INFO - PROCESS | 4200 | RSS: Main: 269381632 16:51:39 INFO - PROCESS | 4200 | 16:51:39 INFO - PROCESS | 4200 | __start_tp_report 16:51:39 INFO - PROCESS | 4200 | _x_x_mozilla_page_load 16:51:39 INFO - PROCESS | 4200 | _x_x_mozilla_page_load_details 16:51:39 INFO - PROCESS | 4200 | |i|pagename|runs| 16:51:39 INFO - PROCESS | 4200 | |0;ai-astar;103;115;114;114;114;112;112;112;111;113 16:51:39 INFO - PROCESS | 4200 | |1;audio-beat-detection;144;120;126;174;121;121;145;120;155;123 16:51:39 INFO - PROCESS | 4200 | |2;audio-dft;169;162;161;159;162;161;162;161;161;162 16:51:39 INFO - PROCESS | 4200 | |3;audio-fft;76;75;77;124;76;77;76;76;101;75 16:51:39 INFO - PROCESS | 4200 | |4;audio-oscillator;85;85;119;85;85;85;118;86;84;123 16:51:39 INFO - PROCESS | 4200 | |5;imaging-gaussian-blur;116;117;117;117;117;117;117;117;117;116 16:51:39 INFO - PROCESS | 4200 | |6;imaging-darkroom;146;146;147;147;147;146;147;146;146;146 16:51:39 INFO - PROCESS | 4200 | |7;imaging-desaturate;95;95;94;95;95;95;95;95;95;95 16:51:39 INFO - PROCESS | 4200 | |8;json-parse-financial;65;66;65;66;65;67;66;65;64;64 16:51:39 INFO - PROCESS | 4200 | |9;json-stringify-tinderbox;65;63;63;64;64;63;64;64;64;63 16:51:39 INFO - PROCESS | 4200 | |10;stanford-crypto-aes;78;79;78;78;78;79;82;78;76;78 16:51:39 INFO - PROCESS | 4200 | |11;stanford-crypto-ccm;140;128;128;130;130;127;134;130;221;129 16:51:39 INFO - PROCESS | 4200 | |12;stanford-crypto-pbkdf2;167;171;169;168;167;168;170;165;166;166 16:51:39 INFO - PROCESS | 4200 | |13;stanford-crypto-sha256-iterative;72;67;67;65;66;66;66;65;66;68 16:51:39 INFO - PROCESS | 4200 | __end_tp_report 16:51:39 INFO - PROCESS | 4200 | __start_cc_report 16:51:39 INFO - PROCESS | 4200 | _x_x_mozilla_cycle_collect,1911 16:51:39 INFO - PROCESS | 4200 | __end_cc_report 16:51:39 INFO - PROCESS | 4200 | __startTimestamp1467676299986__endTimestamp 16:51:39 INFO - PROCESS | 4200 | 16:51:39 INFO - PROCESS | 4200 | ------- Summary: start ------- 16:51:39 INFO - PROCESS | 4200 | Number of tests: 14 16:51:39 INFO - PROCESS | 4200 | 16:51:39 INFO - PROCESS | 4200 | [#0] ai-astar Cycles:10 Average:112.00 Median:113.50 stddev:3.40 (3.0%) stddev-sans-first:1.32 16:51:39 INFO - PROCESS | 4200 | Values: 103.0 115.0 114.0 114.0 114.0 112.0 112.0 112.0 111.0 113.0 16:51:39 INFO - PROCESS | 4200 | 16:51:39 INFO - PROCESS | 4200 | [#1] audio-beat-detection Cycles:10 Average:134.90 Median:135.00 stddev:18.76 (13.9%) stddev-sans-first:19.61 16:51:39 INFO - PROCESS | 4200 | Values: 144.0 120.0 126.0 174.0 121.0 121.0 145.0 120.0 155.0 123.0 16:51:39 INFO - PROCESS | 4200 | 16:51:39 INFO - PROCESS | 4200 | [#2] audio-dft Cycles:10 Average:162.00 Median:162.00 stddev:2.62 (1.6%) stddev-sans-first:0.97 16:51:39 INFO - PROCESS | 4200 | Values: 169.0 162.0 161.0 159.0 162.0 161.0 162.0 161.0 161.0 162.0 16:51:39 INFO - PROCESS | 4200 | 16:51:39 INFO - PROCESS | 4200 | [#3] audio-fft Cycles:10 Average:83.30 Median:76.00 stddev:16.33 (21.5%) stddev-sans-first:17.11 16:51:39 INFO - PROCESS | 4200 | Values: 76.0 75.0 77.0 124.0 76.0 77.0 76.0 76.0 101.0 75.0 16:51:39 INFO - PROCESS | 4200 | 16:51:39 INFO - PROCESS | 4200 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:85.00 stddev:16.96 (20.0%) stddev-sans-first:17.56 16:51:40 INFO - PROCESS | 4200 | Values: 85.0 85.0 119.0 85.0 85.0 85.0 118.0 86.0 84.0 123.0 16:51:40 INFO - PROCESS | 4200 | 16:51:40 INFO - PROCESS | 4200 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 16:51:40 INFO - PROCESS | 4200 | Values: 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 16:51:40 INFO - PROCESS | 4200 | 16:51:40 INFO - PROCESS | 4200 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 16:51:40 INFO - PROCESS | 4200 | Values: 146.0 146.0 147.0 147.0 147.0 146.0 147.0 146.0 146.0 146.0 16:51:40 INFO - PROCESS | 4200 | 16:51:40 INFO - PROCESS | 4200 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:51:40 INFO - PROCESS | 4200 | Values: 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:51:40 INFO - PROCESS | 4200 | 16:51:40 INFO - PROCESS | 4200 | [#8] json-parse-financial Cycles:10 Average:65.30 Median:65.50 stddev:0.95 (1.4%) stddev-sans-first:1.00 16:51:40 INFO - PROCESS | 4200 | Values: 65.0 66.0 65.0 66.0 65.0 67.0 66.0 65.0 64.0 64.0 16:51:40 INFO - PROCESS | 4200 | 16:51:40 INFO - PROCESS | 4200 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.67 (1.1%) stddev-sans-first:0.53 16:51:40 INFO - PROCESS | 4200 | Values: 65.0 63.0 63.0 64.0 64.0 63.0 64.0 64.0 64.0 63.0 16:51:40 INFO - PROCESS | 4200 | 16:51:40 INFO - PROCESS | 4200 | [#10] stanford-crypto-aes Cycles:10 Average:78.40 Median:78.00 stddev:1.51 (1.9%) stddev-sans-first:1.59 16:51:40 INFO - PROCESS | 4200 | Values: 78.0 79.0 78.0 78.0 78.0 79.0 82.0 78.0 76.0 78.0 16:51:40 INFO - PROCESS | 4200 | 16:51:40 INFO - PROCESS | 4200 | [#11] stanford-crypto-ccm Cycles:10 Average:139.70 Median:130.00 stddev:28.82 (22.2%) stddev-sans-first:30.57 16:51:40 INFO - PROCESS | 4200 | Values: 140.0 128.0 128.0 130.0 130.0 127.0 134.0 130.0 221.0 129.0 16:51:40 INFO - PROCESS | 4200 | 16:51:40 INFO - PROCESS | 4200 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.00 stddev:1.89 (1.1%) stddev-sans-first:1.99 16:51:40 INFO - PROCESS | 4200 | Values: 167.0 171.0 169.0 168.0 167.0 168.0 170.0 165.0 166.0 166.0 16:51:40 INFO - PROCESS | 4200 | 16:51:40 INFO - PROCESS | 4200 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.80 Median:66.50 stddev:2.04 (3.1%) stddev-sans-first:0.97 16:51:40 INFO - PROCESS | 4200 | Values: 72.0 67.0 67.0 65.0 66.0 66.0 66.0 65.0 66.0 68.0 16:51:40 INFO - PROCESS | 4200 | -------- Summary: end -------- 16:51:40 INFO - PROCESS | 4200 | 16:51:40 INFO - TEST-INFO | 4200: exit 0 16:51:41 INFO - TEST-OK | kraken | took 62969ms 16:51:41 INFO - SUITE-END | took 1183s 16:51:41 INFO - Completed test suite (00:19:43) 16:51:41 INFO - javascript benchmark 16:51:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2640.247529454106, 2656.853873036983, 2677.277135173503, 2682.3026013236554, 2686.7984901132413, 4667.533246675331, 4722.24444088945, 4788.569028787409, 4830.468648448672, 4851.975740121295, 4695.882602934928, 4700.835470758524, 4705.435347758265, 4743.857684269469, 4790.616750659948, 4341.305391137419, 4399.406080179183, 4434.312681534351, 4467.754273514972, 4527.660425468087, 4436.889077773049, 4464.441944756905, 4485.327200919855, 4485.663575231854, 4515.232410490208, 4325.697201195918, 4345.543717909637, 4350.956490435086, 4385.079133381993, 4385.539518350559, 4370.934435983431, 4389.495208051083, 4438.267685831834, 4449.844255451076, 4451.043025749479, 4413.315936029889, 4442.62237709795, 4449.443819522559, 4477.552244775529, 4479.372887795711, 4636.4899861015265, 4756.762161891927, 4835.178019736653, 4858.222684370519, 4898.0, 5240.109181439165, 5250.7637156328055, 5261.105612045923, 5268.394134674523, 5276.3932147802725, 5036.521530454601, 5250.921236181461, 5291.3650361956425, 5297.205419187114, 5300.496452836975, 4790.592799612037, 4852.951470485321, 4855.927161092586, 4901.1913034349645, 4917.139500587455, 5376.059189641797, 5386.326709161355, 5395.352557693023, 5395.81114660985, 5400.270963419966, 5060.898782024339, 5088.160453525127, 5106.642535022513, 5107.897842043139, 5115.130427827278, 5015.423226328946, 5115.130427827278, 5174.896502069938, 5204.869878252998, 5220.738963051832, 5146.330976972969, 5146.588272938156, 5167.328247327899, 5174.09453345663, 5228.0, 5020.071286811952, 5133.589312854962, 5144.228365745168, 5146.639735218499, 5149.253358263106, 4347.543507931685, 4353.216421044179, 4387.648988080946, 4391.802368893407, 4416.933745993812, 3813.9427908581392, 3815.904602384907, 3820.2168555446065, 3856.845726170922, 3862.478565393692, 4462.44219472566, 4468.061707041557, 4470.351798989128, 4475.4181956345465, 4519.502854685982, 5018.146915024455, 5095.8980820383385, 5129.051125541712, 5149.897002059938, 5203.713795741195, 4422.358757980075, 4431.40176076232, 4435.356873253425, 4436.423264975597, 4469.754163520973, 4605.6085232755595, 4640.466346370143, 4651.2557990721325, 4657.836975705902, 4696.459907110726, 4736.8342108026745, 4800.831970881002, 4854.854354369375, 4854.902901942012, 4872.244802055687, 5161.974190129175, 5171.974140129275, 5184.688918664892, 5189.040027594907, 5244.265802787689, 4739.976300118477, 4862.927056094232, 4876.731779752147, 4876.756162191948, 4926.655134140576, 5049.0, 5085.694858308513, 5101.0, 5111.309973153725, 5113.233015047773, 5184.092783762751, 5184.585233181261, 5198.012377648235, 5198.584113271005, 5200.869978250574, 4907.68100073494, 4975.875603109951, 5029.9245511318095, 5046.571041461517, 5048.1165795984825, 4981.452040275639, 5026.045051440215, 5039.143345631325, 5044.1424957756535, 5096.541311281854, 4926.827561035347, 4957.876053098701, 5000.6249531284575, 5012.997400519837, 5013.448520662797, 4913.877153071202, 4973.52751488608, 5031.295618613324, 5060.114479966065, 5064.44291127983, 4928.383952005999, 4944.357233559758, 4947.6536642434685, 4948.826791062295, 4983.551480366785], "value": 4737.291244756018, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.5873690172755, 581.5667327840756, 588.1207594646004, 588.5497594340328, 599.3826358850383, 39948.00129996748, 40574.79712601437, 40735.185296294054, 40767.388489172685, 41631.0, 38005.0, 42285.15429691404, 42418.0, 42453.57546424543, 42495.36256956148, 7489.251074892494, 7921.801954951115, 8063.354931605487, 8066.475679080871, 10259.281850270485, 10051.346662466916, 10409.843852342183, 10411.479426028705, 10419.895801042006, 10421.322614030101, 10459.00639439252, 10513.316634418776, 10513.789724205511, 10528.947355263252, 10533.473326333691, 10420.63527776528, 10465.424401657867, 10470.633527826489, 10473.47632618366, 10476.633317833915, 10234.078932896075, 10245.641402550875, 10312.071913527818, 10312.278140530167, 10315.948420257926, 39261.411078833844, 39525.80237098796, 39645.20709585821, 39676.80161599174, 39730.0, 2971.747401470878, 2989.5515672649058, 3230.2893363460003, 3633.5458067741533, 3715.4241092630414, 29796.70707292047, 29991.550126748116, 30328.393432131455, 30352.241193970105, 31550.211244718837, 3291.917702057444, 3324.6841550052704, 3391.9830400848086, 3415.163284995167, 3461.5846098468346, 268003.0, 269756.0, 270410.0, 271030.999999998, 271089.0, 52626.73686631543, 53347.466525335025, 53366.0, 53396.46603533992, 53438.73280633572, 55683.0, 55821.720891395285, 55918.0, 55922.0, 55951.0, 13678.589642310746, 14063.367148478343, 14150.29248537569, 14151.080179788281, 14167.079139855876, 9656.75858103539, 10233.641822536176, 10383.94808025955, 10447.268691191544, 10597.152227821756, 15964.0, 16022.359105635876, 16066.839331606769, 16076.517704468884, 16143.273552690158, 4905.053812823249, 5612.494875461228, 5651.4348565143155, 5959.910601340984, 5984.461398474158, 807.4670717326653, 822.3256929318021, 873.8988874018655, 939.9441410314471, 953.5422996961497, 27179.184624461297, 27992.0, 28110.85944570264, 28460.715392845806, 28689.0, 953.2469349214182, 962.8026254617787, 977.372142903352, 986.8519722041751, 1062.7024433158729, 14371.568852934428, 14759.77860332096, 14767.852321476863, 15133.621659458382, 15141.621459463602, 384557.0, 388518.0, 394671.0, 395126.0, 395726.0, 50373.0, 50485.24272135921, 50538.241926371134, 50605.24092138621, 50612.0, 1085.8751243606928, 1113.9665810025713, 1158.247139359423, 1183.7691650128143, 1210.8365370675021, 24969.500609988063, 27492.862535687193, 28024.0, 28024.29939251535, 28420.85789571039, 43076.56923430726, 43638.12723745571, 43704.344434834136, 43705.0, 43730.562694372646, 314219.0, 314343.0, 315538.0, 315959.0, 318570.0, 22222.0, 22934.770652293264, 24699.135530256353, 25316.367090822878, 25460.49079018372, 42339.364909525764, 42386.788066059475, 42501.574984251, 43223.13553728971, 43538.34692479679, 36052.639473604926, 36381.0, 36433.81783091067, 36856.81571592125, 37246.88259352224, 34790.0, 37126.814365927996, 37778.43332349962, 37922.62077379191, 38084.0, 36703.81648091743, 36731.44902826513, 36985.260294793414, 37451.625483744814, 37568.81215593904, 32619.415251282375, 34062.31875362429, 34236.0, 34392.656073439946, 34704.0, 25663.230103096936, 25982.22053338403, 26165.0, 26234.86882565575, 26595.468090638467], "value": 18115.13705091234, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.4387852403609, 372.9030452082459, 375.791435753157, 380.4863434363611, 390.4982098004065, 17141.914290428547, 17481.213345399457, 18088.728669069973, 18292.81707182928, 18304.084795760224, 17316.913415432937, 17868.55328616785, 18143.27426902922, 18176.545586360313, 18216.0, 4869.707817530951, 5049.368828896388, 5073.112205364065, 5093.923591146136, 5096.821611243608, 3702.2040261343805, 3824.063104539378, 4960.60315174787, 4986.0, 6026.819195424122, 6049.455549000589, 6055.2430946131735, 6073.969630151865, 6085.665288409135, 6085.908711369333, 5771.105478650795, 5937.762489500415, 5939.554533410012, 5944.524438044946, 5945.167676525247, 3404.7446441516986, 4910.705357678515, 5212.50481204285, 5249.370075590915, 5255.02781985334, 21119.788802111936, 21516.677249841265, 21804.563908721895, 21807.345779626638, 22003.22988695388, 1857.1921214271836, 1987.5428651410111, 2021.2521367094123, 2088.6136064828056, 2439.3901524618846, 13284.202947823162, 13869.306534673226, 13929.442822287197, 13968.58094257174, 14236.0, 1735.9132043397906, 1800.9909950450165, 1817.7546031285872, 1819.7088465845534, 1863.3943968210385, 68276.0, 70952.64523677349, 71646.283537165, 72101.0, 72743.63628181878, 9370.85943710845, 9379.24966002718, 9659.275554333453, 9830.115289623967, 9920.065587210569, 13325.400356983959, 13451.32743362828, 13496.865031349756, 13515.053946223867, 13541.458341666223, 7208.459365547605, 7227.819304517429, 7312.378447831994, 7417.369523590555, 7432.368248698813, 6915.723371065101, 6921.0, 6973.755918542928, 7052.012718219454, 7068.222495525488, 6162.691865406712, 6183.505319574513, 6219.100177348896, 6331.0, 6391.712372943229, 1619.4574817436292, 1663.3928616055296, 1752.835248468141, 1812.755278037448, 1828.2047309420445, 822.6668199379261, 875.8773771671971, 901.6528636475005, 942.58997336159, 991.127807529384, 17371.131443427777, 17981.640367192584, 18222.544436389195, 18482.630347392977, 18550.16524256412, 883.9337049721297, 912.4798864647088, 927.8376284150247, 935.7941252924346, 964.1178321835582, 10246.077852993118, 10376.688699339033, 10447.738806529745, 10511.369317840954, 10539.314944528582, 379479.0, 381003.8046385589, 384611.0, 387860.0, 388835.0, 51398.486015140115, 60125.69937150374, 72453.63773181206, 88846.55576722205, 89461.9999999987, 916.5417291354323, 929.5677509957767, 940.2290122099812, 944.0276515189366, 952.7808604021114, 16342.346306147621, 16342.754858677366, 16537.090460024334, 16537.83462165411, 16715.83284167143, 37753.24493510059, 38010.42984355292, 38494.80752596219, 39237.0, 40247.79876100601, 52810.471895280556, 53935.46064539305, 54214.728926355114, 54874.451255486936, 55350.72324638351, 7522.962385188039, 7678.8080297993, 7825.569593672402, 7863.488873223222, 7921.485103468256, 10602.681919542427, 11659.067274618179, 11685.883141168479, 11898.405079746151, 12026.098042647012, 9743.756406089904, 10093.5457904393, 10236.795264094528, 10619.256652034283, 10971.890281097087, 11038.668839934815, 11172.664820055412, 11175.441227938409, 11208.103351732005, 11390.715232119263, 10345.793084138426, 10864.185186111232, 10898.727531811768, 11136.554537818396, 11303.095752339628, 6946.687399067156, 7144.821379465555, 7182.712691492282, 7371.078615173104, 7905.169957154646, 7884.448088633741, 10452.790944181226, 11006.724831879266, 11046.950539698715, 11108.389038602954], "value": 8547.301232398811, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1247.7317376763995, 1394.3864699532207, 1409.8096756937814, 1523.6495606010617, 1717.5276798880313, 6528.934710652892, 7376.7418140365035, 7644.541327520339, 7661.080670319556, 7669.884951725729, 7316.414686825055, 7561.962190189055, 7615.9619201903915, 7815.687372505107, 7827.960860195691, 2178.2593918067855, 2223.2552095048177, 2225.521512874732, 2226.5880812049822, 2226.7327920649545, 2174.5650869826018, 2198.0218802632835, 2217.46780772615, 2226.487907781211, 2229.442639340165, 2176.1621775616422, 2180.7710190429934, 2184.7487538932987, 2188.5841690078832, 2226.755056943735, 2148.5488047510044, 2160.4166874943758, 2166.1876796201423, 2168.382011126829, 2168.728908886389, 2120.162535798351, 2163.0482587661536, 2163.2104281937136, 2164.0802658869916, 2165.7725938776357, 7470.925290747132, 7676.884846727304, 7734.922650773477, 7813.453058285922, 7821.335186509154, 4550.271956486979, 4649.465311489154, 4659.930101048487, 4660.231061874821, 4667.369905062807, 2851.3584443500254, 2911.737943585066, 2942.2938494761315, 2949.159489545469, 2963.7777166712367, 936.1200471556715, 950.334765664038, 956.3401253135384, 960.7646126699003, 969.7042402067367, 10319.638812641597, 10537.78924421515, 10546.947265263701, 10574.471276436147, 10600.469976501145, 3994.8801535953967, 4181.97909010453, 4186.644135248477, 4240.1307731914885, 4333.739975601474, 9091.227245684058, 9139.0, 9140.268778497704, 9143.451392916446, 9173.77065573366, 4638.0491999140095, 4651.139539185261, 4653.371794807726, 4656.3713898623255, 4657.767111644472, 3722.0, 3819.961800382016, 4219.641330486882, 4230.809613567397, 4241.024564350217, 3708.517892673989, 3742.66316031553, 3785.205106927521, 3808.923821523554, 3945.1320709443876, 1180.6812160716559, 1194.035811090751, 1200.9579664711694, 1206.029146537046, 1227.643983244849, 742.2058397514716, 752.4845480845638, 809.688270016048, 810.6392655268467, 882.245679943639, 5195.350581177353, 5287.576993840484, 5294.92057619136, 5338.065838478251, 5479.863003424946, 864.4337958637103, 878.5607196401799, 936.5223735894742, 947.275334369208, 950.1828427552299, 3512.8594856205978, 3624.5469316335457, 3657.707383409374, 3685.4656074868994, 3744.64425879541, 9543.522823858779, 9597.32818702698, 9642.132208101304, 9706.514674266258, 9767.0, 8949.239314658196, 9337.206337461255, 9341.20599749029, 9632.75918102053, 9654.372465789702, 7173.7130514779865, 7286.599237041907, 7294.635268236673, 7367.300106489982, 7369.0, 5263.578913686973, 5278.0, 5327.9200811987075, 5419.132938729785, 5468.589855760754, 9061.0, 9172.0, 9292.62829486813, 9304.534773261445, 9311.208547273558, 8020.83958320842, 8739.475631462132, 9142.63429462814, 9146.039665835258, 9254.398464099811, 6541.8691626168165, 6713.899291510534, 6736.124303840469, 6897.55165914214, 6897.793066208022, 7312.817179570553, 7385.556866588022, 7415.703371865281, 7422.0, 7457.179710231979, 6683.398494135551, 6720.260771315249, 6797.538529216242, 6879.759208427881, 6886.8622627546165, 6597.27429982692, 6639.170103737033, 6669.633170175687, 6685.431738302299, 6742.898856517254, 6248.937510625017, 6324.588901721373, 6328.240611126695, 6329.968350158404, 6330.873382532415, 4581.106684196549, 4630.143423466669, 4702.083093796677, 4715.740634265148, 4759.50025247344, 4696.577308042292, 4702.553257440538, 4708.646851486221, 4743.407074115736, 4808.6153107752], "value": 4154.1393070789645, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [305.16689437834714, 308.1756301892437, 312.8170020537985, 315.0548354935194, 317.70612183730043, 4834.129856625806, 4850.660453768238, 4851.902961940764, 4857.222844344897, 4870.975645121774, 4779.35478710374, 4802.471728109905, 4806.975965120169, 4814.301926220696, 4847.497275844491, 3675.852965881368, 3748.6063963283873, 3792.2415516896594, 3849.499565056539, 3917.6278253565865, 3829.3490106681793, 3856.1709232515004, 3869.8839034829, 3892.143728379752, 3896.454496370496, 3631.5279013728177, 3836.808159592023, 3840.404737265714, 3847.499825022743, 3856.6914646828186, 3684.2631473705233, 3783.9621603783885, 3814.6376094271277, 3826.1391186982705, 3839.1361943562756, 3388.3731509670542, 3402.5406570112964, 3418.453047512386, 3423.8288085595623, 3426.5716785401823, 4680.321353403771, 4695.859124226278, 4727.361806156159, 4740.0, 4742.146413645542, 4257.998740591916, 4341.5007274163245, 4389.407429996942, 4390.682795161439, 4393.857597024797, 4995.8509542804995, 5044.319016932704, 5051.520105589963, 5065.594752419797, 5078.187490001582, 3718.1819999600043, 3736.9252614947823, 3747.7938713370754, 3753.2118255166447, 3762.9811850940846, 5112.667676601009, 5228.529432351069, 5272.393674727378, 5336.359636843565, 5348.679079255257, 3773.6792372648083, 3787.0910981364273, 3789.374753165697, 3792.6965842732516, 3797.0697179190724, 3847.249786291646, 3848.2111167210655, 3860.2665493556133, 3862.343401621731, 3864.3237433449035, 4333.609975102193, 4355.695101342939, 4384.364267181305, 4385.144896745104, 4394.472663280427, 4858.7570621468785, 5097.974510127426, 5100.5409513143995, 5102.591792656579, 5117.155669314521, 1290.5547586082787, 1308.1562392256942, 1311.2853494845333, 1313.7897936330141, 1322.1141834970592, 818.3167055508598, 824.1058451580103, 860.8708693695995, 890.3589415620743, 897.9685711000084, 4435.977820110943, 4443.977780111143, 4451.310046942729, 4463.910721785611, 4465.843695470643, 5173.22401639757, 5188.610854185876, 5192.844214673566, 5200.63595548308, 5229.790808367623, 4272.871813845528, 4428.070105277863, 4457.0, 4457.459248228479, 4508.18852606534, 2750.3674154944474, 2755.5453350196995, 2765.184270640166, 2765.889364425441, 2779.9722002779713, 4848.733319667452, 4867.756612169448, 4873.366462359871, 4877.341558889504, 4895.534924182197, 5098.527214301061, 5239.42817154852, 5262.973685131627, 5287.867803304948, 5318.468153184728, 4833.154198015333, 4841.176999909953, 4842.7820748065715, 4859.1496488114435, 4868.610511159028, 5169.940162266802, 5173.689578625294, 5179.559737422211, 5203.349581302337, 5203.921941170961, 4964.280179374043, 5049.419316778617, 5090.49095090488, 5092.134337162617, 5138.0, 4805.711657300573, 4834.444038935568, 4849.636277279147, 4851.539103785135, 4852.320675105418, 3721.7022638189424, 3733.1973625669525, 3737.177820879402, 3738.607446218217, 3752.981235093807, 4941.678790878582, 5112.284280200849, 5144.742762861917, 5204.947950520446, 5209.47905209476, 4966.503349665005, 4979.278004689228, 4982.601391888567, 4993.975030124826, 5002.949380629962, 4965.950340496694, 4988.600911926965, 4989.750512474435, 4993.27597498368, 5010.624203184849, 4708.915660242546, 4813.518648135158, 4853.150698627655, 4915.827946021872, 5017.297578339108, 5016.473270306566, 5132.9743351283005, 5136.30659860914, 5140.46025167352, 5146.948530514647, 5007.674501157413, 5013.473585273494, 5018.498150185098, 5035.230623157322, 5087.364079490064], "value": 3834.993454610862, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [664.3754870421803, 665.4210836572183, 675.0886303490287, 690.9827254318639, 697.0380874393336, 13050.086493945428, 13322.46710131596, 13549.59351219465, 13601.795973060413, 13624.0, 13473.865261347384, 13607.659808504792, 13616.0, 13629.454821807116, 13646.317684115804, 626.9435750782452, 644.5842431631595, 649.1301655781252, 766.2720415605183, 793.175097898188, 638.1289539778215, 640.4588123036027, 780.1613265739325, 803.1245941923303, 809.8258874342015, 826.1614461321764, 827.3133299361516, 829.0548774397162, 830.0951962361025, 831.8585840407115, 838.0948575538404, 838.4298676899706, 838.6058552480355, 838.828040251747, 839.983200335996, 488.6921239619053, 491.86965454154677, 495.96528243023005, 496.7342471777618, 593.2169536212201, 13496.392662330121, 14037.64905877351, 14090.295485225697, 14119.435222591084, 14138.08102473336, 13247.138935969131, 13679.24764137972, 13771.655708607264, 13826.30868456573, 13923.86076139246, 11278.266912650652, 11490.195686301962, 11808.46861891217, 11984.70038249042, 12306.507739690402, 4273.337632666941, 4285.678574106954, 4377.255866502702, 4516.16450956574, 4518.502964673883, 64218.789060546784, 64799.0, 65472.67263663699, 65641.343586564, 67657.3234267656, 10992.395418251914, 11213.887861121284, 11257.0, 11547.307161570332, 11676.766464670829, 20568.691469627967, 20733.170673173205, 20757.481062973548, 20765.065572049294, 21075.78924210769, 6456.806295811133, 6752.831179220559, 7069.434445244368, 7131.144262688511, 7261.346478816932, 3622.1487950331652, 3630.8729194478065, 3641.089727568108, 3670.6329367063613, 3678.8528458861883, 2996.4007198560375, 3091.7372023377816, 3102.612173478315, 3122.640896296955, 3125.3905488429536, 530.4827792901967, 533.2028617217208, 534.0280689145718, 537.5430883748783, 552.5607142321863, 448.76439869069, 448.88777805548614, 514.8827045311608, 539.4605394605395, 561.0602241245897, 7798.844023119505, 7949.205079492004, 8109.310708589836, 8349.248567628943, 8553.914460855312, 539.6708008115125, 540.41635034163, 552.4061633743661, 559.4154108956151, 567.5998421113188, 3777.320082385197, 3883.7475564088245, 3929.7052721045466, 3992.4210989406956, 4041.333180025322, 51679.7416012925, 51961.50925792671, 52314.47685523172, 52341.47658523442, 52367.0, 80295.0, 85024.0, 85177.57411213029, 85878.0, 85944.0, 65501.67249163723, 66976.66511667508, 72833.6358318205, 74266.0, 76217.23782762101, 8595.957020214859, 9219.354645174773, 9406.905930940877, 9535.897194361907, 9544.0, 42514.36228456638, 42952.57047429486, 43124.0, 46733.532664672915, 47272.0, 43672.0, 55025.44974550203, 64282.357176427635, 65667.67166164139, 65947.67026164838, 10701.732456688645, 11182.88817111851, 11199.384033877888, 11529.192956492965, 11635.243709158878, 12652.683682908, 12659.430325635552, 13034.804477932648, 13414.731705366034, 13580.93209533946, 12565.308908009782, 12704.110712250054, 13110.737785244433, 13432.126911750705, 13492.392842322315, 12901.677458063623, 12909.289989050692, 13304.667383315495, 13440.529581464602, 13514.59456216315, 11764.647060588197, 12219.144659873724, 12416.441260143134, 13216.801747973595, 13345.065845391118, 10259.230557708352, 10302.0, 10345.224108192066, 10427.061564459234, 10851.620193293196, 9594.603347001079, 10135.647316975805, 10139.481498116244, 10160.745981350525, 10247.231457640855], "value": 6607.6738672974925, "unit": "score"}], "name": "dromaeo_css", "value": 6525.657491878448, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 115.0, 114.0, 114.0, 114.0, 112.0, 112.0, 112.0, 111.0, 113.0], "value": 112.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 120.0, 126.0, 174.0, 121.0, 121.0, 145.0, 120.0, 155.0, 123.0], "value": 134.9, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 162.0, 161.0, 159.0, 162.0, 161.0, 162.0, 161.0, 161.0, 162.0], "value": 162.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 124.0, 76.0, 77.0, 76.0, 76.0, 101.0, 75.0], "value": 83.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 119.0, 85.0, 85.0, 85.0, 118.0, 86.0, 84.0, 123.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 65.0, 66.0, 65.0, 67.0, 66.0, 65.0, 64.0, 64.0], "value": 65.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 64.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [78.0, 79.0, 78.0, 78.0, 78.0, 79.0, 82.0, 78.0, 76.0, 78.0], "value": 78.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 128.0, 128.0, 130.0, 130.0, 127.0, 134.0, 130.0, 221.0, 129.0], "value": 139.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 171.0, 169.0, 168.0, 167.0, 168.0, 170.0, 165.0, 166.0, 166.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [72.0, 67.0, 67.0, 65.0, 66.0, 66.0, 66.0, 65.0, 66.0, 68.0], "value": 66.8, "unit": "score"}], "name": "kraken", "value": 1527.4, "alertThreshold": 2.0}]} 16:51:41 INFO - Return code: 0 16:51:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:51:41 INFO - # TBPL SUCCESS # 16:51:41 INFO - Running post-action listener: _resource_record_post_action 16:51:41 INFO - ##### 16:51:41 INFO - ##### Finished run-tests step (success) 16:51:41 INFO - ##### 16:51:41 INFO - Running post-run listener: _resource_record_post_run 16:51:41 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 430080; Write bytes: 289185792; Read time: 248; Write time: 238840 16:51:41 INFO - TinderboxPrint: CPU usage
12.9% 16:51:41 INFO - TinderboxPrint: I/O read bytes / time
430,080 / 248 16:51:41 INFO - TinderboxPrint: I/O write bytes / time
289,185,792 / 238,840 16:51:41 INFO - TinderboxPrint: CPU idle
8,336.9 (87.0%) 16:51:41 INFO - TinderboxPrint: CPU user
1,200.3 (12.5%) 16:51:41 INFO - TinderboxPrint: Swap in / out
0 / 0 16:51:41 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 9871360; Read time: 0; Write time: 1328 16:51:41 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 425984; Write bytes: 192827392; Read time: 92; Write time: 157816 16:51:41 INFO - Running post-run listener: _upload_blobber_files 16:51:41 INFO - Blob upload gear active. 16:51:41 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:51:41 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 16:51:41 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'] 16:51:41 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 16:51:42 INFO - (blobuploader) - INFO - Open directory for files ... 16:51:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:51:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:51:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:45 INFO - (blobuploader) - INFO - Done attempting. 16:51:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 16:51:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 16:51:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:46 INFO - (blobuploader) - INFO - Done attempting. 16:51:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 16:51:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:51:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:51:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 16:51:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:51:47 INFO - (blobuploader) - INFO - Done attempting. 16:51:47 INFO - (blobuploader) - INFO - Iteration through files over. 16:51:47 INFO - Return code: 0 16:51:47 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:51:47 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:51:47 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4005a81ccccab958c05f3579f8aa29e84601e2ae8305bef6dc244e661adda81b9ccee84ce72ae07d3ca20fb4093367aba839e2c47b2dd18b96ab6a63e59749b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/809df071884bb93021f951b59e5b3988e3b24246c3b840fe3d766c3f1d81d3a775fe41cd2ad3f98e681191bb566a96bf24906f894d18abe872ef611bd07fbfaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0237c4df8d3f6321e795d5c336af0fbac502f7e7cd74a5ecc8a6911a7af0a73ebd4380b73888af9cd5649df376cda3b8ff746ee515c4a85595d3865625a7d52"} 16:51:47 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:51:47 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:51:47 INFO - Contents: 16:51:47 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/f4005a81ccccab958c05f3579f8aa29e84601e2ae8305bef6dc244e661adda81b9ccee84ce72ae07d3ca20fb4093367aba839e2c47b2dd18b96ab6a63e59749b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/809df071884bb93021f951b59e5b3988e3b24246c3b840fe3d766c3f1d81d3a775fe41cd2ad3f98e681191bb566a96bf24906f894d18abe872ef611bd07fbfaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0237c4df8d3f6321e795d5c336af0fbac502f7e7cd74a5ecc8a6911a7af0a73ebd4380b73888af9cd5649df376cda3b8ff746ee515c4a85595d3865625a7d52"} 16:51:47 INFO - Running post-run listener: copy_logs_to_upload_dir 16:51:47 INFO - Copying logs to upload dir... 16:51:47 INFO - mkdir: /builds/slave/test/build/upload/logs 16:51:47 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1241.717425 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 41 secs) (at 2016-07-04 16:51:47.544644) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 16:51:47.548066) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138 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/f4005a81ccccab958c05f3579f8aa29e84601e2ae8305bef6dc244e661adda81b9ccee84ce72ae07d3ca20fb4093367aba839e2c47b2dd18b96ab6a63e59749b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/809df071884bb93021f951b59e5b3988e3b24246c3b840fe3d766c3f1d81d3a775fe41cd2ad3f98e681191bb566a96bf24906f894d18abe872ef611bd07fbfaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0237c4df8d3f6321e795d5c336af0fbac502f7e7cd74a5ecc8a6911a7af0a73ebd4380b73888af9cd5649df376cda3b8ff746ee515c4a85595d3865625a7d52"} build_url:https://queue.taskcluster.net/v1/task/SRJ5e4FVRmytB0-VejKzjA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011276 build_url: 'https://queue.taskcluster.net/v1/task/SRJ5e4FVRmytB0-VejKzjA/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/f4005a81ccccab958c05f3579f8aa29e84601e2ae8305bef6dc244e661adda81b9ccee84ce72ae07d3ca20fb4093367aba839e2c47b2dd18b96ab6a63e59749b", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/809df071884bb93021f951b59e5b3988e3b24246c3b840fe3d766c3f1d81d3a775fe41cd2ad3f98e681191bb566a96bf24906f894d18abe872ef611bd07fbfaf", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/a0237c4df8d3f6321e795d5c336af0fbac502f7e7cd74a5ecc8a6911a7af0a73ebd4380b73888af9cd5649df376cda3b8ff746ee515c4a85595d3865625a7d52"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 16:51:47.574062) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:51:47.574408) ========= 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=03627c79f6bb3d1578c4a402000001ba-1467674175.702994-851843138 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004450 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 16:51:47.657627) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 16:51:47.657950) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 16:51:47.658253) ========= ========= Total master_lag: 0.20 =========