builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1467284896.61 results: success (0) buildid: 20160630025528 builduid: 7c2474b8f06e4e13acbdaf7b1377d375 revision: d700dc054751333e0735f975fce3d3adf153c62a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:16.613849) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:16.614517) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:16.614838) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:16.639670) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:16.639962) ========= 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=db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 04:08:16-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 114M=0s 2016-06-30 04:08:16 (114 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.092880 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:16.747560) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:16.747871) ========= 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=db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020642 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:16.797341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:16.797730) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d700dc054751333e0735f975fce3d3adf153c62a --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 d700dc054751333e0735f975fce3d3adf153c62a --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=db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 04:08:16,836 truncating revision to first 12 chars 2016-06-30 04:08:16,836 Setting DEBUG logging. 2016-06-30 04:08:16,836 attempt 1/10 2016-06-30 04:08:16,836 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d700dc054751?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 04:08:17,148 unpacking tar archive at: mozilla-central-d700dc054751/testing/mozharness/ program finished with exit code 0 elapsedTime=0.644233 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:17.455489) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:17.455806) ========= script_repo_revision: d700dc054751333e0735f975fce3d3adf153c62a ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:17.456228) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:17.456518) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 04:08:17.465322) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-30 04:08:17.465623) ========= /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=db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:08:17 INFO - MultiFileLogger online at 20160630 04:08:17 in /builds/slave/test 04:08:17 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 04:08:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:08:17 INFO - {'append_to_log': False, 04:08:17 INFO - 'base_work_dir': '/builds/slave/test', 04:08:17 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:08:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:08:17 INFO - 'branch': 'Firefox-Non-PGO', 04:08:17 INFO - 'buildbot_json_path': 'buildprops.json', 04:08:17 INFO - 'config_files': ('talos/linux_config.py',), 04:08:17 INFO - 'default_actions': ('clobber', 04:08:17 INFO - 'read-buildbot-config', 04:08:17 INFO - 'download-and-extract', 04:08:17 INFO - 'populate-webroot', 04:08:17 INFO - 'create-virtualenv', 04:08:17 INFO - 'install', 04:08:17 INFO - 'run-tests'), 04:08:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:08:17 INFO - 'download_minidump_stackwalk': True, 04:08:17 INFO - 'download_symbols': 'ondemand', 04:08:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:08:17 INFO - 'tooltool.py': '/tools/tooltool.py', 04:08:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:08:17 INFO - '/tools/misc-python/virtualenv.py')}, 04:08:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:08:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:08:17 INFO - 'installer_path': 'installer.exe', 04:08:17 INFO - 'log_level': 'info', 04:08:17 INFO - 'log_name': 'talos', 04:08:17 INFO - 'log_to_console': True, 04:08:17 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:08:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:08:17 INFO - 'opt_config_files': (), 04:08:17 INFO - 'pip_index': False, 04:08:17 INFO - 'sps_profile': False, 04:08:17 INFO - 'sps_profile_interval': 0, 04:08:17 INFO - 'suite': 'dromaeojs', 04:08:17 INFO - 'system_bits': '32', 04:08:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:08:17 INFO - 'title': 'talos-linux64-ix-049', 04:08:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:08:17 INFO - 'use_talos_json': True, 04:08:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:08:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:08:17 INFO - 'work_dir': 'build'} 04:08:17 INFO - ##### 04:08:17 INFO - ##### Running clobber step. 04:08:17 INFO - ##### 04:08:17 INFO - Running pre-action listener: _resource_record_pre_action 04:08:17 INFO - Running main action method: clobber 04:08:17 INFO - rmtree: /builds/slave/test/build 04:08:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:08:18 INFO - Running post-action listener: _resource_record_post_action 04:08:18 INFO - ##### 04:08:18 INFO - ##### Finished clobber step (success) 04:08:18 INFO - ##### 04:08:18 INFO - ##### 04:08:18 INFO - ##### Running read-buildbot-config step. 04:08:18 INFO - ##### 04:08:18 INFO - Running pre-action listener: _resource_record_pre_action 04:08:18 INFO - Running main action method: read_buildbot_config 04:08:18 INFO - Using buildbot properties: 04:08:18 INFO - { 04:08:18 INFO - "project": "", 04:08:18 INFO - "product": "firefox", 04:08:18 INFO - "script_repo_revision": "production", 04:08:18 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:08:18 INFO - "repository": "", 04:08:18 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:08:18 INFO - "buildid": "20160630025528", 04:08:18 INFO - "pgo_build": "False", 04:08:18 INFO - "basedir": "/builds/slave/test", 04:08:18 INFO - "buildnumber": 134, 04:08:18 INFO - "slavename": "talos-linux64-ix-049", 04:08:18 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:08:18 INFO - "platform": "ubuntu64_hw", 04:08:18 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:08:18 INFO - "branch": "mozilla-central", 04:08:18 INFO - "repo_path": "mozilla-central", 04:08:18 INFO - "revision": "d700dc054751333e0735f975fce3d3adf153c62a", 04:08:18 INFO - "stage_platform": "linux64", 04:08:18 INFO - "builduid": "7c2474b8f06e4e13acbdaf7b1377d375", 04:08:18 INFO - "slavebuilddir": "test" 04:08:18 INFO - } 04:08:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:08:18 INFO - Running post-action listener: _resource_record_post_action 04:08:18 INFO - ##### 04:08:18 INFO - ##### Finished read-buildbot-config step (success) 04:08:18 INFO - ##### 04:08:18 INFO - ##### 04:08:18 INFO - ##### Running download-and-extract step. 04:08:18 INFO - ##### 04:08:18 INFO - Running pre-action listener: _resource_record_pre_action 04:08:18 INFO - Running main action method: download_and_extract 04:08:18 INFO - mkdir: /builds/slave/test/build/tests 04:08:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:18 INFO - https://queue.taskcluster.net/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/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 04:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/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 04:08:22 INFO - Downloaded 1361 bytes. 04:08:22 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:08:22 INFO - Using the following test package requirements: 04:08:22 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:22 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:08:22 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:08:22 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:22 INFO - u'jsshell-linux-x86_64.zip'], 04:08:22 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:08:22 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:08:22 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:08:22 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:08:22 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:08:22 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:08:22 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:08:22 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:08:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 04:08:22 INFO - https://queue.taskcluster.net/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:08:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:08:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/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 04:08:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/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 04:08:26 INFO - Downloaded 22701705 bytes. 04:08:26 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'] 04:08:26 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 04:08:27 INFO - Return code: 0 04:08:27 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 04:08:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:27 INFO - https://queue.taskcluster.net/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:08:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:08:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:08:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/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 04:08:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/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 04:08:29 INFO - Downloaded 22701705 bytes. 04:08:29 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'] 04:08:29 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 04:08:30 INFO - Return code: 0 04:08:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:30 INFO - https://queue.taskcluster.net/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:08:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:08:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/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 04:08:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/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 04:08:31 INFO - Downloaded 14405245 bytes. 04:08:31 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'] 04:08:31 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 04:08:32 INFO - Return code: 0 04:08: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')]} 04:08:32 INFO - https://queue.taskcluster.net/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:08:32 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:08:32 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:08:32 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/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 04:08:32 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/CfPBSXnkSB2US6VyU8rcUQ/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 04:08:33 INFO - Downloaded 56457164 bytes. 04:08:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:08:33 INFO - mkdir: /builds/slave/test/properties 04:08:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:08:33 INFO - Writing to file /builds/slave/test/properties/build_url 04:08:33 INFO - Contents: 04:08:33 INFO - build_url:https://queue.taskcluster.net/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:08:34 INFO - Running post-action listener: _resource_record_post_action 04:08:34 INFO - Running post-action listener: set_extra_try_arguments 04:08:34 INFO - ##### 04:08:34 INFO - ##### Finished download-and-extract step (success) 04:08:34 INFO - ##### 04:08:34 INFO - ##### 04:08:34 INFO - ##### Running populate-webroot step. 04:08:34 INFO - ##### 04:08:34 INFO - Running pre-action listener: _resource_record_pre_action 04:08:34 INFO - Running main action method: populate_webroot 04:08:34 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:08:34 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:08:34 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:08:34 INFO - '--tppagecycles', 04:08:34 INFO - '7'], 04:08:34 INFO - 'tests': ['tsvgm']}}, 04:08:34 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:08:34 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:08:34 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:08:34 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:08:34 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:08:34 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:08:34 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:34 INFO - 'talos_options': ['--disable-e10s'], 04:08:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:34 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:34 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:08:34 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:34 INFO - 'talos_options': ['--disable-e10s'], 04:08:34 INFO - 'tests': ['damp', 'tps']}, 04:08:34 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:34 INFO - 'tests': ['damp', 'tps']}, 04:08:34 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:08:34 INFO - 'tests': ['dromaeo_dom']}, 04:08:34 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:08:34 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:08:34 INFO - 'tests': ['basic_compositor_video']}, 04:08:34 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:08:34 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:08:34 INFO - 'tests': ['a11yr', 04:08:34 INFO - 'ts_paint', 04:08:34 INFO - 'tpaint', 04:08:34 INFO - 'sessionrestore', 04:08:34 INFO - 'sessionrestore_no_auto_restore', 04:08:34 INFO - 'tabpaint']}, 04:08:34 INFO - 'other-e10s': {'tests': ['a11yr', 04:08:34 INFO - 'ts_paint', 04:08:34 INFO - 'tpaint', 04:08:34 INFO - 'sessionrestore', 04:08:34 INFO - 'sessionrestore_no_auto_restore', 04:08:34 INFO - 'tabpaint']}, 04:08:34 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:08:34 INFO - 'ts_paint', 04:08:34 INFO - 'tpaint', 04:08:34 INFO - 'sessionrestore', 04:08:34 INFO - 'sessionrestore_no_auto_restore', 04:08:34 INFO - 'tabpaint']}, 04:08:34 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:08:34 INFO - 'ts_paint', 04:08:34 INFO - 'tpaint', 04:08:34 INFO - 'sessionrestore', 04:08:34 INFO - 'sessionrestore_no_auto_restore', 04:08:34 INFO - 'tabpaint']}, 04:08:34 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:08:34 INFO - 'tests': ['a11yr', 04:08:34 INFO - 'ts_paint', 04:08:34 INFO - 'tpaint', 04:08:34 INFO - 'sessionrestore', 04:08:34 INFO - 'sessionrestore_no_auto_restore', 04:08:34 INFO - 'tabpaint']}, 04:08:34 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:08:34 INFO - 'tests': ['a11yr', 04:08:34 INFO - 'ts_paint', 04:08:34 INFO - 'tpaint', 04:08:34 INFO - 'sessionrestore', 04:08:34 INFO - 'sessionrestore_no_auto_restore', 04:08:34 INFO - 'tabpaint']}, 04:08:34 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:08:34 INFO - 'tests': ['tsvgx', 04:08:34 INFO - 'tsvgr_opacity', 04:08:34 INFO - 'tart', 04:08:34 INFO - 'tscrollx', 04:08:34 INFO - 'cart']}, 04:08:34 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:08:34 INFO - 'tsvgr_opacity', 04:08:34 INFO - 'tart', 04:08:34 INFO - 'tscrollx', 04:08:34 INFO - 'cart']}, 04:08:34 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:34 INFO - 'talos_options': ['--disable-e10s'], 04:08:34 INFO - 'tests': ['tp5o']}, 04:08:34 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:34 INFO - 'tests': ['tp5o']}, 04:08:34 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:34 INFO - 'talos_options': ['--disable-e10s', 04:08:34 INFO - '--xperf_path', 04:08:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:34 INFO - 'tests': ['tp5n']}, 04:08:34 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:08:34 INFO - 'talos_options': ['--xperf_path', 04:08:34 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:08:34 INFO - 'tests': ['tp5n']}}, 04:08:34 INFO - 'talos.zip': {'path': '', 04:08:34 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:08:34 INFO - Running post-action listener: _resource_record_post_action 04:08:34 INFO - ##### 04:08:34 INFO - ##### Finished populate-webroot step (success) 04:08:34 INFO - ##### 04:08:34 INFO - ##### 04:08:34 INFO - ##### Running create-virtualenv step. 04:08:34 INFO - ##### 04:08:34 INFO - Running pre-action listener: _resource_record_pre_action 04:08:34 INFO - Running main action method: create_virtualenv 04:08:34 INFO - Creating virtualenv /builds/slave/test/build/venv 04:08:34 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:08:34 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:08:34 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:08:34 INFO - Using real prefix '/usr' 04:08:34 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:08:35 INFO - Installing distribute.............................................................................................................................................................................................done. 04:08:37 INFO - Installing pip.................done. 04:08:37 INFO - Return code: 0 04:08:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 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 0xb8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c3b0>, '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 0xe4d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:08:37 INFO - Using env: {'DISPLAY': ':0', 04:08:37 INFO - 'HOME': '/home/cltbld', 04:08:37 INFO - 'LANG': 'en_US.UTF-8', 04:08:37 INFO - 'LANGUAGE': 'en_US:en', 04:08:37 INFO - 'LOGNAME': 'cltbld', 04:08:37 INFO - 'MAIL': '/var/mail/cltbld', 04:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:37 INFO - 'MOZ_NO_REMOTE': '1', 04:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:37 INFO - 'NO_EM_RESTART': '1', 04:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:37 INFO - 'PWD': '/builds/slave/test', 04:08:37 INFO - 'SHELL': '/bin/bash', 04:08:37 INFO - 'SHLVL': '1', 04:08:37 INFO - 'TERM': 'linux', 04:08:37 INFO - 'TMOUT': '86400', 04:08:37 INFO - 'USER': 'cltbld', 04:08:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 04:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:37 INFO - '_': '/tools/buildbot/bin/python'} 04:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:08:37 INFO - Cleaning up... 04:08:37 INFO - Return code: 0 04:08:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:37 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 0xb8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c3b0>, '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 0xe4d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:08:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:08:37 INFO - Using env: {'DISPLAY': ':0', 04:08:37 INFO - 'HOME': '/home/cltbld', 04:08:37 INFO - 'LANG': 'en_US.UTF-8', 04:08:37 INFO - 'LANGUAGE': 'en_US:en', 04:08:37 INFO - 'LOGNAME': 'cltbld', 04:08:37 INFO - 'MAIL': '/var/mail/cltbld', 04:08:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:37 INFO - 'MOZ_NO_REMOTE': '1', 04:08:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:37 INFO - 'NO_EM_RESTART': '1', 04:08:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:37 INFO - 'PWD': '/builds/slave/test', 04:08:37 INFO - 'SHELL': '/bin/bash', 04:08:37 INFO - 'SHLVL': '1', 04:08:37 INFO - 'TERM': 'linux', 04:08:37 INFO - 'TMOUT': '86400', 04:08:37 INFO - 'USER': 'cltbld', 04:08:37 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 04:08:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:37 INFO - '_': '/tools/buildbot/bin/python'} 04:08:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:37 INFO - Downloading/unpacking psutil>=3.1.1 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08: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 04:08:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:08:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:39 INFO - Installing collected packages: psutil 04:08:39 INFO - Running setup.py install for psutil 04:08:39 INFO - building 'psutil._psutil_linux' extension 04:08:39 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:08:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:08:40 INFO - building 'psutil._psutil_posix' extension 04:08:40 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:08:40 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:08:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:08:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:08:40 INFO - Successfully installed psutil 04:08:40 INFO - Cleaning up... 04:08:40 INFO - Return code: 0 04:08:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c3b0>, '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 0xe4d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:08: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 mozsystemmonitor==0.3 04:08:40 INFO - Using env: {'DISPLAY': ':0', 04:08:40 INFO - 'HOME': '/home/cltbld', 04:08:40 INFO - 'LANG': 'en_US.UTF-8', 04:08:40 INFO - 'LANGUAGE': 'en_US:en', 04:08:40 INFO - 'LOGNAME': 'cltbld', 04:08:40 INFO - 'MAIL': '/var/mail/cltbld', 04:08:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:40 INFO - 'MOZ_NO_REMOTE': '1', 04:08:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:40 INFO - 'NO_EM_RESTART': '1', 04:08:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:40 INFO - 'PWD': '/builds/slave/test', 04:08:40 INFO - 'SHELL': '/bin/bash', 04:08:40 INFO - 'SHLVL': '1', 04:08:40 INFO - 'TERM': 'linux', 04:08:40 INFO - 'TMOUT': '86400', 04:08:40 INFO - 'USER': 'cltbld', 04:08:40 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 04:08:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:40 INFO - '_': '/tools/buildbot/bin/python'} 04:08:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:40 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:42 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:08:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:08:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:08:42 INFO - Installing collected packages: mozsystemmonitor 04:08:42 INFO - Running setup.py install for mozsystemmonitor 04:08:42 INFO - Successfully installed mozsystemmonitor 04:08:42 INFO - Cleaning up... 04:08:43 INFO - Return code: 0 04:08:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:08:43 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')]} 04:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:43 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')]} 04:08:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:43 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 0xb8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c3b0>, '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 0xe4d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:08:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:08:43 INFO - Using env: {'DISPLAY': ':0', 04:08:43 INFO - 'HOME': '/home/cltbld', 04:08:43 INFO - 'LANG': 'en_US.UTF-8', 04:08:43 INFO - 'LANGUAGE': 'en_US:en', 04:08:43 INFO - 'LOGNAME': 'cltbld', 04:08:43 INFO - 'MAIL': '/var/mail/cltbld', 04:08:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:43 INFO - 'MOZ_NO_REMOTE': '1', 04:08:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:43 INFO - 'NO_EM_RESTART': '1', 04:08:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:43 INFO - 'PWD': '/builds/slave/test', 04:08:43 INFO - 'SHELL': '/bin/bash', 04:08:43 INFO - 'SHLVL': '1', 04:08:43 INFO - 'TERM': 'linux', 04:08:43 INFO - 'TMOUT': '86400', 04:08:43 INFO - 'USER': 'cltbld', 04:08:43 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 04:08:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:43 INFO - '_': '/tools/buildbot/bin/python'} 04:08:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:43 INFO - Downloading/unpacking jsonschema==2.5.1 04:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:08:45 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:45 INFO - Downloading functools32-3.2.3-2.tar.gz 04:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:08:45 INFO - warning: no files found matching '*.txt' 04:08:45 INFO - no previously-included directories found matching 'build' 04:08:45 INFO - no previously-included directories found matching 'dist' 04:08:45 INFO - no previously-included directories found matching '.git*' 04:08:45 INFO - Installing collected packages: jsonschema, functools32 04:08:45 INFO - Running setup.py install for functools32 04:08:45 INFO - warning: no files found matching '*.txt' 04:08:45 INFO - no previously-included directories found matching 'build' 04:08:45 INFO - no previously-included directories found matching 'dist' 04:08:45 INFO - no previously-included directories found matching '.git*' 04:08:45 INFO - Successfully installed jsonschema functools32 04:08:45 INFO - Cleaning up... 04:08:45 INFO - Return code: 0 04:08:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xb8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c3b0>, '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 0xe4d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:08:45 INFO - Using env: {'DISPLAY': ':0', 04:08:45 INFO - 'HOME': '/home/cltbld', 04:08:45 INFO - 'LANG': 'en_US.UTF-8', 04:08:45 INFO - 'LANGUAGE': 'en_US:en', 04:08:45 INFO - 'LOGNAME': 'cltbld', 04:08:45 INFO - 'MAIL': '/var/mail/cltbld', 04:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:45 INFO - 'MOZ_NO_REMOTE': '1', 04:08:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:45 INFO - 'NO_EM_RESTART': '1', 04:08:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:45 INFO - 'PWD': '/builds/slave/test', 04:08:45 INFO - 'SHELL': '/bin/bash', 04:08:45 INFO - 'SHLVL': '1', 04:08:45 INFO - 'TERM': 'linux', 04:08:45 INFO - 'TMOUT': '86400', 04:08:45 INFO - 'USER': 'cltbld', 04:08:45 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 04:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:45 INFO - '_': '/tools/buildbot/bin/python'} 04:08:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:46 INFO - Downloading/unpacking blobuploader==1.2.4 04:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:47 INFO - Downloading blobuploader-1.2.4.tar.gz 04:08:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:08:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:08:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:48 INFO - Downloading docopt-0.6.1.tar.gz 04:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:08:48 INFO - Installing collected packages: blobuploader, requests, docopt 04:08:48 INFO - Running setup.py install for blobuploader 04:08:48 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:08:48 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:08:48 INFO - Running setup.py install for requests 04:08:49 INFO - Running setup.py install for docopt 04:08:49 INFO - Successfully installed blobuploader requests docopt 04:08:49 INFO - Cleaning up... 04:08:49 INFO - Return code: 0 04:08:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:49 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')]} 04:08:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:49 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')]} 04:08:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:49 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 0xb8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c3b0>, '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 0xe4d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:08:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:49 INFO - Using env: {'DISPLAY': ':0', 04:08:49 INFO - 'HOME': '/home/cltbld', 04:08:49 INFO - 'LANG': 'en_US.UTF-8', 04:08:49 INFO - 'LANGUAGE': 'en_US:en', 04:08:49 INFO - 'LOGNAME': 'cltbld', 04:08:49 INFO - 'MAIL': '/var/mail/cltbld', 04:08:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:49 INFO - 'MOZ_NO_REMOTE': '1', 04:08:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:49 INFO - 'NO_EM_RESTART': '1', 04:08:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:49 INFO - 'PWD': '/builds/slave/test', 04:08:49 INFO - 'SHELL': '/bin/bash', 04:08:49 INFO - 'SHLVL': '1', 04:08:49 INFO - 'TERM': 'linux', 04:08:49 INFO - 'TMOUT': '86400', 04:08:49 INFO - 'USER': 'cltbld', 04:08:49 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 04:08:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:49 INFO - '_': '/tools/buildbot/bin/python'} 04:08:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:49 INFO - Running setup.py (path:/tmp/pip-BHKYrH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:49 INFO - Running setup.py (path:/tmp/pip-3CPSLB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:49 INFO - Running setup.py (path:/tmp/pip-zFRI_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:49 INFO - Running setup.py (path:/tmp/pip-ngZbUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:49 INFO - Running setup.py (path:/tmp/pip-2IZVHy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:49 INFO - Running setup.py (path:/tmp/pip-df0szf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:49 INFO - Running setup.py (path:/tmp/pip-tNSsG4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:50 INFO - Running setup.py (path:/tmp/pip-SglaCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:50 INFO - Running setup.py (path:/tmp/pip-vwZuAV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:50 INFO - Running setup.py (path:/tmp/pip-Svz4fr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:50 INFO - Running setup.py (path:/tmp/pip-voyFiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:50 INFO - Running setup.py (path:/tmp/pip-lm48w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:50 INFO - Running setup.py (path:/tmp/pip-OzSmHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:50 INFO - Running setup.py (path:/tmp/pip-x8tsGW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:50 INFO - Running setup.py (path:/tmp/pip-2C493V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:50 INFO - Running setup.py (path:/tmp/pip-nuFScJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:50 INFO - Running setup.py (path:/tmp/pip-d9S1ji-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:50 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:08:50 INFO - Running setup.py install for manifestparser 04:08:50 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:08:50 INFO - Running setup.py install for mozcrash 04:08:50 INFO - Running setup.py install for mozdebug 04:08:51 INFO - Running setup.py install for mozdevice 04:08:51 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:08:51 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:08:51 INFO - Running setup.py install for mozfile 04:08:51 INFO - Running setup.py install for mozhttpd 04:08:51 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:08:51 INFO - Running setup.py install for mozinfo 04:08:51 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:08:51 INFO - Running setup.py install for mozInstall 04:08:51 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:08:51 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:08:51 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:08:51 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:08:51 INFO - Running setup.py install for mozleak 04:08:51 INFO - Running setup.py install for mozlog 04:08:51 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:08:51 INFO - Running setup.py install for moznetwork 04:08:51 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:08:51 INFO - Running setup.py install for mozprocess 04:08:51 INFO - Running setup.py install for mozprofile 04:08:52 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:08:52 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:08:52 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:08:52 INFO - Running setup.py install for mozrunner 04:08:52 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:08:52 INFO - Running setup.py install for mozscreenshot 04:08:52 INFO - Running setup.py install for moztest 04:08:52 INFO - Running setup.py install for mozversion 04:08:52 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:08:52 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:08:52 INFO - Cleaning up... 04:08:52 INFO - Return code: 0 04:08:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08:52 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')]} 04:08:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:52 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')]} 04:08:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:52 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 0xb8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c3b0>, '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 0xe4d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:08:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:52 INFO - Using env: {'DISPLAY': ':0', 04:08:52 INFO - 'HOME': '/home/cltbld', 04:08:52 INFO - 'LANG': 'en_US.UTF-8', 04:08:52 INFO - 'LANGUAGE': 'en_US:en', 04:08:52 INFO - 'LOGNAME': 'cltbld', 04:08:52 INFO - 'MAIL': '/var/mail/cltbld', 04:08:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:52 INFO - 'MOZ_NO_REMOTE': '1', 04:08:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:52 INFO - 'NO_EM_RESTART': '1', 04:08:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:52 INFO - 'PWD': '/builds/slave/test', 04:08:52 INFO - 'SHELL': '/bin/bash', 04:08:52 INFO - 'SHLVL': '1', 04:08:52 INFO - 'TERM': 'linux', 04:08:52 INFO - 'TMOUT': '86400', 04:08:52 INFO - 'USER': 'cltbld', 04:08:52 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 04:08:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:52 INFO - '_': '/tools/buildbot/bin/python'} 04:08:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:08:52 INFO - Running setup.py (path:/tmp/pip-HezROk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:08:52 INFO - Running setup.py (path:/tmp/pip-VeHW77-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:08:52 INFO - Running setup.py (path:/tmp/pip-1QGRyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:08:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:08:52 INFO - Running setup.py (path:/tmp/pip-yEg9fF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:08:53 INFO - Running setup.py (path:/tmp/pip-ttpGZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:08:53 INFO - Running setup.py (path:/tmp/pip-mGeN6b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:08:53 INFO - Running setup.py (path:/tmp/pip-sL43mN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:08:53 INFO - Running setup.py (path:/tmp/pip-V0xxs7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:08:53 INFO - Running setup.py (path:/tmp/pip-HuW1L5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:08:53 INFO - Running setup.py (path:/tmp/pip-NWHKAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:08:53 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)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:08:53 INFO - Running setup.py (path:/tmp/pip-feyDV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:08:53 INFO - Running setup.py (path:/tmp/pip-3q7iiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:08:53 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)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:08:53 INFO - Running setup.py (path:/tmp/pip-G6eQys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:08:53 INFO - Running setup.py (path:/tmp/pip-eaDGVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:08:53 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)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:53 INFO - Running setup.py (path:/tmp/pip-EHOP_D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:08:53 INFO - Running setup.py (path:/tmp/pip-scP9WJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:08:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:08:53 INFO - Running setup.py (path:/tmp/pip-C9qXCT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:08:54 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:08:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:08:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:08:55 INFO - Downloading blessings-1.6.tar.gz 04:08:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:08:55 INFO - Installing collected packages: blessings 04:08:55 INFO - Running setup.py install for blessings 04:08:56 INFO - Successfully installed blessings 04:08:56 INFO - Cleaning up... 04:08:56 INFO - Return code: 0 04:08:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:08:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:56 INFO - Reading from file tmpfile_stdout 04:08:56 INFO - Current package versions: 04:08:56 INFO - argparse == 1.2.1 04:08:56 INFO - blessings == 1.6 04:08:56 INFO - blobuploader == 1.2.4 04:08:56 INFO - docopt == 0.6.1 04:08:56 INFO - functools32 == 3.2.3-2 04:08:56 INFO - jsonschema == 2.5.1 04:08:56 INFO - manifestparser == 1.1 04:08:56 INFO - mozInstall == 1.12 04:08:56 INFO - mozcrash == 0.17 04:08:56 INFO - mozdebug == 0.1 04:08:56 INFO - mozdevice == 0.48 04:08:56 INFO - mozfile == 1.2 04:08:56 INFO - mozhttpd == 0.7 04:08:56 INFO - mozinfo == 0.9 04:08:56 INFO - mozleak == 0.1 04:08:56 INFO - mozlog == 3.2 04:08:56 INFO - moznetwork == 0.27 04:08:56 INFO - mozprocess == 0.22 04:08:56 INFO - mozprofile == 0.28 04:08:56 INFO - mozrunner == 6.11 04:08:56 INFO - mozscreenshot == 0.1 04:08:56 INFO - mozsystemmonitor == 0.3 04:08:56 INFO - moztest == 0.7 04:08:56 INFO - mozversion == 1.4 04:08:56 INFO - psutil == 3.1.1 04:08:56 INFO - requests == 1.2.3 04:08:56 INFO - wsgiref == 0.1.2 04:08:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:56 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 0xb8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c3b0>, '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 0xe4d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:08:56 INFO - Using env: {'DISPLAY': ':0', 04:08:56 INFO - 'HOME': '/home/cltbld', 04:08:56 INFO - 'LANG': 'en_US.UTF-8', 04:08:56 INFO - 'LANGUAGE': 'en_US:en', 04:08:56 INFO - 'LOGNAME': 'cltbld', 04:08:56 INFO - 'MAIL': '/var/mail/cltbld', 04:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:56 INFO - 'MOZ_NO_REMOTE': '1', 04:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:56 INFO - 'NO_EM_RESTART': '1', 04:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:56 INFO - 'PWD': '/builds/slave/test', 04:08:56 INFO - 'SHELL': '/bin/bash', 04:08:56 INFO - 'SHLVL': '1', 04:08:56 INFO - 'TERM': 'linux', 04:08:56 INFO - 'TMOUT': '86400', 04:08:56 INFO - 'USER': 'cltbld', 04:08:56 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 04:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:56 INFO - '_': '/tools/buildbot/bin/python'} 04:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:08:56 INFO - Cleaning up... 04:08:56 INFO - Return code: 0 04:08:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:08: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')]} 04:08:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:08:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08: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')]} 04:08:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:08:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:08:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xb8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xcf08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe4e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe4c3b0>, '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 0xe4d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d740>, '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': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:08:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:08:56 INFO - Using env: {'DISPLAY': ':0', 04:08:56 INFO - 'HOME': '/home/cltbld', 04:08:56 INFO - 'LANG': 'en_US.UTF-8', 04:08:56 INFO - 'LANGUAGE': 'en_US:en', 04:08:56 INFO - 'LOGNAME': 'cltbld', 04:08:56 INFO - 'MAIL': '/var/mail/cltbld', 04:08:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:08:56 INFO - 'MOZ_NO_REMOTE': '1', 04:08:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:08:56 INFO - 'NO_EM_RESTART': '1', 04:08:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:08:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:08:56 INFO - 'PWD': '/builds/slave/test', 04:08:56 INFO - 'SHELL': '/bin/bash', 04:08:56 INFO - 'SHLVL': '1', 04:08:56 INFO - 'TERM': 'linux', 04:08:56 INFO - 'TMOUT': '86400', 04:08:56 INFO - 'USER': 'cltbld', 04:08:56 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 04:08:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:08:56 INFO - '_': '/tools/buildbot/bin/python'} 04:08:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:08:56 INFO - Cleaning up... 04:08:56 INFO - Return code: 0 04:08:56 INFO - Running post-action listener: _resource_record_post_action 04:08:56 INFO - Running post-action listener: _start_resource_monitoring 04:08:56 INFO - Starting resource monitoring. 04:08:56 INFO - ##### 04:08:56 INFO - ##### Finished create-virtualenv step (success) 04:08:56 INFO - ##### 04:08:56 INFO - ##### 04:08:56 INFO - ##### Running install step. 04:08:56 INFO - ##### 04:08:56 INFO - Running pre-action listener: _resource_record_pre_action 04:08:56 INFO - Running main action method: install 04:08:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:08:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:08:57 INFO - Reading from file tmpfile_stdout 04:08:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:08:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:08:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:08:57 INFO - Reading from file tmpfile_stdout 04:08:57 INFO - Output received: 04:08:57 INFO - Usage: mozinstall [options] installer 04:08:57 INFO - Options: 04:08:57 INFO - -h, --help show this help message and exit 04:08:57 INFO - -d DEST, --destination=DEST 04:08:57 INFO - Directory to install application into. [default: 04:08:57 INFO - "/builds/slave/test"] 04:08:57 INFO - --app=APP Application being installed. [default: firefox] 04:08:57 INFO - mkdir: /builds/slave/test/build/application 04:08:57 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'] 04:08:57 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 04:09:13 INFO - Reading from file tmpfile_stdout 04:09:13 INFO - Output received: 04:09:13 INFO - /builds/slave/test/build/application/firefox/firefox 04:09:13 INFO - Running post-action listener: _resource_record_post_action 04:09:13 INFO - ##### 04:09:13 INFO - ##### Finished install step (success) 04:09:13 INFO - ##### 04:09:13 INFO - ##### 04:09:13 INFO - ##### Running run-tests step. 04:09:13 INFO - ##### 04:09:13 INFO - Running pre-action listener: _resource_record_pre_action 04:09:13 INFO - Running main action method: run_tests 04:09:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:09:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:09:13 INFO - Python 2.7.3 04:09:13 INFO - Return code: 0 04:09:13 INFO - grabbing minidump binary from tooltool 04:09:13 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')]} 04:09:13 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 0xe4c3b0>, '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 0xe4d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe4d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:09:13 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:09:13 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:09:13 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:09:13 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:09:13 INFO - Return code: 0 04:09:13 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:09:13 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:09:13 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:09:13 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:09:13 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:09:13 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/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:09:13 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/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:09:13 INFO - Using env: {'DISPLAY': ':0', 04:09:13 INFO - 'HOME': '/home/cltbld', 04:09:13 INFO - 'LANG': 'en_US.UTF-8', 04:09:13 INFO - 'LANGUAGE': 'en_US:en', 04:09:13 INFO - 'LOGNAME': 'cltbld', 04:09:13 INFO - 'MAIL': '/var/mail/cltbld', 04:09:13 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:09:13 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:09:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:09:13 INFO - 'MOZ_NO_REMOTE': '1', 04:09:13 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:09:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:09:13 INFO - 'NO_EM_RESTART': '1', 04:09:13 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:09:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:09:13 INFO - 'PWD': '/builds/slave/test', 04:09:13 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:09:13 INFO - 'SHELL': '/bin/bash', 04:09:13 INFO - 'SHLVL': '1', 04:09:13 INFO - 'TERM': 'linux', 04:09:13 INFO - 'TMOUT': '86400', 04:09:13 INFO - 'USER': 'cltbld', 04:09:13 INFO - 'XDG_SESSION_COOKIE': 'db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757', 04:09:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:09:13 INFO - '_': '/tools/buildbot/bin/python'} 04:09:13 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/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:09:13 INFO - mozversion application_buildid: 20160630025528 04:09:13 INFO - mozversion application_changeset: d700dc054751333e0735f975fce3d3adf153c62a 04:09:13 INFO - mozversion application_display_name: Nightly 04:09:13 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:09:13 INFO - mozversion application_name: Firefox 04:09:13 INFO - mozversion application_remotingname: firefox 04:09:13 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:09:13 INFO - mozversion application_vendor: Mozilla 04:09:13 INFO - mozversion application_version: 50.0a1 04:09:13 INFO - mozversion platform_buildid: 20160630025528 04:09:13 INFO - mozversion platform_changeset: d700dc054751333e0735f975fce3d3adf153c62a 04:09:13 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:09:13 INFO - mozversion platform_version: 50.0a1 04:09:13 INFO - using testdate: 1467284953 04:09:13 INFO - actual date: 1467284953 04:09:13 INFO - starting webserver on 'localhost:60052' 04:09:13 INFO - SUITE-START | Running 2 tests 04:09:13 INFO - TEST-START | dromaeo_css 04:09:13 INFO - operating with platform_type : linux_ 04:09:13 INFO - Initialising browser for dromaeo_css test... 04:09:13 INFO - TEST-INFO | started process 23539 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm3frdl/profile http://localhost:60052/getInfo.html) 04:09:17 INFO - PROCESS | 23539 | __metrics Screen width/height:1600/1200 04:09:17 INFO - PROCESS | 23539 | colorDepth:24 04:09:17 INFO - PROCESS | 23539 | Browser inner width/height: 1024/697 04:09:17 INFO - PROCESS | 23539 | __metrics 04:09:19 INFO - PROCESS | 23539 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:09:20 INFO - TEST-INFO | 23539: exit 0 04:09:20 INFO - Browser initialized. 04:09:20 INFO - Running cycle 1/1 for dromaeo_css test... 04:09:20 INFO - TEST-INFO | started process 23623 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpm3frdl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:09:31 INFO - PROCESS | 23623 | RSS: Main: 158924800 04:09:31 INFO - PROCESS | 23623 | 04:10:22 INFO - PROCESS | 23623 | 1467285022970 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:12:35 INFO - PROCESS | 23623 | Cycle 1(1): loaded http://localhost:60052/tests/dromaeo/cssquery-dojo.html (next: http://localhost:60052/tests/dromaeo/cssquery-ext.html) 04:12:37 INFO - PROCESS | 23623 | RSS: Main: 279117824 04:12:37 INFO - PROCESS | 23623 | 04:15:40 INFO - PROCESS | 23623 | Cycle 1(1): loaded http://localhost:60052/tests/dromaeo/cssquery-ext.html (next: http://localhost:60052/tests/dromaeo/cssquery-jquery.html) 04:15:40 INFO - PROCESS | 23623 | RSS: Main: 239591424 04:15:40 INFO - PROCESS | 23623 | 04:18:42 INFO - PROCESS | 23623 | Cycle 1(1): loaded http://localhost:60052/tests/dromaeo/cssquery-jquery.html (next: http://localhost:60052/tests/dromaeo/cssquery-mootools.html) 04:18:43 INFO - PROCESS | 23623 | RSS: Main: 244137984 04:18:43 INFO - PROCESS | 23623 | 04:21:45 INFO - PROCESS | 23623 | Cycle 1(1): loaded http://localhost:60052/tests/dromaeo/cssquery-mootools.html (next: http://localhost:60052/tests/dromaeo/cssquery-prototype.html) 04:21:46 INFO - PROCESS | 23623 | RSS: Main: 237256704 04:21:46 INFO - PROCESS | 23623 | 04:24:49 INFO - PROCESS | 23623 | Cycle 1(1): loaded http://localhost:60052/tests/dromaeo/cssquery-prototype.html (next: http://localhost:60052/tests/dromaeo/cssquery-yui.html) 04:24:49 INFO - PROCESS | 23623 | RSS: Main: 232722432 04:24:49 INFO - PROCESS | 23623 | 04:27:52 INFO - PROCESS | 23623 | Cycle 1(1): loaded http://localhost:60052/tests/dromaeo/cssquery-yui.html (next: http://localhost:60052/tests/dromaeo/cssquery-dojo.html) 04:27:52 INFO - PROCESS | 23623 | RSS: Main: 270737408 04:27:52 INFO - PROCESS | 23623 | 04:27:52 INFO - PROCESS | 23623 | __start_tp_report 04:27:52 INFO - PROCESS | 23623 | _x_x_mozilla_page_load 04:27:52 INFO - PROCESS | 23623 | _x_x_mozilla_page_load_details 04:27:52 INFO - PROCESS | 23623 | |i|pagename|runs| 04:27:52 INFO - PROCESS | 23623 | |0;dojo.html;2641.432092100198;2655.8273712208716;2680.986595067025;2702.3244188952763;2704.9188524344263;4659.813607455706;4711.623070154388;4733.266343716721;4781.426228852538;4819.614430845532;4643.373144625474;4656.045510670313;4708.36437080994;4786.37777088978;4802.423709154907;4203;4229.661627069842;4277.358396240557;4304.548022457644;4425.446819147606;4350.456192975878;4353.499347575038;4378.102488989765;4417.094495628388;4434.800433980478;4304;4313.805878735465;4354.564543545652;4357.586029327209;4380.78096095194;4306.590873866978;4315.287977483711;4318.028443600197;4318.460192475941;4414.690971631987;4341.565843415665;4345.087531618364;4345.41336919515;4385.342198670193;4386.451693538308;4672.0889426561835;4694.319323698079;4785.019071090418;4804.783784729696;4834.854954351375;5195.350581177353;5200.24596433515;5212.139996900507;5212.374515058217;5212.713300768494;5176.715280659562;5195.792168313263;5234;5236.423993360727;5237.973810130963;4685.718856868599;4775.808967641325;4813.15769740294;4817.975910120427;4893.608511319086;5265.736713164327;5275.103232450492;5321.467853214647;5340.145576707708;5343.091674415358;5065.240213967934;5067.923981140286;5109.131447653907;5119.129747942859;5123.231515272739;4949.876253093629;5042.117629414838;5093.363329583802;5095.490450954949;5112.488751124932;5014.373203349582;5035.924461133086;5042.243663450512;5053.166227572483;5098.439171691111;4847.95152048475;5016.623753218523;5029.698218106852;5032.647714659939;5035.370578677665;4202.768847713405;4234.534201237861;4257.829686812554;4268.039691069484;4321.978390108029;3723.906902327409;3736.4021756518828;3754.5869954305003;3779.848806047782;3788.886333410002;4405.603495685404;4420.292753159479;4421.38100665907;4430.867073987785;4464.799084041226;4995.225740010304;5020.5732512736095;5028.849134525897;5040.823571174991;5045.394552653705;4352.064306174188;4359.280718681445;4364;4369.060651959844;4414.80133393998;4444.28891377378;4510.323451482238;4514.977425112919;4517.1417430688725;4555.362249285103;4752.239641657387;4787.880302992453;4844.346013288161;4860.73265970375;4865.805367785249;5125.333706618116;5148.742562871917;5149.536541711264;5150.381954165524;5210.114280572236;4694.976525117352;4799.640026997919;4870.025994801124;4877.365942427462;4920.532549407801;5010.69935803853;5060.898782024413;5076.441591424867;5086.516780905808;5137.1010073237785;5132.024915266087;5138.948610513847;5140.357455318085;5145.176771716508;5195.168772996453;4869.050535145754;4878.121938051185;4912.164931961646;5002.799888004439;5010.5240002199735;4908.460069392293;4939.827106051271;4942.8022879085875;4943.752812359439;4982.327385802871;4874.90250194987;4877.853664390074;4879.634027448026;4919.557239848431;4922.532359425849;4858.5384388483035;4898.289747986593;4923.950760492349;4924.72913989734;5006.574441172541;4797.472278049342;4805.3512775774825;4857.295692124693;4862.975685121552;4873.975630121827 04:27:52 INFO - PROCESS | 23623 | |1;ext.html;578.0952808854142;580.7909152705025;580.8664007278327;585.8359659295398;588.1794896119912;27680.723192768066;28107.718922810793;40006.39990400146;40590.39114413286;41768.164636707246;37172.62827371725;37814.62185378146;37843.4323485148;42322.36516452248;42439.78780106095;7862.764117076483;8016.358691304711;8016.879746803803;8019.278264956153;8022.398320125984;7411.592362420065;10219.335743176707;10470.21473389495;10476.214283928697;10806.72983175423;10334.948325258401;10400;10417.635382761604;10423.218258630595;10423.374597524135;10359.171266298716;10378.481075946172;10421.062104410563;10424.94787526065;10435.686929392092;10281.794364112751;10290.485475726258;10359.637412690596;10368.844467332996;10370.170386369073;39163;39482;39510.40734388986;39519.40720889189;39540.20919581592;3200.8719651213923;3231.111444352798;3249.69127932846;3284.1297056280105;3649.6897763690117;30073;30184.396312073855;30433.69566304331;30690;31194.064178074466;3330.500424936279;3396.490526421032;3538.5576802899636;3568.232829941549;3611.4402267648557;214464;277258;277794;278037;280693;57675;58554;58563.414365855795;58616;58670.41329586649;60749.39250607437;61083.38916610777;61159.694201528706;61168.694156529826;61225.08162377568;15124.470643527424;15760.369585216693;15781;15800.60498487547;15803.841961580467;10539.894601054044;11219.775604487864;11593.826092608617;11981.700457488458;12106.576269830513;18059.27762889496;18239.817601824077;18271.36050238235;18299.72550411745;18333.7249941251;6956.478264130211;6985.79042628722;7141.89287160693;7143.7142514299885;7297.197308296083;688.8209065642969;815.404754529197;848.3425345357274;1014.7767491151935;1015.8171529124828;27709.445811083664;28414.573781393297;28560.714392856222;28744.856275718907;28810.680453007888;987.4174237200086;1003.1773945364877;1003.9247056470793;1013.5793645636978;1086.3916206924148;14896.329665165094;14921.253937303092;14985;15191.240437978056;15376.15431151275;424563;426537;428885;430125;430175;50604.49395505998;51086.74456627767;51115.74442127765;51122.74438627783;51148.74425627923;1083.0847933496184;1187.7149484123747;1209.848768903887;1233.2785320587557;1234.8456442944632;28439.573406399333;29213;29512.409751805273;29847;29932;42377.78811105925;42825.357619635106;42891.356629649956;42969.35545966875;43073.78463107665;310167;313529;314159;315224;315302;22764.20325288607;23361.88319058394;23449.76550234476;24593.754062459862;24639.137630183573;37279.627203727614;43719;43959;47975;48814.51185488242;37177.62822371742;37394.43908341431;37537.81231093827;37823;37958;35185.296294074484;37898.43152352772;38021.809890951474;38028.42957355586;38088.238235235694;35363.11592210215;36534.269314613026;36577.63422365742;37054.629453705114;37291.254174915804;30900.53649195219;33490.33019339648;33864;33930.321393572485;34056;24973.625395619445;25410.74589254084;25911.870440647675;26070.914326854185;26313.342166445993 04:27:52 INFO - PROCESS | 23623 | |2;jquery.html;368.66267365360693;368.9391250443677;375.93984962406023;383.8522168964948;384.7883663984808;16733.41433049842;17776.466705998824;18407.8955262684;18720.90639546804;18732.90633546834;17218;17228.82771172288;17629.911850440763;17632.559186020324;17749.55626109348;5112.105381558222;5295.655782374133;5303.655262407931;5335.173048177519;5339.038972984861;3697.667209951104;3734.8319325630414;5271.103912334893;6141.907871381933;6150.96924515379;6190.41191086846;6205.9379406206035;6226.937730622703;6238.812835614939;6243.219597550306;5978.8505287367725;6170.321264660884;6176.351483094255;6179.752809887599;6188.659623720693;3451.5685539307588;5071.46749591295;5361.437049109865;5370.57035437168;5442.727863606843;21726.935941085572;21764.238251661114;21791.237306694347;21837.454063648376;22035.889820550954;1985.1166231027198;2039.01107962638;2201.1635578480236;2424.187897054489;2455.0945954028;13313.800292995613;13851.792223116561;14064.648383790385;14388.784168237486;14468.782968255484;1754.8596112310984;1796.3443343179777;1801.6486785076916;1835.4952388093247;1858.1266804601817;70957;71854.64072679656;72374.63812680956;72391.63804180999;72834;9479.763005924908;9518.90481095194;9839.262055345878;10160.441175735257;10611.628592999208;13884.51404200848;14036.228007459484;14049;14079;14083.295835208404;7599.126100498403;7603.353714934182;7707.614619269014;7795.220477952273;7822.960885195652;7416.0729908761405;7448.217937116525;7505.849883002309;7624.046994125734;7648.694052237959;6332.145160403379;6359.586626869332;6383.9361606383345;6489.837754056092;6514.73941042353;1706.1384001079375;1719.7162468192607;1750.7023805953017;1753.1059159828578;1786.9910650446925;837.2924878477677;875.3259989807813;876.9561521923878;947.0576776107679;949.3971328206638;17033.829661703472;17234.82765172332;17525.47423577295;17954;18322.908385458253;873.7597160780836;883.9823203536022;897.1387468030633;902.8690839828188;948.9003654616166;9769.169620582188;10047.296689231829;10257.794844103077;10286.074253317238;10348.979540855746;418491;422719;429696;431376;436295;49896.50103498991;71329.64335178395;72366.27633723595;73442;74860;851.1488511488387;887.3522328699956;897.6813231302924;930.0467021303083;931.897491275959;15135.394584216949;15757.527274181793;17322.740158897373;17374.478765636544;17551.82448175502;36930.44604330991;38048;38141.61858381492;38212;38433;47462.288065679735;47737.76131119322;48179.518204817505;49317.26024109713;52273;7188.784336469915;7412.62936853166;7487.101547814297;7701.152873184057;7791.22087791239;10216.693499195037;10551.419671918118;10586.258961872594;10654.680359589225;10897.727556810825;7373.741919032808;8166.060902996232;8341.582920853813;8743;8897.866532001895;8390.202930721573;8456.83086338282;8568.57157142153;8672;9321.347505674537;8144.0634327050775;8298.543834768116;8669.003064647393;9054.637814487347;9093.954530227307;7115.2884711530505;7179.712811487482;7218.27817218274;7227.566346019255;7254.746083887038;8413.242808147295;9033.50315732641;9043.502607356395;9207.263418926335;9229.723108306762 04:27:52 INFO - PROCESS | 23623 | |3;mootools.html;1373.8694823991723;1419.1343280598835;1496.618362317609;1676.6814305282003;1718.9828101718988;7722.459427840054;8171.468854524466;8268.834623307544;8275.503469791816;8275.958620206899;6776.186857577098;7167.354938055574;7258;7302.3427891489755;8100.878486822688;2145.410012246633;2170.924017659382;2176.7823217678265;2179.727534058243;2180.5420861619;2177.575372802304;2183.5087105401235;2196.9780302197014;2213.1258153029544;2217.2572188316853;1868.271374164077;2142.9035693393757;2196.879171645559;2198.857074290174;2240.9439764005947;2225.299030805307;2236.7539570647214;2245.079517397859;2258.3563684349883;2260.6722025306403;2256.4020534558354;2261.8982145803316;2264.0038383111378;2264.4452109233343;2264.8754318512474;8143.389245806529;8174.26431621151;8181.140980197112;8193.385496087818;8200.958995204986;4521.7739113044545;4565.954340456587;4711.128441238382;4734.053189362141;4825.927611085836;2968.5695574141846;3054.3433161870303;3083.8458077096057;3100.2404410919244;3102.10039088664;947.147567189528;955.1833182628822;964.3394274921701;967.0957654592978;978.8923218445965;11179.105671546256;11179.329240245612;11186.888131118665;11239.100871930226;11242.381669008202;4199.727017743837;4249.2988656871885;4297.699161058696;4367.432233809648;4382.342648602735;9514.952425237829;9635.710928672152;9637.18083962871;9645.565949532287;9646.565904534173;4811.927821082687;4829.975850120727;4837.419509658864;4840.733759643183;4844.128056949783;4340.262155433584;4395.7362558246605;4397.274449715825;4405.052913623586;4435.800388982503;3673.1368128489785;3727.6458736419995;3780.5652349979555;3798.5061941947924;3945.072907866649;1067.3115840283128;1176.347127344315;1195.109643315718;1195.6532605544294;1212.2726364181422;714.7962830593256;753.8680730872076;768.8808234723626;806.3065763443434;842.0568962761623;5171.120909445403;5222.660527065728;5241.580673546107;5267.209918512254;5303.920441193385;837.2339309531832;842.9367797415218;845.0957475501277;845.2688424512875;848.5121055393174;3621.0766254604905;3675.5221821163077;3676.2647470506004;3715.256948610289;3775.3959366501776;9721.708348749407;9996.100350968301;10005.699829005142;10137.036981486746;10169.54237059334;8770.605322760364;9978.451185184884;9979.251556133318;10008.949955250177;10014.849777253346;7214.422846172293;7573.015507984037;7585.241475852481;7741.922580774233;7749.186335434811;5492.395836458067;5503.3120859892515;5560.054790685513;5659;5663.745131469176;8872.201501864864;9017.819643607223;9156.267498599962;9389.201917837061;9418.387804792666;9375.859362109437;9383.624655013722;9514.571844267162;9718.368306060367;9724.367916085432;7148;7148.03501527308;7222.09723784527;7240.312170343809;7292.1614014386905;7360.263973602597;7364.116306043309;7374.188839227573;7402.814929626802;7413.629318534159;6937.687804048931;7070.717171313296;7071.328223818729;7138.750143744944;7195.640217988975;6864.4165245954655;6979.30206979298;7025.086738723933;7052.435805135474;7072.646367681698;5642.266505354278;6030.698465076641;6034.758609655564;6111.236095488064;6191.690415479298;4381.342798580238;4408.625266852354;4441.200583894801;4483;4535.682502224945;4533.591976722111;4551.226291530382;4581.152486789954;4599.264117741145;4619.076184762994 04:27:52 INFO - PROCESS | 23623 | |4;prototype.html;289.0980141957093;289.39949604570495;289.70739553051425;296.5255591054313;301.59736751436833;4858.708477491353;4895.437024742151;4911.140550403674;4918.3114363989025;4927.531884470978;4842.951570484294;4867.123917694814;4881.8291359802415;4888.388951381077;4891.779869905854;3784.829682664287;3811.8856434307013;3819.1216020315346;3822.4075268333454;3832.3676593362134;3622.225109696243;3672.5042119313953;3847.3844184930417;3848.749831260959;3864.3430616795213;3333.683300086488;3521.489384039313;3684.299983003221;3732.9440058399146;3796.297684928283;3720.795356255405;3740.925181496355;3765.1151979284846;3783.2433513297315;3810.7713537187856;3361;3361.5629968104236;3383.2218589724257;3396.5075064115813;3398.5072164536004;4459.241928872099;4588.816447342136;4696.741679207642;4709.7174169549935;4723.48041715411;4307.870763877088;4318.82724691012;4322.962489002648;4323.718958267703;4327.7186982846015;5037.330214986063;5048.3941926969;5050.4697006814495;5061.861081256725;5111.670965548947;3605.56733192016;3700.296943580711;3723.94414083789;3736.215394767102;3737.2712321097397;5277.393099793535;5286.471352864683;5286.841394758163;5305.946940530584;5312.4687531246955;3787.5833658297565;3806.8667596633986;3816.923661526754;3818.560865500503;3821.885343439701;3854.768713877176;3874.7287689862;3875;3882.514685664292;3883;4046.5548789633117;4261.978690106592;4269.615734583902;4320.3519472078815;4344.391785150082;5065.11360511909;5094.133997220481;5108.361454818148;5129.204973229155;5143.948560514347;1286.2668279080833;1287.3498883063992;1293.224065560675;1294.2040645003444;1294.7863602505481;820.2904487618287;825.6871574197055;833.5790425834914;834.7829564313322;845.2815107158866;4021.3565829467143;4037.394390841397;4047.6559492442884;4076.6534844538546;4079.551249362568;4629.421322334708;4665.4634717007975;4672.392588963413;4682.742449165328;4738.597219236403;4065.735727177724;4075.612816782401;4082.857100001486;4104.179164167119;4165.937510937339;2378.762123787642;2500.349769152387;2513.4219129600297;2524.457241693045;2536.3278731136265;4438.889027774267;4470.2177119004045;4485.116251174514;4493.685442019093;4729.314249433813;5127.974360128175;5351.581830814837;5367.141257398797;5406.729663516809;5415.6479828811;4936.851894443173;4958.305837182726;4959.231319145538;4963.851084467472;4974.776135073858;4913.606911447004;5227.529522343008;5243.423223445342;5244.344456942882;5267.71027593486;5117.2068329409;5129.461406552258;5134.743262836918;5143.125668636416;5174;4952.276248063623;4959.718529476481;4973.825916092919;5031.974840125776;5040.445550989315;3628.8569100733184;3700.870469533553;3730.7948062856804;3740.1210715482384;3805;5189.6107791915;5190.818321358885;5195.844124676266;5222.608304377263;5248.110680155065;5037.622178336566;5039.2944987702485;5071.467495912876;5112.514311140584;5126.615503837302;4923.950760492349;4978.502149784992;5021.698698078127;5025.824096156617;5040.6219533534395;4971.154903666313;4995.25071239317;5006.4743201963265;5008.99820035987;5019.164172242671;5097.923531146962;5104.744762761921;5116.539511443988;5118.897622047463;5122.923156152586;4796.2805579162;5000.524950129732;5002.673222307125;5005.549500544968;5019.447860735389 04:27:52 INFO - PROCESS | 23623 | |5;yui.html;672.7847088931541;690.854920466702;738.294928343432;756.7691853984534;756.8183635927379;11644.941775291123;11852.585159519418;12268.509259629614;12277.69305767354;12301.876981230185;12430.254184748921;12447.377631118454;12493.625191244255;12527.749445011093;12554.623361299153;631.4474834519796;765.6248438265266;765.6401491299081;791.3669064748207;797.2943944609034;792.9722459713911;794.1542257495778;795.0499153511556;795.6658203554492;795.7135431244748;842.7261140129483;845.7251393297172;845.7716416567523;845.8266055458616;846.2130218896424;662.4700239808159;796.6176235407037;824.1922915542801;825.0305890578546;839.9076101628847;604.0456079394546;604.6221111805122;605.7849463440504;607.8206928955968;607.8996965500687;12202.084843636674;12245.142840001203;12245.571405000783;12265.141440099196;12276.693082673004;11705.414729263588;12148.21036632616;12148.21036632616;12348.135630505778;12350.0737444692;9046.77383065422;9129;9206.401583897024;9256.768580785534;11090.833637495443;3966.226585815767;3971.8808435746973;4014.8193331300163;4036.616521430489;4055.2092341993325;61387.693061534854;63270.367296326905;63296.05055924119;63487.36512634861;63527;9409.200217981548;9878.703638890845;9921.801563968824;9997.250206234561;10043.19654427644;16658.416955406745;16730.916345418438;16746.581335466468;16761.1619419031;16762.832371676126;6464.935350646528;6528.445082168069;6757.155355580552;6769.898451523231;6983.441324694012;3658.5243918290453;3797.9240415192094;3808.409696496992;3813.675837553839;3965.20695860829;2688.206978941217;2773.3759904021435;2775.4171623959196;2775.750182483546;2777.402858385457;480.9302651115569;484.4912841516394;485.57754753364094;508.4788092205519;523.0976565424612;524.1822756499872;538.727942389091;551.2530521143792;569.9939606594364;571.8313097636208;7995.640196191069;8182.263596276363;8281.8343633127;8333.458325208841;8784.472931624123;511.987200319995;526.8129813916081;533.5704757670113;566.9652883487652;640.9038644203407;3785.280796648683;3828.4257361395457;3882.2041481496226;3940.5271367435516;4009.3785463253244;73414;89421;91119;91467.54266228626;93919.06080939103;68018.65990670114;78746;80264;80801.59599202084;80945.59527202326;69296.6535167321;69751.3024869755;71136.64431677808;71751.2824871755;72609.27390726026;8140.75577732669;8204.753857384288;8769.605367758593;8789.516576588348;8938.68714594986;39501.40747888727;43283.35074973941;44176.55823441853;45036.32445513254;45686.31470527878;53999.460005401015;59666.70166649139;61368.38631613627;62194.37805621886;62367.37632623615;10942.069924056545;11027.062699670298;11079.16906232052;11201.43992800373;11311.151663625425;12113.515459381526;12113.576024839442;12229.14395992272;12342.81485777732;12925.741485170432;7454.366378857858;10279.229057820543;10640.680779576625;10778.245522813328;10947.178961577754;11247.325160490396;11519.88480115188;11690.649280521598;11699.88300117022;11911.940440297743;10461.320014199053;10521.842172367573;10589.152867770714;10770.192235582206;10875.347479151276;9748.994936167897;9824.803503930025;10015.449150296803;10243;10276.743081423025;9294.535273236175;10018.148457380912;10100.393976361442;10121.34296136404;10233.437160956219 04:27:52 INFO - PROCESS | 23623 | __end_tp_report 04:27:52 INFO - PROCESS | 23623 | __start_cc_report 04:27:52 INFO - PROCESS | 23623 | _x_x_mozilla_cycle_collect,1130 04:27:52 INFO - PROCESS | 23623 | __end_cc_report 04:27:52 INFO - PROCESS | 23623 | __startTimestamp1467286072943__endTimestamp 04:27:52 INFO - PROCESS | 23623 | 04:27:52 INFO - PROCESS | 23623 | ------- Summary: start ------- 04:27:52 INFO - PROCESS | 23623 | Number of tests: 6 04:27:52 INFO - PROCESS | 23623 | 04:27:52 INFO - PROCESS | 23623 | [#0] dojo.html Cycles:165 Average:4704.66 Median:4857.30 stddev:506.55 (10.4%) stddev-sans-first:481.56 04:27:52 INFO - PROCESS | 23623 | Values: 2641.4 2655.8 2681.0 2702.3 2704.9 4659.8 4711.6 4733.3 4781.4 4819.6 4643.4 4656.0 4708.4 4786.4 4802.4 4203.0 4229.7 4277.4 4304.5 4425.4 4350.5 4353.5 4378.1 4417.1 4434.8 4304.0 4313.8 4354.6 4357.6 4380.8 4306.6 4315.3 4318.0 4318.5 4414.7 4341.6 4345.1 4345.4 4385.3 4386.5 4672.1 4694.3 4785.0 4804.8 4834.9 5195.4 5200.2 5212.1 5212.4 5212.7 5176.7 5195.8 5234.0 5236.4 5238.0 4685.7 4775.8 4813.2 4818.0 4893.6 5265.7 5275.1 5321.5 5340.1 5343.1 5065.2 5067.9 5109.1 5119.1 5123.2 4949.9 5042.1 5093.4 5095.5 5112.5 5014.4 5035.9 5042.2 5053.2 5098.4 4848.0 5016.6 5029.7 5032.6 5035.4 4202.8 4234.5 4257.8 4268.0 4322.0 3723.9 3736.4 3754.6 3779.8 3788.9 4405.6 4420.3 4421.4 4430.9 4464.8 4995.2 5020.6 5028.8 5040.8 5045.4 4352.1 4359.3 4364.0 4369.1 4414.8 4444.3 4510.3 4515.0 4517.1 4555.4 4752.2 4787.9 4844.3 4860.7 4865.8 5125.3 5148.7 5149.5 5150.4 5210.1 4695.0 4799.6 4870.0 4877.4 4920.5 5010.7 5060.9 5076.4 5086.5 5137.1 5132.0 5138.9 5140.4 5145.2 5195.2 4869.1 4878.1 4912.2 5002.8 5010.5 4908.5 4939.8 4942.8 4943.8 4982.3 4874.9 4877.9 4879.6 4919.6 4922.5 4858.5 4898.3 4924.0 4924.7 5006.6 4797.5 4805.4 4857.3 4863.0 4874.0 04:27:52 INFO - PROCESS | 23623 | 04:27:52 INFO - PROCESS | 23623 | [#1] ext.html Cycles:180 Average:49705.27 Median:3266.91 stddev:90391.32 (2766.9%) stddev-sans-first:90569.63 04:27:52 INFO - PROCESS | 23623 | Values: 578.1 580.8 580.9 585.8 588.2 27680.7 28107.7 40006.4 40590.4 41768.2 37172.6 37814.6 37843.4 42322.4 42439.8 7862.8 8016.4 8016.9 8019.3 8022.4 7411.6 10219.3 10470.2 10476.2 10806.7 10334.9 10400.0 10417.6 10423.2 10423.4 10359.2 10378.5 10421.1 10424.9 10435.7 10281.8 10290.5 10359.6 10368.8 10370.2 39163.0 39482.0 39510.4 39519.4 39540.2 3200.9 3231.1 3249.7 3284.1 3649.7 30073.0 30184.4 30433.7 30690.0 31194.1 3330.5 3396.5 3538.6 3568.2 3611.4 214464.0 277258.0 277794.0 278037.0 280693.0 57675.0 58554.0 58563.4 58616.0 58670.4 60749.4 61083.4 61159.7 61168.7 61225.1 15124.5 15760.4 15781.0 15800.6 15803.8 10539.9 11219.8 11593.8 11981.7 12106.6 18059.3 18239.8 18271.4 18299.7 18333.7 6956.5 6985.8 7141.9 7143.7 7297.2 688.8 815.4 848.3 1014.8 1015.8 27709.4 28414.6 28560.7 28744.9 28810.7 987.4 1003.2 1003.9 1013.6 1086.4 14896.3 14921.3 14985.0 15191.2 15376.2 424563.0 426537.0 428885.0 430125.0 430175.0 50604.5 51086.7 51115.7 51122.7 51148.7 1083.1 1187.7 1209.8 1233.3 1234.8 28439.6 29213.0 29512.4 29847.0 29932.0 42377.8 42825.4 42891.4 42969.4 43073.8 310167.0 313529.0 314159.0 315224.0 315302.0 22764.2 23361.9 23449.8 24593.8 24639.1 37279.6 43719.0 43959.0 47975.0 48814.5 37177.6 37394.4 37537.8 37823.0 37958.0 35185.3 37898.4 38021.8 38028.4 38088.2 35363.1 36534.3 36577.6 37054.6 37291.3 30900.5 33490.3 33864.0 33930.3 34056.0 24973.6 25410.7 25911.9 26070.9 26313.3 04:27:52 INFO - PROCESS | 23623 | 04:27:52 INFO - PROCESS | 23623 | [#2] jquery.html Cycles:180 Average:25357.39 Median:5337.11 stddev:70270.02 (1316.6%) stddev-sans-first:70442.09 04:27:52 INFO - PROCESS | 23623 | Values: 368.7 368.9 375.9 383.9 384.8 16733.4 17776.5 18407.9 18720.9 18732.9 17218.0 17228.8 17629.9 17632.6 17749.6 5112.1 5295.7 5303.7 5335.2 5339.0 3697.7 3734.8 5271.1 6141.9 6151.0 6190.4 6205.9 6226.9 6238.8 6243.2 5978.9 6170.3 6176.4 6179.8 6188.7 3451.6 5071.5 5361.4 5370.6 5442.7 21726.9 21764.2 21791.2 21837.5 22035.9 1985.1 2039.0 2201.2 2424.2 2455.1 13313.8 13851.8 14064.6 14388.8 14468.8 1754.9 1796.3 1801.6 1835.5 1858.1 70957.0 71854.6 72374.6 72391.6 72834.0 9479.8 9518.9 9839.3 10160.4 10611.6 13884.5 14036.2 14049.0 14079.0 14083.3 7599.1 7603.4 7707.6 7795.2 7823.0 7416.1 7448.2 7505.8 7624.0 7648.7 6332.1 6359.6 6383.9 6489.8 6514.7 1706.1 1719.7 1750.7 1753.1 1787.0 837.3 875.3 877.0 947.1 949.4 17033.8 17234.8 17525.5 17954.0 18322.9 873.8 884.0 897.1 902.9 948.9 9769.2 10047.3 10257.8 10286.1 10349.0 418491.0 422719.0 429696.0 431376.0 436295.0 49896.5 71329.6 72366.3 73442.0 74860.0 851.1 887.4 897.7 930.0 931.9 15135.4 15757.5 17322.7 17374.5 17551.8 36930.4 38048.0 38141.6 38212.0 38433.0 47462.3 47737.8 48179.5 49317.3 52273.0 7188.8 7412.6 7487.1 7701.2 7791.2 10216.7 10551.4 10586.3 10654.7 10897.7 7373.7 8166.1 8341.6 8743.0 8897.9 8390.2 8456.8 8568.6 8672.0 9321.3 8144.1 8298.5 8669.0 9054.6 9094.0 7115.3 7179.7 7218.3 7227.6 7254.7 8413.2 9033.5 9043.5 9207.3 9229.7 04:27:52 INFO - PROCESS | 23623 | 04:27:52 INFO - PROCESS | 23623 | [#3] mootools.html Cycles:180 Average:5279.48 Median:5196.89 stddev:2996.08 (57.7%) stddev-sans-first:2990.11 04:27:52 INFO - PROCESS | 23623 | Values: 1373.9 1419.1 1496.6 1676.7 1719.0 7722.5 8171.5 8268.8 8275.5 8276.0 6776.2 7167.4 7258.0 7302.3 8100.9 2145.4 2170.9 2176.8 2179.7 2180.5 2177.6 2183.5 2197.0 2213.1 2217.3 1868.3 2142.9 2196.9 2198.9 2240.9 2225.3 2236.8 2245.1 2258.4 2260.7 2256.4 2261.9 2264.0 2264.4 2264.9 8143.4 8174.3 8181.1 8193.4 8201.0 4521.8 4566.0 4711.1 4734.1 4825.9 2968.6 3054.3 3083.8 3100.2 3102.1 947.1 955.2 964.3 967.1 978.9 11179.1 11179.3 11186.9 11239.1 11242.4 4199.7 4249.3 4297.7 4367.4 4382.3 9515.0 9635.7 9637.2 9645.6 9646.6 4811.9 4830.0 4837.4 4840.7 4844.1 4340.3 4395.7 4397.3 4405.1 4435.8 3673.1 3727.6 3780.6 3798.5 3945.1 1067.3 1176.3 1195.1 1195.7 1212.3 714.8 753.9 768.9 806.3 842.1 5171.1 5222.7 5241.6 5267.2 5303.9 837.2 842.9 845.1 845.3 848.5 3621.1 3675.5 3676.3 3715.3 3775.4 9721.7 9996.1 10005.7 10137.0 10169.5 8770.6 9978.5 9979.3 10008.9 10014.8 7214.4 7573.0 7585.2 7741.9 7749.2 5492.4 5503.3 5560.1 5659.0 5663.7 8872.2 9017.8 9156.3 9389.2 9418.4 9375.9 9383.6 9514.6 9718.4 9724.4 7148.0 7148.0 7222.1 7240.3 7292.2 7360.3 7364.1 7374.2 7402.8 7413.6 6937.7 7070.7 7071.3 7138.8 7195.6 6864.4 6979.3 7025.1 7052.4 7072.6 5642.3 6030.7 6034.8 6111.2 6191.7 4381.3 4408.6 4441.2 4483.0 4535.7 4533.6 4551.2 4581.2 4599.3 4619.1 04:27:52 INFO - PROCESS | 23623 | 04:27:52 INFO - PROCESS | 23623 | [#4] prototype.html Cycles:180 Average:4169.98 Median:4703.23 stddev:1221.99 (26.0%) stddev-sans-first:1190.19 04:27:52 INFO - PROCESS | 23623 | Values: 289.1 289.4 289.7 296.5 301.6 4858.7 4895.4 4911.1 4918.3 4927.5 4843.0 4867.1 4881.8 4888.4 4891.8 3784.8 3811.9 3819.1 3822.4 3832.4 3622.2 3672.5 3847.4 3848.7 3864.3 3333.7 3521.5 3684.3 3732.9 3796.3 3720.8 3740.9 3765.1 3783.2 3810.8 3361.0 3361.6 3383.2 3396.5 3398.5 4459.2 4588.8 4696.7 4709.7 4723.5 4307.9 4318.8 4323.0 4323.7 4327.7 5037.3 5048.4 5050.5 5061.9 5111.7 3605.6 3700.3 3723.9 3736.2 3737.3 5277.4 5286.5 5286.8 5305.9 5312.5 3787.6 3806.9 3816.9 3818.6 3821.9 3854.8 3874.7 3875.0 3882.5 3883.0 4046.6 4262.0 4269.6 4320.4 4344.4 5065.1 5094.1 5108.4 5129.2 5143.9 1286.3 1287.3 1293.2 1294.2 1294.8 820.3 825.7 833.6 834.8 845.3 4021.4 4037.4 4047.7 4076.7 4079.6 4629.4 4665.5 4672.4 4682.7 4738.6 4065.7 4075.6 4082.9 4104.2 4165.9 2378.8 2500.3 2513.4 2524.5 2536.3 4438.9 4470.2 4485.1 4493.7 4729.3 5128.0 5351.6 5367.1 5406.7 5415.6 4936.9 4958.3 4959.2 4963.9 4974.8 4913.6 5227.5 5243.4 5244.3 5267.7 5117.2 5129.5 5134.7 5143.1 5174.0 4952.3 4959.7 4973.8 5032.0 5040.4 3628.9 3700.9 3730.8 3740.1 3805.0 5189.6 5190.8 5195.8 5222.6 5248.1 5037.6 5039.3 5071.5 5112.5 5126.6 4924.0 4978.5 5021.7 5025.8 5040.6 4971.2 4995.3 5006.5 5009.0 5019.2 5097.9 5104.7 5116.5 5118.9 5122.9 4796.3 5000.5 5002.7 5005.5 5019.4 04:27:52 INFO - PROCESS | 23623 | 04:27:52 INFO - PROCESS | 23623 | [#5] yui.html Cycles:180 Average:16886.93 Median:530.19 stddev:23763.91 (4482.1%) stddev-sans-first:23799.38 04:27:52 INFO - PROCESS | 23623 | Values: 672.8 690.9 738.3 756.8 756.8 11644.9 11852.6 12268.5 12277.7 12301.9 12430.3 12447.4 12493.6 12527.7 12554.6 631.4 765.6 765.6 791.4 797.3 793.0 794.2 795.0 795.7 795.7 842.7 845.7 845.8 845.8 846.2 662.5 796.6 824.2 825.0 839.9 604.0 604.6 605.8 607.8 607.9 12202.1 12245.1 12245.6 12265.1 12276.7 11705.4 12148.2 12148.2 12348.1 12350.1 9046.8 9129.0 9206.4 9256.8 11090.8 3966.2 3971.9 4014.8 4036.6 4055.2 61387.7 63270.4 63296.1 63487.4 63527.0 9409.2 9878.7 9921.8 9997.3 10043.2 16658.4 16730.9 16746.6 16761.2 16762.8 6464.9 6528.4 6757.2 6769.9 6983.4 3658.5 3797.9 3808.4 3813.7 3965.2 2688.2 2773.4 2775.4 2775.8 2777.4 480.9 484.5 485.6 508.5 523.1 524.2 538.7 551.3 570.0 571.8 7995.6 8182.3 8281.8 8333.5 8784.5 512.0 526.8 533.6 567.0 640.9 3785.3 3828.4 3882.2 3940.5 4009.4 73414.0 89421.0 91119.0 91467.5 93919.1 68018.7 78746.0 80264.0 80801.6 80945.6 69296.7 69751.3 71136.6 71751.3 72609.3 8140.8 8204.8 8769.6 8789.5 8938.7 39501.4 43283.4 44176.6 45036.3 45686.3 53999.5 59666.7 61368.4 62194.4 62367.4 10942.1 11027.1 11079.2 11201.4 11311.2 12113.5 12113.6 12229.1 12342.8 12925.7 7454.4 10279.2 10640.7 10778.2 10947.2 11247.3 11519.9 11690.6 11699.9 11911.9 10461.3 10521.8 10589.2 10770.2 10875.3 9749.0 9824.8 10015.4 10243.0 10276.7 9294.5 10018.1 10100.4 10121.3 10233.4 04:27:52 INFO - PROCESS | 23623 | -------- Summary: end -------- 04:27:52 INFO - PROCESS | 23623 | 04:27:53 INFO - TEST-INFO | 23623: exit 0 04:27:53 INFO - TEST-OK | dromaeo_css | took 1120094ms 04:27:53 INFO - TEST-START | kraken 04:27:53 INFO - operating with platform_type : linux_ 04:27:53 INFO - Initialising browser for kraken test... 04:27:53 INFO - TEST-INFO | started process 23815 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZf721J/profile http://localhost:60052/getInfo.html) 04:27:58 INFO - PROCESS | 23815 | __metrics Screen width/height:1600/1200 04:27:58 INFO - PROCESS | 23815 | colorDepth:24 04:27:58 INFO - PROCESS | 23815 | Browser inner width/height: 1024/697 04:27:58 INFO - PROCESS | 23815 | __metrics 04:27:59 INFO - PROCESS | 23815 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:00 INFO - TEST-INFO | 23815: exit 0 04:28:00 INFO - Browser initialized. 04:28:00 INFO - Running cycle 1/1 for kraken test... 04:28:00 INFO - TEST-INFO | started process 23898 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZf721J/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:12 INFO - PROCESS | 23898 | RSS: Main: 157868032 04:28:12 INFO - PROCESS | 23898 | 04:28:14 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:60052/tests/kraken/driver.html?testName=audio-beat-detection) 04:28:15 INFO - PROCESS | 23898 | RSS: Main: 215699456 04:28:15 INFO - PROCESS | 23898 | 04:28:18 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:60052/tests/kraken/driver.html?testName=audio-dft) 04:28:19 INFO - PROCESS | 23898 | RSS: Main: 203956224 04:28:19 INFO - PROCESS | 23898 | 04:28:22 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:60052/tests/kraken/driver.html?testName=audio-fft) 04:28:22 INFO - PROCESS | 23898 | RSS: Main: 270831616 04:28:22 INFO - PROCESS | 23898 | 04:28:25 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:60052/tests/kraken/driver.html?testName=audio-oscillator) 04:28:25 INFO - PROCESS | 23898 | RSS: Main: 181751808 04:28:25 INFO - PROCESS | 23898 | 04:28:27 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:60052/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:28:28 INFO - PROCESS | 23898 | RSS: Main: 185102336 04:28:28 INFO - PROCESS | 23898 | 04:28:31 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:60052/tests/kraken/driver.html?testName=imaging-darkroom) 04:28:32 INFO - PROCESS | 23898 | RSS: Main: 221650944 04:28:32 INFO - PROCESS | 23898 | 04:28:35 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:60052/tests/kraken/driver.html?testName=imaging-desaturate) 04:28:36 INFO - PROCESS | 23898 | RSS: Main: 221921280 04:28:36 INFO - PROCESS | 23898 | 04:28:39 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:60052/tests/kraken/driver.html?testName=json-parse-financial) 04:28:39 INFO - PROCESS | 23898 | RSS: Main: 222220288 04:28:39 INFO - PROCESS | 23898 | 04:28:41 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:60052/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:28:42 INFO - PROCESS | 23898 | RSS: Main: 210644992 04:28:42 INFO - PROCESS | 23898 | 04:28:44 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:60052/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:28:44 INFO - PROCESS | 23898 | RSS: Main: 213807104 04:28:44 INFO - PROCESS | 23898 | 04:28:46 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:60052/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:28:47 INFO - PROCESS | 23898 | RSS: Main: 212983808 04:28:47 INFO - PROCESS | 23898 | 04:28:50 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:60052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:28:50 INFO - PROCESS | 23898 | RSS: Main: 225669120 04:28:50 INFO - PROCESS | 23898 | 04:28:53 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:60052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:28:54 INFO - PROCESS | 23898 | RSS: Main: 225128448 04:28:54 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | Cycle 1(1): loaded http://localhost:60052/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:60052/tests/kraken/driver.html?testName=ai-astar) 04:28:56 INFO - PROCESS | 23898 | RSS: Main: 267145216 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | __start_tp_report 04:28:56 INFO - PROCESS | 23898 | _x_x_mozilla_page_load 04:28:56 INFO - PROCESS | 23898 | _x_x_mozilla_page_load_details 04:28:56 INFO - PROCESS | 23898 | |i|pagename|runs| 04:28:56 INFO - PROCESS | 23898 | |0;ai-astar;104;115;115;114;114;116;113;114;115;115 04:28:56 INFO - PROCESS | 23898 | |1;audio-beat-detection;151;125;131;183;124;123;148;127;179;120 04:28:56 INFO - PROCESS | 23898 | |2;audio-dft;162;161;163;162;162;162;163;161;162;161 04:28:56 INFO - PROCESS | 23898 | |3;audio-fft;76;78;79;133;76;78;76;75;100;76 04:28:56 INFO - PROCESS | 23898 | |4;audio-oscillator;85;85;117;85;85;85;121;84;85;130 04:28:56 INFO - PROCESS | 23898 | |5;imaging-gaussian-blur;118;118;117;117;117;117;116;117;119;117 04:28:56 INFO - PROCESS | 23898 | |6;imaging-darkroom;146;146;146;146;145;146;147;147;145;145 04:28:56 INFO - PROCESS | 23898 | |7;imaging-desaturate;95;94;95;94;94;94;95;95;95;94 04:28:56 INFO - PROCESS | 23898 | |8;json-parse-financial;64;64;64;63;67;64;63;63;65;63 04:28:56 INFO - PROCESS | 23898 | |9;json-stringify-tinderbox;64;64;65;64;64;63;64;64;65;65 04:28:56 INFO - PROCESS | 23898 | |10;stanford-crypto-aes;87;78;78;87;78;81;78;84;78;84 04:28:56 INFO - PROCESS | 23898 | |11;stanford-crypto-ccm;129;129;142;125;126;128;127;127;179;136 04:28:56 INFO - PROCESS | 23898 | |12;stanford-crypto-pbkdf2;168;165;177;166;170;167;162;168;171;163 04:28:56 INFO - PROCESS | 23898 | |13;stanford-crypto-sha256-iterative;67;68;70;65;67;67;66;69;69;65 04:28:56 INFO - PROCESS | 23898 | __end_tp_report 04:28:56 INFO - PROCESS | 23898 | __start_cc_report 04:28:56 INFO - PROCESS | 23898 | _x_x_mozilla_cycle_collect,1919 04:28:56 INFO - PROCESS | 23898 | __end_cc_report 04:28:56 INFO - PROCESS | 23898 | __startTimestamp1467286136378__endTimestamp 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | ------- Summary: start ------- 04:28:56 INFO - PROCESS | 23898 | Number of tests: 14 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#0] ai-astar Cycles:10 Average:113.50 Median:115.00 stddev:3.44 (3.0%) stddev-sans-first:0.88 04:28:56 INFO - PROCESS | 23898 | Values: 104.0 115.0 115.0 114.0 114.0 116.0 113.0 114.0 115.0 115.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:139.50 stddev:23.48 (16.8%) stddev-sans-first:24.63 04:28:56 INFO - PROCESS | 23898 | Values: 151.0 125.0 131.0 183.0 124.0 123.0 148.0 127.0 179.0 120.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 04:28:56 INFO - PROCESS | 23898 | Values: 162.0 161.0 163.0 162.0 162.0 162.0 163.0 161.0 162.0 161.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#3] audio-fft Cycles:10 Average:84.70 Median:76.00 stddev:18.52 (24.4%) stddev-sans-first:19.37 04:28:56 INFO - PROCESS | 23898 | Values: 76.0 78.0 79.0 133.0 76.0 78.0 76.0 75.0 100.0 76.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#4] audio-oscillator Cycles:10 Average:96.20 Median:85.00 stddev:18.53 (21.8%) stddev-sans-first:19.21 04:28:56 INFO - PROCESS | 23898 | Values: 85.0 85.0 117.0 85.0 85.0 85.0 121.0 84.0 85.0 130.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#5] imaging-gaussian-blur Cycles:10 Average:117.30 Median:117.00 stddev:0.82 (0.7%) stddev-sans-first:0.83 04:28:56 INFO - PROCESS | 23898 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 116.0 117.0 119.0 117.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#6] imaging-darkroom Cycles:10 Average:145.90 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 04:28:56 INFO - PROCESS | 23898 | Values: 146.0 146.0 146.0 146.0 145.0 146.0 147.0 147.0 145.0 145.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#7] imaging-desaturate Cycles:10 Average:94.50 Median:95.00 stddev:0.53 (0.6%) stddev-sans-first:0.53 04:28:56 INFO - PROCESS | 23898 | Values: 95.0 94.0 95.0 94.0 94.0 94.0 95.0 95.0 95.0 94.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:1.25 (1.9%) stddev-sans-first:1.32 04:28:56 INFO - PROCESS | 23898 | Values: 64.0 64.0 64.0 63.0 67.0 64.0 63.0 63.0 65.0 63.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 04:28:56 INFO - PROCESS | 23898 | Values: 64.0 64.0 65.0 64.0 64.0 63.0 64.0 64.0 65.0 65.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#10] stanford-crypto-aes Cycles:10 Average:81.30 Median:82.50 stddev:3.86 (4.7%) stddev-sans-first:3.50 04:28:56 INFO - PROCESS | 23898 | Values: 87.0 78.0 78.0 87.0 78.0 81.0 78.0 84.0 78.0 84.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#11] stanford-crypto-ccm Cycles:10 Average:134.80 Median:129.00 stddev:16.38 (12.7%) stddev-sans-first:17.24 04:28:56 INFO - PROCESS | 23898 | Values: 129.0 129.0 142.0 125.0 126.0 128.0 127.0 127.0 179.0 136.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.70 Median:168.00 stddev:4.32 (2.6%) stddev-sans-first:4.58 04:28:56 INFO - PROCESS | 23898 | Values: 168.0 165.0 177.0 166.0 170.0 167.0 162.0 168.0 171.0 163.0 04:28:56 INFO - PROCESS | 23898 | 04:28:56 INFO - PROCESS | 23898 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:67.50 stddev:1.70 (2.5%) stddev-sans-first:1.80 04:28:56 INFO - PROCESS | 23898 | Values: 67.0 68.0 70.0 65.0 67.0 67.0 66.0 69.0 69.0 65.0 04:28:56 INFO - PROCESS | 23898 | -------- Summary: end -------- 04:28:56 INFO - PROCESS | 23898 | 04:28:57 INFO - TEST-INFO | 23898: exit 0 04:28:57 INFO - TEST-OK | kraken | took 63731ms 04:28:57 INFO - SUITE-END | took 1183s 04:28:57 INFO - Completed test suite (00:19:43) 04:28:57 INFO - javascript benchmark 04:28:57 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2641.432092100198, 2655.8273712208716, 2680.986595067025, 2702.3244188952763, 2704.9188524344263, 4659.813607455706, 4711.623070154388, 4733.266343716721, 4781.426228852538, 4819.614430845532, 4643.373144625474, 4656.045510670313, 4708.36437080994, 4786.37777088978, 4802.423709154907, 4203.0, 4229.661627069842, 4277.358396240557, 4304.548022457644, 4425.446819147606, 4350.456192975878, 4353.499347575038, 4378.102488989765, 4417.094495628388, 4434.800433980478, 4304.0, 4313.805878735465, 4354.564543545652, 4357.586029327209, 4380.78096095194, 4306.590873866978, 4315.287977483711, 4318.028443600197, 4318.460192475941, 4414.690971631987, 4341.565843415665, 4345.087531618364, 4345.41336919515, 4385.342198670193, 4386.451693538308, 4672.0889426561835, 4694.319323698079, 4785.019071090418, 4804.783784729696, 4834.854954351375, 5195.350581177353, 5200.24596433515, 5212.139996900507, 5212.374515058217, 5212.713300768494, 5176.715280659562, 5195.792168313263, 5234.0, 5236.423993360727, 5237.973810130963, 4685.718856868599, 4775.808967641325, 4813.15769740294, 4817.975910120427, 4893.608511319086, 5265.736713164327, 5275.103232450492, 5321.467853214647, 5340.145576707708, 5343.091674415358, 5065.240213967934, 5067.923981140286, 5109.131447653907, 5119.129747942859, 5123.231515272739, 4949.876253093629, 5042.117629414838, 5093.363329583802, 5095.490450954949, 5112.488751124932, 5014.373203349582, 5035.924461133086, 5042.243663450512, 5053.166227572483, 5098.439171691111, 4847.95152048475, 5016.623753218523, 5029.698218106852, 5032.647714659939, 5035.370578677665, 4202.768847713405, 4234.534201237861, 4257.829686812554, 4268.039691069484, 4321.978390108029, 3723.906902327409, 3736.4021756518828, 3754.5869954305003, 3779.848806047782, 3788.886333410002, 4405.603495685404, 4420.292753159479, 4421.38100665907, 4430.867073987785, 4464.799084041226, 4995.225740010304, 5020.5732512736095, 5028.849134525897, 5040.823571174991, 5045.394552653705, 4352.064306174188, 4359.280718681445, 4364.0, 4369.060651959844, 4414.80133393998, 4444.28891377378, 4510.323451482238, 4514.977425112919, 4517.1417430688725, 4555.362249285103, 4752.239641657387, 4787.880302992453, 4844.346013288161, 4860.73265970375, 4865.805367785249, 5125.333706618116, 5148.742562871917, 5149.536541711264, 5150.381954165524, 5210.114280572236, 4694.976525117352, 4799.640026997919, 4870.025994801124, 4877.365942427462, 4920.532549407801, 5010.69935803853, 5060.898782024413, 5076.441591424867, 5086.516780905808, 5137.1010073237785, 5132.024915266087, 5138.948610513847, 5140.357455318085, 5145.176771716508, 5195.168772996453, 4869.050535145754, 4878.121938051185, 4912.164931961646, 5002.799888004439, 5010.5240002199735, 4908.460069392293, 4939.827106051271, 4942.8022879085875, 4943.752812359439, 4982.327385802871, 4874.90250194987, 4877.853664390074, 4879.634027448026, 4919.557239848431, 4922.532359425849, 4858.5384388483035, 4898.289747986593, 4923.950760492349, 4924.72913989734, 5006.574441172541, 4797.472278049342, 4805.3512775774825, 4857.295692124693, 4862.975685121552, 4873.975630121827], "value": 4671.936194085979, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [578.0952808854142, 580.7909152705025, 580.8664007278327, 585.8359659295398, 588.1794896119912, 27680.723192768066, 28107.718922810793, 40006.39990400146, 40590.39114413286, 41768.164636707246, 37172.62827371725, 37814.62185378146, 37843.4323485148, 42322.36516452248, 42439.78780106095, 7862.764117076483, 8016.358691304711, 8016.879746803803, 8019.278264956153, 8022.398320125984, 7411.592362420065, 10219.335743176707, 10470.21473389495, 10476.214283928697, 10806.72983175423, 10334.948325258401, 10400.0, 10417.635382761604, 10423.218258630595, 10423.374597524135, 10359.171266298716, 10378.481075946172, 10421.062104410563, 10424.94787526065, 10435.686929392092, 10281.794364112751, 10290.485475726258, 10359.637412690596, 10368.844467332996, 10370.170386369073, 39163.0, 39482.0, 39510.40734388986, 39519.40720889189, 39540.20919581592, 3200.8719651213923, 3231.111444352798, 3249.69127932846, 3284.1297056280105, 3649.6897763690117, 30073.0, 30184.396312073855, 30433.69566304331, 30690.0, 31194.064178074466, 3330.500424936279, 3396.490526421032, 3538.5576802899636, 3568.232829941549, 3611.4402267648557, 214464.0, 277258.0, 277794.0, 278037.0, 280693.0, 57675.0, 58554.0, 58563.414365855795, 58616.0, 58670.41329586649, 60749.39250607437, 61083.38916610777, 61159.694201528706, 61168.694156529826, 61225.08162377568, 15124.470643527424, 15760.369585216693, 15781.0, 15800.60498487547, 15803.841961580467, 10539.894601054044, 11219.775604487864, 11593.826092608617, 11981.700457488458, 12106.576269830513, 18059.27762889496, 18239.817601824077, 18271.36050238235, 18299.72550411745, 18333.7249941251, 6956.478264130211, 6985.79042628722, 7141.89287160693, 7143.7142514299885, 7297.197308296083, 688.8209065642969, 815.404754529197, 848.3425345357274, 1014.7767491151935, 1015.8171529124828, 27709.445811083664, 28414.573781393297, 28560.714392856222, 28744.856275718907, 28810.680453007888, 987.4174237200086, 1003.1773945364877, 1003.9247056470793, 1013.5793645636978, 1086.3916206924148, 14896.329665165094, 14921.253937303092, 14985.0, 15191.240437978056, 15376.15431151275, 424563.0, 426537.0, 428885.0, 430125.0, 430175.0, 50604.49395505998, 51086.74456627767, 51115.74442127765, 51122.74438627783, 51148.74425627923, 1083.0847933496184, 1187.7149484123747, 1209.848768903887, 1233.2785320587557, 1234.8456442944632, 28439.573406399333, 29213.0, 29512.409751805273, 29847.0, 29932.0, 42377.78811105925, 42825.357619635106, 42891.356629649956, 42969.35545966875, 43073.78463107665, 310167.0, 313529.0, 314159.0, 315224.0, 315302.0, 22764.20325288607, 23361.88319058394, 23449.76550234476, 24593.754062459862, 24639.137630183573, 37279.627203727614, 43719.0, 43959.0, 47975.0, 48814.51185488242, 37177.62822371742, 37394.43908341431, 37537.81231093827, 37823.0, 37958.0, 35185.296294074484, 37898.43152352772, 38021.809890951474, 38028.42957355586, 38088.238235235694, 35363.11592210215, 36534.269314613026, 36577.63422365742, 37054.629453705114, 37291.254174915804, 30900.53649195219, 33490.33019339648, 33864.0, 33930.321393572485, 34056.0, 24973.625395619445, 25410.74589254084, 25911.870440647675, 26070.914326854185, 26313.342166445993], "value": 18491.94081400181, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.66267365360693, 368.9391250443677, 375.93984962406023, 383.8522168964948, 384.7883663984808, 16733.41433049842, 17776.466705998824, 18407.8955262684, 18720.90639546804, 18732.90633546834, 17218.0, 17228.82771172288, 17629.911850440763, 17632.559186020324, 17749.55626109348, 5112.105381558222, 5295.655782374133, 5303.655262407931, 5335.173048177519, 5339.038972984861, 3697.667209951104, 3734.8319325630414, 5271.103912334893, 6141.907871381933, 6150.96924515379, 6190.41191086846, 6205.9379406206035, 6226.937730622703, 6238.812835614939, 6243.219597550306, 5978.8505287367725, 6170.321264660884, 6176.351483094255, 6179.752809887599, 6188.659623720693, 3451.5685539307588, 5071.46749591295, 5361.437049109865, 5370.57035437168, 5442.727863606843, 21726.935941085572, 21764.238251661114, 21791.237306694347, 21837.454063648376, 22035.889820550954, 1985.1166231027198, 2039.01107962638, 2201.1635578480236, 2424.187897054489, 2455.0945954028, 13313.800292995613, 13851.792223116561, 14064.648383790385, 14388.784168237486, 14468.782968255484, 1754.8596112310984, 1796.3443343179777, 1801.6486785076916, 1835.4952388093247, 1858.1266804601817, 70957.0, 71854.64072679656, 72374.63812680956, 72391.63804180999, 72834.0, 9479.763005924908, 9518.90481095194, 9839.262055345878, 10160.441175735257, 10611.628592999208, 13884.51404200848, 14036.228007459484, 14049.0, 14079.0, 14083.295835208404, 7599.126100498403, 7603.353714934182, 7707.614619269014, 7795.220477952273, 7822.960885195652, 7416.0729908761405, 7448.217937116525, 7505.849883002309, 7624.046994125734, 7648.694052237959, 6332.145160403379, 6359.586626869332, 6383.9361606383345, 6489.837754056092, 6514.73941042353, 1706.1384001079375, 1719.7162468192607, 1750.7023805953017, 1753.1059159828578, 1786.9910650446925, 837.2924878477677, 875.3259989807813, 876.9561521923878, 947.0576776107679, 949.3971328206638, 17033.829661703472, 17234.82765172332, 17525.47423577295, 17954.0, 18322.908385458253, 873.7597160780836, 883.9823203536022, 897.1387468030633, 902.8690839828188, 948.9003654616166, 9769.169620582188, 10047.296689231829, 10257.794844103077, 10286.074253317238, 10348.979540855746, 418491.0, 422719.0, 429696.0, 431376.0, 436295.0, 49896.50103498991, 71329.64335178395, 72366.27633723595, 73442.0, 74860.0, 851.1488511488387, 887.3522328699956, 897.6813231302924, 930.0467021303083, 931.897491275959, 15135.394584216949, 15757.527274181793, 17322.740158897373, 17374.478765636544, 17551.82448175502, 36930.44604330991, 38048.0, 38141.61858381492, 38212.0, 38433.0, 47462.288065679735, 47737.76131119322, 48179.518204817505, 49317.26024109713, 52273.0, 7188.784336469915, 7412.62936853166, 7487.101547814297, 7701.152873184057, 7791.22087791239, 10216.693499195037, 10551.419671918118, 10586.258961872594, 10654.680359589225, 10897.727556810825, 7373.741919032808, 8166.060902996232, 8341.582920853813, 8743.0, 8897.866532001895, 8390.202930721573, 8456.83086338282, 8568.57157142153, 8672.0, 9321.347505674537, 8144.0634327050775, 8298.543834768116, 8669.003064647393, 9054.637814487347, 9093.954530227307, 7115.2884711530505, 7179.712811487482, 7218.27817218274, 7227.566346019255, 7254.746083887038, 8413.242808147295, 9033.50315732641, 9043.502607356395, 9207.263418926335, 9229.723108306762], "value": 8389.79928442445, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.8694823991723, 1419.1343280598835, 1496.618362317609, 1676.6814305282003, 1718.9828101718988, 7722.459427840054, 8171.468854524466, 8268.834623307544, 8275.503469791816, 8275.958620206899, 6776.186857577098, 7167.354938055574, 7258.0, 7302.3427891489755, 8100.878486822688, 2145.410012246633, 2170.924017659382, 2176.7823217678265, 2179.727534058243, 2180.5420861619, 2177.575372802304, 2183.5087105401235, 2196.9780302197014, 2213.1258153029544, 2217.2572188316853, 1868.271374164077, 2142.9035693393757, 2196.879171645559, 2198.857074290174, 2240.9439764005947, 2225.299030805307, 2236.7539570647214, 2245.079517397859, 2258.3563684349883, 2260.6722025306403, 2256.4020534558354, 2261.8982145803316, 2264.0038383111378, 2264.4452109233343, 2264.8754318512474, 8143.389245806529, 8174.26431621151, 8181.140980197112, 8193.385496087818, 8200.958995204986, 4521.7739113044545, 4565.954340456587, 4711.128441238382, 4734.053189362141, 4825.927611085836, 2968.5695574141846, 3054.3433161870303, 3083.8458077096057, 3100.2404410919244, 3102.10039088664, 947.147567189528, 955.1833182628822, 964.3394274921701, 967.0957654592978, 978.8923218445965, 11179.105671546256, 11179.329240245612, 11186.888131118665, 11239.100871930226, 11242.381669008202, 4199.727017743837, 4249.2988656871885, 4297.699161058696, 4367.432233809648, 4382.342648602735, 9514.952425237829, 9635.710928672152, 9637.18083962871, 9645.565949532287, 9646.565904534173, 4811.927821082687, 4829.975850120727, 4837.419509658864, 4840.733759643183, 4844.128056949783, 4340.262155433584, 4395.7362558246605, 4397.274449715825, 4405.052913623586, 4435.800388982503, 3673.1368128489785, 3727.6458736419995, 3780.5652349979555, 3798.5061941947924, 3945.072907866649, 1067.3115840283128, 1176.347127344315, 1195.109643315718, 1195.6532605544294, 1212.2726364181422, 714.7962830593256, 753.8680730872076, 768.8808234723626, 806.3065763443434, 842.0568962761623, 5171.120909445403, 5222.660527065728, 5241.580673546107, 5267.209918512254, 5303.920441193385, 837.2339309531832, 842.9367797415218, 845.0957475501277, 845.2688424512875, 848.5121055393174, 3621.0766254604905, 3675.5221821163077, 3676.2647470506004, 3715.256948610289, 3775.3959366501776, 9721.708348749407, 9996.100350968301, 10005.699829005142, 10137.036981486746, 10169.54237059334, 8770.605322760364, 9978.451185184884, 9979.251556133318, 10008.949955250177, 10014.849777253346, 7214.422846172293, 7573.015507984037, 7585.241475852481, 7741.922580774233, 7749.186335434811, 5492.395836458067, 5503.3120859892515, 5560.054790685513, 5659.0, 5663.745131469176, 8872.201501864864, 9017.819643607223, 9156.267498599962, 9389.201917837061, 9418.387804792666, 9375.859362109437, 9383.624655013722, 9514.571844267162, 9718.368306060367, 9724.367916085432, 7148.0, 7148.03501527308, 7222.09723784527, 7240.312170343809, 7292.1614014386905, 7360.263973602597, 7364.116306043309, 7374.188839227573, 7402.814929626802, 7413.629318534159, 6937.687804048931, 7070.717171313296, 7071.328223818729, 7138.750143744944, 7195.640217988975, 6864.4165245954655, 6979.30206979298, 7025.086738723933, 7052.435805135474, 7072.646367681698, 5642.266505354278, 6030.698465076641, 6034.758609655564, 6111.236095488064, 6191.690415479298, 4381.342798580238, 4408.625266852354, 4441.200583894801, 4483.0, 4535.682502224945, 4533.591976722111, 4551.226291530382, 4581.152486789954, 4599.264117741145, 4619.076184762994], "value": 4226.614455100916, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [289.0980141957093, 289.39949604570495, 289.70739553051425, 296.5255591054313, 301.59736751436833, 4858.708477491353, 4895.437024742151, 4911.140550403674, 4918.3114363989025, 4927.531884470978, 4842.951570484294, 4867.123917694814, 4881.8291359802415, 4888.388951381077, 4891.779869905854, 3784.829682664287, 3811.8856434307013, 3819.1216020315346, 3822.4075268333454, 3832.3676593362134, 3622.225109696243, 3672.5042119313953, 3847.3844184930417, 3848.749831260959, 3864.3430616795213, 3333.683300086488, 3521.489384039313, 3684.299983003221, 3732.9440058399146, 3796.297684928283, 3720.795356255405, 3740.925181496355, 3765.1151979284846, 3783.2433513297315, 3810.7713537187856, 3361.0, 3361.5629968104236, 3383.2218589724257, 3396.5075064115813, 3398.5072164536004, 4459.241928872099, 4588.816447342136, 4696.741679207642, 4709.7174169549935, 4723.48041715411, 4307.870763877088, 4318.82724691012, 4322.962489002648, 4323.718958267703, 4327.7186982846015, 5037.330214986063, 5048.3941926969, 5050.4697006814495, 5061.861081256725, 5111.670965548947, 3605.56733192016, 3700.296943580711, 3723.94414083789, 3736.215394767102, 3737.2712321097397, 5277.393099793535, 5286.471352864683, 5286.841394758163, 5305.946940530584, 5312.4687531246955, 3787.5833658297565, 3806.8667596633986, 3816.923661526754, 3818.560865500503, 3821.885343439701, 3854.768713877176, 3874.7287689862, 3875.0, 3882.514685664292, 3883.0, 4046.5548789633117, 4261.978690106592, 4269.615734583902, 4320.3519472078815, 4344.391785150082, 5065.11360511909, 5094.133997220481, 5108.361454818148, 5129.204973229155, 5143.948560514347, 1286.2668279080833, 1287.3498883063992, 1293.224065560675, 1294.2040645003444, 1294.7863602505481, 820.2904487618287, 825.6871574197055, 833.5790425834914, 834.7829564313322, 845.2815107158866, 4021.3565829467143, 4037.394390841397, 4047.6559492442884, 4076.6534844538546, 4079.551249362568, 4629.421322334708, 4665.4634717007975, 4672.392588963413, 4682.742449165328, 4738.597219236403, 4065.735727177724, 4075.612816782401, 4082.857100001486, 4104.179164167119, 4165.937510937339, 2378.762123787642, 2500.349769152387, 2513.4219129600297, 2524.457241693045, 2536.3278731136265, 4438.889027774267, 4470.2177119004045, 4485.116251174514, 4493.685442019093, 4729.314249433813, 5127.974360128175, 5351.581830814837, 5367.141257398797, 5406.729663516809, 5415.6479828811, 4936.851894443173, 4958.305837182726, 4959.231319145538, 4963.851084467472, 4974.776135073858, 4913.606911447004, 5227.529522343008, 5243.423223445342, 5244.344456942882, 5267.71027593486, 5117.2068329409, 5129.461406552258, 5134.743262836918, 5143.125668636416, 5174.0, 4952.276248063623, 4959.718529476481, 4973.825916092919, 5031.974840125776, 5040.445550989315, 3628.8569100733184, 3700.870469533553, 3730.7948062856804, 3740.1210715482384, 3805.0, 5189.6107791915, 5190.818321358885, 5195.844124676266, 5222.608304377263, 5248.110680155065, 5037.622178336566, 5039.2944987702485, 5071.467495912876, 5112.514311140584, 5126.615503837302, 4923.950760492349, 4978.502149784992, 5021.698698078127, 5025.824096156617, 5040.6219533534395, 4971.154903666313, 4995.25071239317, 5006.4743201963265, 5008.99820035987, 5019.164172242671, 5097.923531146962, 5104.744762761921, 5116.539511443988, 5118.897622047463, 5122.923156152586, 4796.2805579162, 5000.524950129732, 5002.673222307125, 5005.549500544968, 5019.447860735389], "value": 3779.0211183340343, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.7847088931541, 690.854920466702, 738.294928343432, 756.7691853984534, 756.8183635927379, 11644.941775291123, 11852.585159519418, 12268.509259629614, 12277.69305767354, 12301.876981230185, 12430.254184748921, 12447.377631118454, 12493.625191244255, 12527.749445011093, 12554.623361299153, 631.4474834519796, 765.6248438265266, 765.6401491299081, 791.3669064748207, 797.2943944609034, 792.9722459713911, 794.1542257495778, 795.0499153511556, 795.6658203554492, 795.7135431244748, 842.7261140129483, 845.7251393297172, 845.7716416567523, 845.8266055458616, 846.2130218896424, 662.4700239808159, 796.6176235407037, 824.1922915542801, 825.0305890578546, 839.9076101628847, 604.0456079394546, 604.6221111805122, 605.7849463440504, 607.8206928955968, 607.8996965500687, 12202.084843636674, 12245.142840001203, 12245.571405000783, 12265.141440099196, 12276.693082673004, 11705.414729263588, 12148.21036632616, 12148.21036632616, 12348.135630505778, 12350.0737444692, 9046.77383065422, 9129.0, 9206.401583897024, 9256.768580785534, 11090.833637495443, 3966.226585815767, 3971.8808435746973, 4014.8193331300163, 4036.616521430489, 4055.2092341993325, 61387.693061534854, 63270.367296326905, 63296.05055924119, 63487.36512634861, 63527.0, 9409.200217981548, 9878.703638890845, 9921.801563968824, 9997.250206234561, 10043.19654427644, 16658.416955406745, 16730.916345418438, 16746.581335466468, 16761.1619419031, 16762.832371676126, 6464.935350646528, 6528.445082168069, 6757.155355580552, 6769.898451523231, 6983.441324694012, 3658.5243918290453, 3797.9240415192094, 3808.409696496992, 3813.675837553839, 3965.20695860829, 2688.206978941217, 2773.3759904021435, 2775.4171623959196, 2775.750182483546, 2777.402858385457, 480.9302651115569, 484.4912841516394, 485.57754753364094, 508.4788092205519, 523.0976565424612, 524.1822756499872, 538.727942389091, 551.2530521143792, 569.9939606594364, 571.8313097636208, 7995.640196191069, 8182.263596276363, 8281.8343633127, 8333.458325208841, 8784.472931624123, 511.987200319995, 526.8129813916081, 533.5704757670113, 566.9652883487652, 640.9038644203407, 3785.280796648683, 3828.4257361395457, 3882.2041481496226, 3940.5271367435516, 4009.3785463253244, 73414.0, 89421.0, 91119.0, 91467.54266228626, 93919.06080939103, 68018.65990670114, 78746.0, 80264.0, 80801.59599202084, 80945.59527202326, 69296.6535167321, 69751.3024869755, 71136.64431677808, 71751.2824871755, 72609.27390726026, 8140.75577732669, 8204.753857384288, 8769.605367758593, 8789.516576588348, 8938.68714594986, 39501.40747888727, 43283.35074973941, 44176.55823441853, 45036.32445513254, 45686.31470527878, 53999.460005401015, 59666.70166649139, 61368.38631613627, 62194.37805621886, 62367.37632623615, 10942.069924056545, 11027.062699670298, 11079.16906232052, 11201.43992800373, 11311.151663625425, 12113.515459381526, 12113.576024839442, 12229.14395992272, 12342.81485777732, 12925.741485170432, 7454.366378857858, 10279.229057820543, 10640.680779576625, 10778.245522813328, 10947.178961577754, 11247.325160490396, 11519.88480115188, 11690.649280521598, 11699.88300117022, 11911.940440297743, 10461.320014199053, 10521.842172367573, 10589.152867770714, 10770.192235582206, 10875.347479151276, 9748.994936167897, 9824.803503930025, 10015.449150296803, 10243.0, 10276.743081423025, 9294.535273236175, 10018.148457380912, 10100.393976361442, 10121.34296136404, 10233.437160956219], "value": 6390.508390607666, "unit": "score"}], "name": "dromaeo_css", "value": 6479.353362334703, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 115.0, 115.0, 114.0, 114.0, 116.0, 113.0, 114.0, 115.0, 115.0], "value": 113.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 125.0, 131.0, 183.0, 124.0, 123.0, 148.0, 127.0, 179.0, 120.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 163.0, 162.0, 162.0, 162.0, 163.0, 161.0, 162.0, 161.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 78.0, 79.0, 133.0, 76.0, 78.0, 76.0, 75.0, 100.0, 76.0], "value": 84.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 85.0, 85.0, 85.0, 121.0, 84.0, 85.0, 130.0], "value": 96.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 116.0, 117.0, 119.0, 117.0], "value": 117.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 145.0, 146.0, 147.0, 147.0, 145.0, 145.0], "value": 145.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 94.0, 94.0, 94.0, 95.0, 95.0, 95.0, 94.0], "value": 94.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 63.0, 67.0, 64.0, 63.0, 63.0, 65.0, 63.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 65.0, 64.0, 64.0, 63.0, 64.0, 64.0, 65.0, 65.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 78.0, 78.0, 87.0, 78.0, 81.0, 78.0, 84.0, 78.0, 84.0], "value": 81.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 129.0, 142.0, 125.0, 126.0, 128.0, 127.0, 127.0, 179.0, 136.0], "value": 134.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 165.0, 177.0, 166.0, 170.0, 167.0, 162.0, 168.0, 171.0, 163.0], "value": 167.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 65.0, 67.0, 67.0, 66.0, 69.0, 69.0, 65.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1534.3999999999999, "alertThreshold": 2.0}]} 04:28:57 INFO - Return code: 0 04:28:57 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:28:57 INFO - # TBPL SUCCESS # 04:28:57 INFO - Running post-action listener: _resource_record_post_action 04:28:57 INFO - ##### 04:28:57 INFO - ##### Finished run-tests step (success) 04:28:57 INFO - ##### 04:28:57 INFO - Running post-run listener: _resource_record_post_run 04:28:57 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 135168; Write bytes: 289103872; Read time: 24; Write time: 166900 04:28:57 INFO - TinderboxPrint: CPU usage
13.0% 04:28:57 INFO - TinderboxPrint: I/O read bytes / time
135,168 / 24 04:28:57 INFO - TinderboxPrint: I/O write bytes / time
289,103,872 / 166,900 04:28:57 INFO - TinderboxPrint: CPU idle
8,333.7 (87.0%) 04:28:57 INFO - TinderboxPrint: CPU user
1,203.8 (12.6%) 04:28:57 INFO - TinderboxPrint: Swap in / out
0 / 0 04:28:57 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 2830336; Read time: 0; Write time: 136 04:28:57 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 135168; Write bytes: 285659136; Read time: 24; Write time: 166764 04:28:58 INFO - Running post-run listener: _upload_blobber_files 04:28:58 INFO - Blob upload gear active. 04:28:58 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:28:58 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:28:58 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'] 04:28:58 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 04:28:58 INFO - (blobuploader) - INFO - Open directory for files ... 04:28:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:28:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:28:59 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:28:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:28:59 INFO - (blobuploader) - INFO - Done attempting. 04:28:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:28:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:28:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:29:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:00 INFO - (blobuploader) - INFO - Done attempting. 04:29:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:29:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:29:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:29:03 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:29:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:29:03 INFO - (blobuploader) - INFO - Done attempting. 04:29:03 INFO - (blobuploader) - INFO - Iteration through files over. 04:29:03 INFO - Return code: 0 04:29:03 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:29:03 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:29:03 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46a69bba80bb86dfea07dbf77d63f00b0bf73c5c57c4de22464c4324665adb93c70d131b05ab6be4181f1729261b510dd60b7216d65fc16ee2199131d715f4c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/824961d5c48815a0f2738622859560ffef5bd3879eea5affef150ed21e4fa7ccaa9087f1de90c190ac8febc71e3cb3ce4247f1ebb6a0443d33cf340852a4a249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8425a8c889d3677918ed7b5de142fff053324db992440c058fed847d7c7ed5da31909788923ffbd533188bb1ca540e157c7ca739e01103513be5bb01d8a20ac1"} 04:29:03 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:29:03 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:29:03 INFO - Contents: 04:29:03 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/46a69bba80bb86dfea07dbf77d63f00b0bf73c5c57c4de22464c4324665adb93c70d131b05ab6be4181f1729261b510dd60b7216d65fc16ee2199131d715f4c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/824961d5c48815a0f2738622859560ffef5bd3879eea5affef150ed21e4fa7ccaa9087f1de90c190ac8febc71e3cb3ce4247f1ebb6a0443d33cf340852a4a249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8425a8c889d3677918ed7b5de142fff053324db992440c058fed847d7c7ed5da31909788923ffbd533188bb1ca540e157c7ca739e01103513be5bb01d8a20ac1"} 04:29:03 INFO - Running post-run listener: copy_logs_to_upload_dir 04:29:03 INFO - Copying logs to upload dir... 04:29:03 INFO - mkdir: /builds/slave/test/build/upload/logs 04:29:03 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1246.188775 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 46 secs) (at 2016-06-30 04:29:03.674845) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 04:29:03.678219) ========= 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=db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757 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/46a69bba80bb86dfea07dbf77d63f00b0bf73c5c57c4de22464c4324665adb93c70d131b05ab6be4181f1729261b510dd60b7216d65fc16ee2199131d715f4c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/824961d5c48815a0f2738622859560ffef5bd3879eea5affef150ed21e4fa7ccaa9087f1de90c190ac8febc71e3cb3ce4247f1ebb6a0443d33cf340852a4a249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8425a8c889d3677918ed7b5de142fff053324db992440c058fed847d7c7ed5da31909788923ffbd533188bb1ca540e157c7ca739e01103513be5bb01d8a20ac1"} build_url:https://queue.taskcluster.net/v1/task/CfPBSXnkSB2US6VyU8rcUQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011391 build_url: 'https://queue.taskcluster.net/v1/task/CfPBSXnkSB2US6VyU8rcUQ/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/46a69bba80bb86dfea07dbf77d63f00b0bf73c5c57c4de22464c4324665adb93c70d131b05ab6be4181f1729261b510dd60b7216d65fc16ee2199131d715f4c5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/824961d5c48815a0f2738622859560ffef5bd3879eea5affef150ed21e4fa7ccaa9087f1de90c190ac8febc71e3cb3ce4247f1ebb6a0443d33cf340852a4a249", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/8425a8c889d3677918ed7b5de142fff053324db992440c058fed847d7c7ed5da31909788923ffbd533188bb1ca540e157c7ca739e01103513be5bb01d8a20ac1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 04:29:03.705945) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:29:03.706367) ========= 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=db7e7c15f3ca076d53731445000001ba-1467284511.156137-832506757 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:29:03.789740) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 04:29:03.790217) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 04:29:03.790696) ========= ========= Total master_lag: 0.17 =========