builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-046 starttime: 1469141937.41 results: success (0) buildid: 20160721144820 builduid: fb0d2f467d3543f18d34a808d054c000 revision: 10501352b0eef4ecf19dd4d5b1d307ebb212cf5e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:57.414785) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:57.415167) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:57.415458) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:57.445625) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:57.445900) ========= 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=652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-21 15:58:57-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2016-07-21 15:58:57 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115690 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:57.580247) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:57.580595) ========= 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=652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015072 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:57.629839) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:57.630151) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 10501352b0eef4ecf19dd4d5b1d307ebb212cf5e --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 10501352b0eef4ecf19dd4d5b1d307ebb212cf5e --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=652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-21 15:58:57,799 truncating revision to first 12 chars 2016-07-21 15:58:57,799 Setting DEBUG logging. 2016-07-21 15:58:57,799 attempt 1/10 2016-07-21 15:58:57,799 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/10501352b0ee?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-21 15:58:58,105 unpacking tar archive at: mozilla-central-10501352b0ee/testing/mozharness/ program finished with exit code 0 elapsedTime=0.656339 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:58.299296) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:58.299580) ========= script_repo_revision: 10501352b0eef4ecf19dd4d5b1d307ebb212cf5e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:58.299951) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:58.300213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-21 15:58:58.312808) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-21 15:58:58.313080) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:58 INFO - MultiFileLogger online at 20160721 15:58:58 in /builds/slave/test 15:58:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 15:58:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:58 INFO - {'append_to_log': False, 15:58:58 INFO - 'base_work_dir': '/builds/slave/test', 15:58:58 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:58:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:58 INFO - 'branch': 'Firefox-Non-PGO', 15:58:58 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:58 INFO - 'config_files': ('talos/linux_config.py',), 15:58:58 INFO - 'default_actions': ('clobber', 15:58:58 INFO - 'read-buildbot-config', 15:58:58 INFO - 'download-and-extract', 15:58:58 INFO - 'populate-webroot', 15:58:58 INFO - 'create-virtualenv', 15:58:58 INFO - 'install', 15:58:58 INFO - 'run-tests'), 15:58:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:58 INFO - 'download_minidump_stackwalk': True, 15:58:58 INFO - 'download_symbols': 'ondemand', 15:58:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:58 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:58 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:58 INFO - 'installer_path': 'installer.exe', 15:58:58 INFO - 'log_level': 'info', 15:58:58 INFO - 'log_name': 'talos', 15:58:58 INFO - 'log_to_console': True, 15:58:58 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:58 INFO - 'opt_config_files': (), 15:58:58 INFO - 'pip_index': False, 15:58:58 INFO - 'sps_profile': False, 15:58:58 INFO - 'sps_profile_interval': 0, 15:58:58 INFO - 'suite': 'dromaeojs-e10s', 15:58:58 INFO - 'system_bits': '32', 15:58:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:58 INFO - 'title': 'talos-linux64-ix-046', 15:58:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:58 INFO - 'use_talos_json': True, 15:58:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:58 INFO - 'work_dir': 'build'} 15:58:58 INFO - [mozharness: 2016-07-21 22:58:58.571179Z] Running clobber step. 15:58:58 INFO - Running pre-action listener: _resource_record_pre_action 15:58:58 INFO - Running main action method: clobber 15:58:58 INFO - rmtree: /builds/slave/test/build 15:58:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:59 INFO - Running post-action listener: _resource_record_post_action 15:58:59 INFO - [mozharness: 2016-07-21 22:58:59.038342Z] Finished clobber step (success) 15:58:59 INFO - [mozharness: 2016-07-21 22:58:59.038442Z] Running read-buildbot-config step. 15:58:59 INFO - Running pre-action listener: _resource_record_pre_action 15:58:59 INFO - Running main action method: read_buildbot_config 15:58:59 INFO - Using buildbot properties: 15:58:59 INFO - { 15:58:59 INFO - "project": "", 15:58:59 INFO - "product": "firefox", 15:58:59 INFO - "script_repo_revision": "production", 15:58:59 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 15:58:59 INFO - "repository": "", 15:58:59 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 15:58:59 INFO - "buildid": "20160721144820", 15:58:59 INFO - "pgo_build": "False", 15:58:59 INFO - "basedir": "/builds/slave/test", 15:58:59 INFO - "buildnumber": 401, 15:58:59 INFO - "slavename": "talos-linux64-ix-046", 15:58:59 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:58:59 INFO - "platform": "ubuntu64_hw", 15:58:59 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:58:59 INFO - "branch": "mozilla-central", 15:58:59 INFO - "repo_path": "mozilla-central", 15:58:59 INFO - "revision": "10501352b0eef4ecf19dd4d5b1d307ebb212cf5e", 15:58:59 INFO - "stage_platform": "linux64", 15:58:59 INFO - "builduid": "fb0d2f467d3543f18d34a808d054c000", 15:58:59 INFO - "slavebuilddir": "test" 15:58:59 INFO - } 15:58:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 15:58:59 INFO - Running post-action listener: _resource_record_post_action 15:58:59 INFO - [mozharness: 2016-07-21 22:58:59.040881Z] Finished read-buildbot-config step (success) 15:58:59 INFO - [mozharness: 2016-07-21 22:58:59.040971Z] Running download-and-extract step. 15:58:59 INFO - Running pre-action listener: _resource_record_pre_action 15:58:59 INFO - Running main action method: download_and_extract 15:58:59 INFO - mkdir: /builds/slave/test/build/tests 15:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://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')]} 15:58:59 INFO - https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 15:58:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:58:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:58:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/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 15:58:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/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 15:59:10 INFO - Downloaded 1361 bytes. 15:59:10 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 15:59:10 INFO - Using the following test package requirements: 15:59:10 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:10 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:59:10 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 15:59:10 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:10 INFO - u'jsshell-linux-x86_64.zip'], 15:59:10 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:59:10 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 15:59:10 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:59:10 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:59:10 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:59:10 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 15:59:10 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:59:10 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:59:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:10 INFO - https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:59:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:59:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/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 15:59:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/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 15:59:19 INFO - Downloaded 22735470 bytes. 15:59:19 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 15:59:19 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 15:59:20 INFO - Return code: 0 15:59:20 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 15:59:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:20 INFO - https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:59:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:59:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 15:59:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/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 15:59:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/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 15:59:21 INFO - Downloaded 22735470 bytes. 15:59:21 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'] 15:59:21 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 15:59:23 INFO - Return code: 0 15:59:23 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')]} 15:59:23 INFO - https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:59:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 15:59:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/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 15:59:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/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 15:59:24 INFO - Downloaded 14403317 bytes. 15:59:24 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'] 15:59:24 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 15:59:24 INFO - Return code: 0 15:59:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:24 INFO - https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:59:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:59:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:59:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/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 15:59:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JYRAzwcmSci5-mG6CSINfg/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 15:59:25 INFO - Downloaded 57148915 bytes. 15:59:25 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:59:25 INFO - mkdir: /builds/slave/test/properties 15:59:25 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:59:25 INFO - Writing to file /builds/slave/test/properties/build_url 15:59:25 INFO - Contents: 15:59:25 INFO - build_url:https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 15:59:26 INFO - Running post-action listener: _resource_record_post_action 15:59:26 INFO - Running post-action listener: set_extra_try_arguments 15:59:26 INFO - [mozharness: 2016-07-21 22:59:26.470507Z] Finished download-and-extract step (success) 15:59:26 INFO - [mozharness: 2016-07-21 22:59:26.470741Z] Running populate-webroot step. 15:59:26 INFO - Running pre-action listener: _resource_record_pre_action 15:59:26 INFO - Running main action method: populate_webroot 15:59:26 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:59:26 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:59:26 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:59:26 INFO - '--tppagecycles', 15:59:26 INFO - '7'], 15:59:26 INFO - 'tests': ['tsvgm']}}, 15:59:26 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 15:59:26 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:59:26 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 15:59:26 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 15:59:26 INFO - 'tests': ['dromaeo_css', 'kraken']}, 15:59:26 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 15:59:26 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'talos_options': ['--disable-e10s'], 15:59:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:26 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:59:26 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'talos_options': ['--disable-e10s'], 15:59:26 INFO - 'tests': ['damp', 'tps']}, 15:59:26 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'tests': ['damp', 'tps']}, 15:59:26 INFO - 'g3': {'talos_options': ['--disable-e10s'], 15:59:26 INFO - 'tests': ['dromaeo_dom']}, 15:59:26 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:59:26 INFO - 'g4': {'talos_options': ['--disable-e10s'], 15:59:26 INFO - 'tests': ['basic_compositor_video']}, 15:59:26 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 15:59:26 INFO - 'other': {'talos_options': ['--disable-e10s'], 15:59:26 INFO - 'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore', 15:59:26 INFO - 'tabpaint']}, 15:59:26 INFO - 'other-e10s': {'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore', 15:59:26 INFO - 'tabpaint']}, 15:59:26 INFO - 'other-e10s_l64': {'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore', 15:59:26 INFO - 'tabpaint']}, 15:59:26 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore', 15:59:26 INFO - 'tabpaint']}, 15:59:26 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 15:59:26 INFO - 'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore', 15:59:26 INFO - 'tabpaint']}, 15:59:26 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 15:59:26 INFO - 'tests': ['a11yr', 15:59:26 INFO - 'ts_paint', 15:59:26 INFO - 'tpaint', 15:59:26 INFO - 'sessionrestore', 15:59:26 INFO - 'sessionrestore_no_auto_restore', 15:59:26 INFO - 'tabpaint']}, 15:59:26 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 15:59:26 INFO - 'tests': ['tsvgx', 15:59:26 INFO - 'tsvgr_opacity', 15:59:26 INFO - 'tart', 15:59:26 INFO - 'tscrollx', 15:59:26 INFO - 'cart']}, 15:59:26 INFO - 'svgr-e10s': {'tests': ['tsvgx', 15:59:26 INFO - 'tsvgr_opacity', 15:59:26 INFO - 'tart', 15:59:26 INFO - 'tscrollx', 15:59:26 INFO - 'cart']}, 15:59:26 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'talos_options': ['--disable-e10s'], 15:59:26 INFO - 'tests': ['tp5o']}, 15:59:26 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'tests': ['tp5o']}, 15:59:26 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'talos_options': ['--disable-e10s', 15:59:26 INFO - '--xperf_path', 15:59:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:26 INFO - 'tests': ['tp5n']}, 15:59:26 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:59:26 INFO - 'talos_options': ['--xperf_path', 15:59:26 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:59:26 INFO - 'tests': ['tp5n']}}, 15:59:26 INFO - 'talos.zip': {'path': '', 15:59:26 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:59:26 INFO - Running post-action listener: _resource_record_post_action 15:59:26 INFO - [mozharness: 2016-07-21 22:59:26.490931Z] Finished populate-webroot step (success) 15:59:26 INFO - [mozharness: 2016-07-21 22:59:26.491020Z] Running create-virtualenv step. 15:59:26 INFO - Running pre-action listener: _resource_record_pre_action 15:59:26 INFO - Running main action method: create_virtualenv 15:59:26 INFO - Creating virtualenv /builds/slave/test/build/venv 15:59:26 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 15:59:26 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:59:26 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:59:26 INFO - Using real prefix '/usr' 15:59:26 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:59:27 INFO - Installing distribute.............................................................................................................................................................................................done. 15:59:29 INFO - Installing pip.................done. 15:59:29 INFO - Return code: 0 15:59:29 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ab570>, '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 0x29ac470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ac900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', '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 15:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 15:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 15:59:29 INFO - Using env: {'DISPLAY': ':0', 15:59:29 INFO - 'HOME': '/home/cltbld', 15:59:29 INFO - 'LANG': 'en_US.UTF-8', 15:59:29 INFO - 'LANGUAGE': 'en_US:en', 15:59:29 INFO - 'LOGNAME': 'cltbld', 15:59:29 INFO - 'MAIL': '/var/mail/cltbld', 15:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:29 INFO - 'MOZ_NO_REMOTE': '1', 15:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:29 INFO - 'NO_EM_RESTART': '1', 15:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:29 INFO - 'PWD': '/builds/slave/test', 15:59:29 INFO - 'SHELL': '/bin/bash', 15:59:29 INFO - 'SHLVL': '1', 15:59:29 INFO - 'TERM': 'linux', 15:59:29 INFO - 'TMOUT': '86400', 15:59:29 INFO - 'USER': 'cltbld', 15:59:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', 15:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:29 INFO - '_': '/tools/buildbot/bin/python'} 15:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:29 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 15:59:29 INFO - Cleaning up... 15:59:29 INFO - Return code: 0 15:59:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 15:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ab570>, '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 0x29ac470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ac900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', '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 15:59:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 15:59:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 15:59:29 INFO - Using env: {'DISPLAY': ':0', 15:59:29 INFO - 'HOME': '/home/cltbld', 15:59:29 INFO - 'LANG': 'en_US.UTF-8', 15:59:29 INFO - 'LANGUAGE': 'en_US:en', 15:59:29 INFO - 'LOGNAME': 'cltbld', 15:59:29 INFO - 'MAIL': '/var/mail/cltbld', 15:59:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:29 INFO - 'MOZ_NO_REMOTE': '1', 15:59:29 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:29 INFO - 'NO_EM_RESTART': '1', 15:59:29 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:29 INFO - 'PWD': '/builds/slave/test', 15:59:29 INFO - 'SHELL': '/bin/bash', 15:59:29 INFO - 'SHLVL': '1', 15:59:29 INFO - 'TERM': 'linux', 15:59:29 INFO - 'TMOUT': '86400', 15:59:29 INFO - 'USER': 'cltbld', 15:59:29 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', 15:59:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:29 INFO - '_': '/tools/buildbot/bin/python'} 15:59:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:29 INFO - Downloading/unpacking psutil>=3.1.1 15:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:59:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:31 INFO - Installing collected packages: psutil 15:59:31 INFO - Running setup.py install for psutil 15:59:31 INFO - building 'psutil._psutil_linux' extension 15:59:31 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 15:59:31 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 15:59:31 INFO - building 'psutil._psutil_posix' extension 15:59:31 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 15:59:31 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 15:59:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:59:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:59:32 INFO - Successfully installed psutil 15:59:32 INFO - Cleaning up... 15:59:32 INFO - Return code: 0 15:59:32 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:32 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x26ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ab570>, '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 0x29ac470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ac900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', '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 15:59:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 15:59:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 15:59:32 INFO - Using env: {'DISPLAY': ':0', 15:59:32 INFO - 'HOME': '/home/cltbld', 15:59:32 INFO - 'LANG': 'en_US.UTF-8', 15:59:32 INFO - 'LANGUAGE': 'en_US:en', 15:59:32 INFO - 'LOGNAME': 'cltbld', 15:59:32 INFO - 'MAIL': '/var/mail/cltbld', 15:59:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:32 INFO - 'MOZ_NO_REMOTE': '1', 15:59:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:32 INFO - 'NO_EM_RESTART': '1', 15:59:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:32 INFO - 'PWD': '/builds/slave/test', 15:59:32 INFO - 'SHELL': '/bin/bash', 15:59:32 INFO - 'SHLVL': '1', 15:59:32 INFO - 'TERM': 'linux', 15:59:32 INFO - 'TMOUT': '86400', 15:59:32 INFO - 'USER': 'cltbld', 15:59:32 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', 15:59:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:32 INFO - '_': '/tools/buildbot/bin/python'} 15:59:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:32 INFO - Downloading/unpacking mozsystemmonitor==0.3 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:34 INFO - Downloading mozsystemmonitor-0.3.tar.gz 15:59:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:59:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 15:59:34 INFO - Installing collected packages: mozsystemmonitor 15:59:34 INFO - Running setup.py install for mozsystemmonitor 15:59:34 INFO - Successfully installed mozsystemmonitor 15:59:34 INFO - Cleaning up... 15:59:34 INFO - Return code: 0 15:59:34 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 15:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x26ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ab570>, '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 0x29ac470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ac900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', '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 15:59:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 15:59:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 15:59:34 INFO - Using env: {'DISPLAY': ':0', 15:59:34 INFO - 'HOME': '/home/cltbld', 15:59:34 INFO - 'LANG': 'en_US.UTF-8', 15:59:34 INFO - 'LANGUAGE': 'en_US:en', 15:59:34 INFO - 'LOGNAME': 'cltbld', 15:59:34 INFO - 'MAIL': '/var/mail/cltbld', 15:59:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:34 INFO - 'MOZ_NO_REMOTE': '1', 15:59:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:34 INFO - 'NO_EM_RESTART': '1', 15:59:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:34 INFO - 'PWD': '/builds/slave/test', 15:59:34 INFO - 'SHELL': '/bin/bash', 15:59:34 INFO - 'SHLVL': '1', 15:59:34 INFO - 'TERM': 'linux', 15:59:34 INFO - 'TMOUT': '86400', 15:59:34 INFO - 'USER': 'cltbld', 15:59:34 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', 15:59:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:34 INFO - '_': '/tools/buildbot/bin/python'} 15:59:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:34 INFO - Downloading/unpacking jsonschema==2.5.1 15:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 15:59:36 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 15:59:36 INFO - Downloading functools32-3.2.3-2.tar.gz 15:59:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 15:59:36 INFO - warning: no files found matching '*.txt' 15:59:36 INFO - no previously-included directories found matching 'build' 15:59:36 INFO - no previously-included directories found matching 'dist' 15:59:36 INFO - no previously-included directories found matching '.git*' 15:59:36 INFO - Installing collected packages: jsonschema, functools32 15:59:36 INFO - Running setup.py install for functools32 15:59:36 INFO - warning: no files found matching '*.txt' 15:59:36 INFO - no previously-included directories found matching 'build' 15:59:36 INFO - no previously-included directories found matching 'dist' 15:59:36 INFO - no previously-included directories found matching '.git*' 15:59:36 INFO - Successfully installed jsonschema functools32 15:59:36 INFO - Cleaning up... 15:59:36 INFO - Return code: 0 15:59:36 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:36 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 0x26ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ab570>, '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 0x29ac470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ac900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', '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 15:59:36 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 15:59:36 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 15:59:37 INFO - Using env: {'DISPLAY': ':0', 15:59:37 INFO - 'HOME': '/home/cltbld', 15:59:37 INFO - 'LANG': 'en_US.UTF-8', 15:59:37 INFO - 'LANGUAGE': 'en_US:en', 15:59:37 INFO - 'LOGNAME': 'cltbld', 15:59:37 INFO - 'MAIL': '/var/mail/cltbld', 15:59:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:37 INFO - 'MOZ_NO_REMOTE': '1', 15:59:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:37 INFO - 'NO_EM_RESTART': '1', 15:59:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:37 INFO - 'PWD': '/builds/slave/test', 15:59:37 INFO - 'SHELL': '/bin/bash', 15:59:37 INFO - 'SHLVL': '1', 15:59:37 INFO - 'TERM': 'linux', 15:59:37 INFO - 'TMOUT': '86400', 15:59:37 INFO - 'USER': 'cltbld', 15:59:37 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', 15:59:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:37 INFO - '_': '/tools/buildbot/bin/python'} 15:59:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:37 INFO - Downloading/unpacking blobuploader==1.2.4 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:39 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:39 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:39 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 15:59:39 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 15:59:39 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 15:59:39 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 15:59:39 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 15:59:39 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 15:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:59:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:39 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 15:59:39 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 15:59:39 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 15:59:39 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 15:59:39 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 15:59:39 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 15:59:39 INFO - Downloading docopt-0.6.1.tar.gz 15:59:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:39 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:39 INFO - Running setup.py install for blobuploader 15:59:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:39 INFO - Running setup.py install for requests 15:59:40 INFO - Running setup.py install for docopt 15:59:40 INFO - Successfully installed blobuploader requests docopt 15:59:40 INFO - Cleaning up... 15:59:40 INFO - Return code: 0 15:59:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:40 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 0x26ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ab570>, '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 0x29ac470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ac900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', '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 15:59:40 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 15:59:40 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 15:59:40 INFO - Using env: {'DISPLAY': ':0', 15:59:40 INFO - 'HOME': '/home/cltbld', 15:59:40 INFO - 'LANG': 'en_US.UTF-8', 15:59:40 INFO - 'LANGUAGE': 'en_US:en', 15:59:40 INFO - 'LOGNAME': 'cltbld', 15:59:40 INFO - 'MAIL': '/var/mail/cltbld', 15:59:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:40 INFO - 'MOZ_NO_REMOTE': '1', 15:59:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:40 INFO - 'NO_EM_RESTART': '1', 15:59:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:40 INFO - 'PWD': '/builds/slave/test', 15:59:40 INFO - 'SHELL': '/bin/bash', 15:59:40 INFO - 'SHLVL': '1', 15:59:40 INFO - 'TERM': 'linux', 15:59:40 INFO - 'TMOUT': '86400', 15:59:40 INFO - 'USER': 'cltbld', 15:59:40 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', 15:59:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:40 INFO - '_': '/tools/buildbot/bin/python'} 15:59:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:40 INFO - Running setup.py (path:/tmp/pip-7kEWey-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:40 INFO - Running setup.py (path:/tmp/pip-cA65i9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:40 INFO - Running setup.py (path:/tmp/pip-z2vG2U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:40 INFO - Running setup.py (path:/tmp/pip-bt65Wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:40 INFO - Running setup.py (path:/tmp/pip-0eqdbq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:41 INFO - Running setup.py (path:/tmp/pip-mqxxHf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:41 INFO - Running setup.py (path:/tmp/pip-CoGb4M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:41 INFO - Running setup.py (path:/tmp/pip-EhfiB8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:41 INFO - Running setup.py (path:/tmp/pip-ieumh7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:41 INFO - Running setup.py (path:/tmp/pip-kYwpDt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:41 INFO - Running setup.py (path:/tmp/pip-lbmxnq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:41 INFO - Running setup.py (path:/tmp/pip-zynmHg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:41 INFO - Running setup.py (path:/tmp/pip-nlORsd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:41 INFO - Running setup.py (path:/tmp/pip-COMCLI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:41 INFO - Running setup.py (path:/tmp/pip-E09I59-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:41 INFO - Running setup.py (path:/tmp/pip-YxaagX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:41 INFO - Running setup.py (path:/tmp/pip-zYynNx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:41 INFO - Running setup.py install for manifestparser 15:59:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Running setup.py install for mozcrash 15:59:42 INFO - Running setup.py install for mozdebug 15:59:42 INFO - Running setup.py install for mozdevice 15:59:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Running setup.py install for mozfile 15:59:42 INFO - Running setup.py install for mozhttpd 15:59:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Running setup.py install for mozinfo 15:59:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Running setup.py install for mozInstall 15:59:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Running setup.py install for mozleak 15:59:42 INFO - Running setup.py install for mozlog 15:59:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:42 INFO - Running setup.py install for moznetwork 15:59:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Running setup.py install for mozprocess 15:59:43 INFO - Running setup.py install for mozprofile 15:59:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Running setup.py install for mozrunner 15:59:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Running setup.py install for mozscreenshot 15:59:43 INFO - Running setup.py install for moztest 15:59:43 INFO - Running setup.py install for mozversion 15:59:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:43 INFO - Cleaning up... 15:59:43 INFO - Return code: 0 15:59:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:43 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 0x26ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ab570>, '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 0x29ac470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ac900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', '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 15:59:43 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 15:59:43 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 15:59:43 INFO - Using env: {'DISPLAY': ':0', 15:59:43 INFO - 'HOME': '/home/cltbld', 15:59:43 INFO - 'LANG': 'en_US.UTF-8', 15:59:43 INFO - 'LANGUAGE': 'en_US:en', 15:59:43 INFO - 'LOGNAME': 'cltbld', 15:59:43 INFO - 'MAIL': '/var/mail/cltbld', 15:59:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:43 INFO - 'MOZ_NO_REMOTE': '1', 15:59:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:43 INFO - 'NO_EM_RESTART': '1', 15:59:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:43 INFO - 'PWD': '/builds/slave/test', 15:59:43 INFO - 'SHELL': '/bin/bash', 15:59:43 INFO - 'SHLVL': '1', 15:59:43 INFO - 'TERM': 'linux', 15:59:43 INFO - 'TMOUT': '86400', 15:59:43 INFO - 'USER': 'cltbld', 15:59:43 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', 15:59:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:43 INFO - '_': '/tools/buildbot/bin/python'} 15:59:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:43 INFO - Running setup.py (path:/tmp/pip-7CAe_F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:43 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)) 15:59:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:43 INFO - Running setup.py (path:/tmp/pip-4kLOW9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:44 INFO - Running setup.py (path:/tmp/pip-cwUuxZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:44 INFO - Running setup.py (path:/tmp/pip-HRN8vd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:44 INFO - Running setup.py (path:/tmp/pip-Sx0v3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:44 INFO - Running setup.py (path:/tmp/pip-VMiHYL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:44 INFO - Running setup.py (path:/tmp/pip-gobb7a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:44 INFO - Running setup.py (path:/tmp/pip-K88Ug6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:44 INFO - Running setup.py (path:/tmp/pip-QqrCK6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:44 INFO - Running setup.py (path:/tmp/pip-aFdugS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.3 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:44 INFO - Running setup.py (path:/tmp/pip-t_EjqZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:44 INFO - Running setup.py (path:/tmp/pip-iScuCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:44 INFO - Running setup.py (path:/tmp/pip-OduSj9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:44 INFO - Running setup.py (path:/tmp/pip-d69rOw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:44 INFO - Running setup.py (path:/tmp/pip-tglJJt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:44 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)) 15:59:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:44 INFO - Running setup.py (path:/tmp/pip-_p5taK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:45 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)) 15:59:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:45 INFO - Running setup.py (path:/tmp/pip-C0hqvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:45 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)) 15:59:45 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)) 15:59:45 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)) 15:59:45 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)) 15:59:45 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)) 15:59:45 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)) 15:59:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.3->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:47 INFO - Downloading blessings-1.6.tar.gz 15:59:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:47 INFO - Installing collected packages: blessings 15:59:47 INFO - Running setup.py install for blessings 15:59:47 INFO - Successfully installed blessings 15:59:47 INFO - Cleaning up... 15:59:47 INFO - Return code: 0 15:59:47 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:47 INFO - Reading from file tmpfile_stdout 15:59:47 INFO - Current package versions: 15:59:47 INFO - argparse == 1.2.1 15:59:47 INFO - blessings == 1.6 15:59:47 INFO - blobuploader == 1.2.4 15:59:47 INFO - docopt == 0.6.1 15:59:47 INFO - functools32 == 3.2.3-2 15:59:47 INFO - jsonschema == 2.5.1 15:59:47 INFO - manifestparser == 1.1 15:59:47 INFO - mozInstall == 1.12 15:59:47 INFO - mozcrash == 0.17 15:59:47 INFO - mozdebug == 0.1 15:59:47 INFO - mozdevice == 0.48 15:59:47 INFO - mozfile == 1.2 15:59:47 INFO - mozhttpd == 0.7 15:59:47 INFO - mozinfo == 0.9 15:59:47 INFO - mozleak == 0.1 15:59:47 INFO - mozlog == 3.3 15:59:47 INFO - moznetwork == 0.27 15:59:47 INFO - mozprocess == 0.23 15:59:47 INFO - mozprofile == 0.28 15:59:47 INFO - mozrunner == 6.12 15:59:47 INFO - mozscreenshot == 0.1 15:59:47 INFO - mozsystemmonitor == 0.3 15:59:47 INFO - moztest == 0.7 15:59:47 INFO - mozversion == 1.4 15:59:47 INFO - psutil == 3.1.1 15:59:47 INFO - requests == 1.2.3 15:59:47 INFO - wsgiref == 0.1.2 15:59:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:47 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')]} 15:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:47 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')]} 15:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:47 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 0x26ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ab570>, '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 0x29ac470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ac900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', '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 15:59:47 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 15:59:47 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 15:59:47 INFO - Using env: {'DISPLAY': ':0', 15:59:47 INFO - 'HOME': '/home/cltbld', 15:59:47 INFO - 'LANG': 'en_US.UTF-8', 15:59:47 INFO - 'LANGUAGE': 'en_US:en', 15:59:47 INFO - 'LOGNAME': 'cltbld', 15:59:47 INFO - 'MAIL': '/var/mail/cltbld', 15:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:47 INFO - 'MOZ_NO_REMOTE': '1', 15:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:47 INFO - 'NO_EM_RESTART': '1', 15:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:47 INFO - 'PWD': '/builds/slave/test', 15:59:47 INFO - 'SHELL': '/bin/bash', 15:59:47 INFO - 'SHLVL': '1', 15:59:47 INFO - 'TERM': 'linux', 15:59:47 INFO - 'TMOUT': '86400', 15:59:47 INFO - 'USER': 'cltbld', 15:59:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', 15:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:47 INFO - '_': '/tools/buildbot/bin/python'} 15:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:47 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)) 15:59:47 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)) 15:59:47 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)) 15:59:47 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)) 15:59:47 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)) 15:59:47 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)) 15:59:47 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)) 15:59:47 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)) 15:59:47 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)) 15:59:47 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)) 15:59:47 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)) 15:59:47 INFO - Cleaning up... 15:59:47 INFO - Return code: 0 15:59:47 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 15:59:47 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')]} 15:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:47 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')]} 15:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:47 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 0x26ed030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28508a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x291c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29ab570>, '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 0x29ac470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ac900>, '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': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', '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 15:59:47 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 15:59:47 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 15:59:47 INFO - Using env: {'DISPLAY': ':0', 15:59:47 INFO - 'HOME': '/home/cltbld', 15:59:47 INFO - 'LANG': 'en_US.UTF-8', 15:59:47 INFO - 'LANGUAGE': 'en_US:en', 15:59:47 INFO - 'LOGNAME': 'cltbld', 15:59:47 INFO - 'MAIL': '/var/mail/cltbld', 15:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:47 INFO - 'MOZ_NO_REMOTE': '1', 15:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:47 INFO - 'NO_EM_RESTART': '1', 15:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:47 INFO - 'PWD': '/builds/slave/test', 15:59:47 INFO - 'SHELL': '/bin/bash', 15:59:47 INFO - 'SHLVL': '1', 15:59:47 INFO - 'TERM': 'linux', 15:59:47 INFO - 'TMOUT': '86400', 15:59:47 INFO - 'USER': 'cltbld', 15:59:47 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', 15:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:47 INFO - '_': '/tools/buildbot/bin/python'} 15:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:47 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 15:59:47 INFO - Cleaning up... 15:59:47 INFO - Return code: 0 15:59:47 INFO - Running post-action listener: _resource_record_post_action 15:59:47 INFO - Running post-action listener: _start_resource_monitoring 15:59:47 INFO - Starting resource monitoring. 15:59:47 INFO - [mozharness: 2016-07-21 22:59:47.930811Z] Finished create-virtualenv step (success) 15:59:47 INFO - [mozharness: 2016-07-21 22:59:47.931238Z] Running install step. 15:59:47 INFO - Running pre-action listener: _resource_record_pre_action 15:59:47 INFO - Running main action method: install 15:59:47 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:48 INFO - Reading from file tmpfile_stdout 15:59:48 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:48 INFO - Reading from file tmpfile_stdout 15:59:48 INFO - Output received: 15:59:48 INFO - Usage: mozinstall [options] installer 15:59:48 INFO - Options: 15:59:48 INFO - -h, --help show this help message and exit 15:59:48 INFO - -d DEST, --destination=DEST 15:59:48 INFO - Directory to install application into. [default: 15:59:48 INFO - "/builds/slave/test"] 15:59:48 INFO - --app=APP Application being installed. [default: firefox] 15:59:48 INFO - mkdir: /builds/slave/test/build/application 15:59:48 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'] 15:59:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:00:04 INFO - Reading from file tmpfile_stdout 16:00:04 INFO - Output received: 16:00:04 INFO - /builds/slave/test/build/application/firefox/firefox 16:00:04 INFO - Running post-action listener: _resource_record_post_action 16:00:04 INFO - [mozharness: 2016-07-21 23:00:04.611653Z] Finished install step (success) 16:00:04 INFO - [mozharness: 2016-07-21 23:00:04.611926Z] Running run-tests step. 16:00:04 INFO - Running pre-action listener: _resource_record_pre_action 16:00:04 INFO - Running main action method: run_tests 16:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:00:04 INFO - Python 2.7.3 16:00:04 INFO - Return code: 0 16:00:04 INFO - grabbing minidump binary from tooltool 16:00:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:00:04 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 0x29ab570>, '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 0x29ac470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ac900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:00:04 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:00:04 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:00:04 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 16:00:04 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:00:04 INFO - Return code: 0 16:00:04 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:00:04 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:00:04 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:00:04 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:00:04 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:00:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 16:00:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-046 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 16:00:04 INFO - Using env: {'DISPLAY': ':0', 16:00:04 INFO - 'HOME': '/home/cltbld', 16:00:04 INFO - 'LANG': 'en_US.UTF-8', 16:00:04 INFO - 'LANGUAGE': 'en_US:en', 16:00:04 INFO - 'LOGNAME': 'cltbld', 16:00:04 INFO - 'MAIL': '/var/mail/cltbld', 16:00:04 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:00:04 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:00:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:00:04 INFO - 'MOZ_NO_REMOTE': '1', 16:00:04 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:00:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:00:04 INFO - 'NO_EM_RESTART': '1', 16:00:04 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:00:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:00:04 INFO - 'PWD': '/builds/slave/test', 16:00:04 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:00:04 INFO - 'SHELL': '/bin/bash', 16:00:04 INFO - 'SHLVL': '1', 16:00:04 INFO - 'TERM': 'linux', 16:00:04 INFO - 'TMOUT': '86400', 16:00:04 INFO - 'USER': 'cltbld', 16:00:04 INFO - 'XDG_SESSION_COOKIE': '652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968', 16:00:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:00:04 INFO - '_': '/tools/buildbot/bin/python'} 16:00:04 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-046', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 16:00:04 INFO - mozversion application_buildid: 20160721144820 16:00:04 INFO - mozversion application_changeset: 10501352b0eef4ecf19dd4d5b1d307ebb212cf5e 16:00:04 INFO - mozversion application_display_name: Nightly 16:00:04 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:00:04 INFO - mozversion application_name: Firefox 16:00:04 INFO - mozversion application_remotingname: firefox 16:00:04 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 16:00:04 INFO - mozversion application_vendor: Mozilla 16:00:04 INFO - mozversion application_version: 50.0a1 16:00:04 INFO - mozversion platform_buildid: 20160721144820 16:00:04 INFO - mozversion platform_changeset: 10501352b0eef4ecf19dd4d5b1d307ebb212cf5e 16:00:04 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 16:00:04 INFO - mozversion platform_version: 50.0a1 16:00:04 INFO - using testdate: 1469142004 16:00:04 INFO - actual date: 1469142004 16:00:04 INFO - starting webserver on 'localhost:35638' 16:00:04 INFO - SUITE-START | Running 2 tests 16:00:04 INFO - TEST-START | dromaeo_css 16:00:04 INFO - operating with platform_type : linux_ 16:00:04 INFO - Initialising browser for dromaeo_css test... 16:00:04 INFO - TEST-INFO | started process 22304 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjWBJ2g/profile http://localhost:35638/getInfo.html) 16:00:08 INFO - PROCESS | 22304 | JavaScript error: , line 0: uncaught exception: undefined 16:00:09 INFO - PROCESS | 22304 | __metrics Screen width/height:1600/1200 16:00:09 INFO - PROCESS | 22304 | colorDepth:24 16:00:09 INFO - PROCESS | 22304 | Browser inner width/height: 1024/697 16:00:09 INFO - PROCESS | 22304 | __metrics 16:00:10 ERROR - PROCESS | 22304 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:00:11 INFO - TEST-INFO | 22304: exit 0 16:00:11 INFO - Browser initialized. 16:00:11 INFO - Running cycle 1/1 for dromaeo_css test... 16:00:11 INFO - TEST-INFO | started process 22424 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjWBJ2g/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:00:23 INFO - PROCESS | 22424 | RSS: Main: 168910848 16:00:23 INFO - PROCESS | 22424 | 16:01:13 INFO - PROCESS | 22424 | 1469142073107 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:03:25 INFO - PROCESS | 22424 | Cycle 1(1): loaded http://localhost:35638/tests/dromaeo/cssquery-dojo.html (next: http://localhost:35638/tests/dromaeo/cssquery-ext.html) 16:03:26 INFO - PROCESS | 22424 | RSS: Main: 169623552 16:03:26 INFO - PROCESS | 22424 | 16:06:28 INFO - PROCESS | 22424 | Cycle 1(1): loaded http://localhost:35638/tests/dromaeo/cssquery-ext.html (next: http://localhost:35638/tests/dromaeo/cssquery-jquery.html) 16:06:29 INFO - PROCESS | 22424 | RSS: Main: 170991616 16:06:29 INFO - PROCESS | 22424 | 16:09:31 INFO - PROCESS | 22424 | Cycle 1(1): loaded http://localhost:35638/tests/dromaeo/cssquery-jquery.html (next: http://localhost:35638/tests/dromaeo/cssquery-mootools.html) 16:09:31 INFO - PROCESS | 22424 | RSS: Main: 173998080 16:09:31 INFO - PROCESS | 22424 | 16:12:33 INFO - PROCESS | 22424 | Cycle 1(1): loaded http://localhost:35638/tests/dromaeo/cssquery-mootools.html (next: http://localhost:35638/tests/dromaeo/cssquery-prototype.html) 16:12:34 INFO - PROCESS | 22424 | RSS: Main: 168214528 16:12:34 INFO - PROCESS | 22424 | 16:15:37 INFO - PROCESS | 22424 | Cycle 1(1): loaded http://localhost:35638/tests/dromaeo/cssquery-prototype.html (next: http://localhost:35638/tests/dromaeo/cssquery-yui.html) 16:15:37 INFO - PROCESS | 22424 | RSS: Main: 170881024 16:15:37 INFO - PROCESS | 22424 | 16:18:40 INFO - PROCESS | 22424 | Cycle 1(1): loaded http://localhost:35638/tests/dromaeo/cssquery-yui.html (next: http://localhost:35638/tests/dromaeo/cssquery-dojo.html) 16:18:40 INFO - PROCESS | 22424 | RSS: Main: 173740032 16:18:40 INFO - PROCESS | 22424 | 16:18:40 INFO - PROCESS | 22424 | __start_tp_report 16:18:40 INFO - PROCESS | 22424 | _x_x_mozilla_page_load 16:18:40 INFO - PROCESS | 22424 | _x_x_mozilla_page_load_details 16:18:40 INFO - PROCESS | 22424 | |i|pagename|runs| 16:18:40 INFO - PROCESS | 22424 | |0;dojo.html;2568.6275490053945;2596.467724116556;2607.9478410431802;2611.360216746896;2621.1219241554077;4645.465771436282;4746.810127594897;4765.833195838146;4812.494688057756;4849.830255941043;4648.48866624671;4781.7130972141695;4787.976060119703;4814;4818.9036219275595;4400.119976004796;4401.581849724279;4441.467023957113;4521.231390663579;4572.588467037983;4202.2856114460465;4450.643948484129;4508.188526065307;4550.203714349992;4551.931721024187;4305.268104422255;4371.388005679208;4457.866264012085;4501.909961800746;4509.79705913233;4400.427944367212;4407.0524837160165;4454.510003899569;4458.799354029076;4482.618977386926;4409.691321607489;4410.316400957857;4413;4431.800568974404;4457.621102206316;4628.074385122989;4734.124187025412;4758.1673207188605;4788.880277993043;4800.711957282574;5122.769475373617;5185.766640501187;5195.428502864682;5197.064528384889;5231.450697676727;5212.40057393397;5214.843554693365;5215.504527069922;5219.347581552306;5258.737063146866;4699.78850951708;4784;4862.222044472867;4874.902501949941;4877.707337559757;5282.920756188661;5334.0665383557725;5340.626156169109;5384.515393614593;5399.1091469907815;5117.437081920985;5121.155009423478;5122.487751224848;5129.79480820763;5157.58739300855;4951.876203094951;5020.849374518771;5183.144781111075;5197.688138711689;5198.740062996835;5045.318881950963;5068.56917162038;5072.543471087546;5111.846644600668;5118.25785261135;4983.277424773388;5054;5057.974710126426;5088.262201980692;5109.284700141983;4317.395564620955;4329.242382583036;4343.326784348431;4412.205802955435;4419.602235798793;3798.582155962842;3804.2201348723447;3847.788371639587;3869.438931354994;3897.5322961244833;4332.1985432695055;4410.29435290352;4426.18115648606;4452.065066336106;4470.1059788041875;5017.598592112622;5162.045021671003;5165.870853228699;5173.275741396207;5175.482451754794;4390.1000294940095;4405.691601587922;4425.114977004612;4441.578050085302;4479.664025198123;4642.860714178512;4668.393108895822;4682.765861706901;4691.108689349013;4731.834385796549;4609.055143695601;4745.9050818984115;4766.7854946526795;4778.522147785194;4819.469858315582;5104.387473503055;5130.050940576006;5142.665726727751;5150.819721309736;5204.401493828258;4727.101850648366;4737.9052418952115;4755.048990201904;4766.189747742961;4804.783784729765;4903.730294833818;4989.625778066732;5085.415177254663;5092.41437234708;5101.846944591668;5042.520960508746;5048.116579598629;5052.797888084436;5147.5881929446305;5175.896482070413;4963.181075122564;4973.328600638867;4976.950230497649;4987.152184128634;5029.673071250357;4916.901661966812;4933.235348520985;4957.529034741694;4961.8511444656715;5024.42219144803;4768.237082066853;4827.758612069312;4835.58897493717;4851.223804191312;4983.177775666974;5033.597312214941;5041.571466425248;5047.596192304533;5073.11220536412;5087.745612719424;4835.153848076643;4927.433345165208;4934.50654934518;4935.629827763004;4957.107720610181 16:18:40 INFO - PROCESS | 22424 | |1;ext.html;551.0494397164889;555.9360673522544;558.5168828962949;573.921028466483;594.4323171371341;33782.49326260105;37784.24431511371;37989.24021519568;37992;38112.618873811254;38508.80745596275;38785;38922;38960.80519597398;39045.80477097611;7637.312641862231;7750.806229844243;7760.301572858441;7771.727989520368;7778.5721785301785;7589.127250366196;7594.73418430355;7667.42494312926;7677.884831727529;7688.730894418696;7684.269994350528;7692.730754423596;7715.807104822368;7741.806454838646;7755.26324999127;7619.80950476237;7630.0843898731955;7632.61836908158;7681.193474685189;7686.730964416219;7588.544687318778;7659.578723170223;7682.8079298018;7697.30724234816;7707.036620422447;36375.454368184495;36514.63485365139;36741.26517469635;36800.815995919846;36967.630323696685;3082.5530298106873;3112.766542509321;3172.888948886778;3201.3437245364644;3356.9328613427597;28333;28648.713512865022;28719.56920646171;28819.42361152765;29091;2772.1544928796707;2780.624615676878;2785.832850029005;2803.509385857467;2894.8118372305735;255345;257092;257194;257481.7125914377;257822;50650.74674626677;50653.49346506488;50893;50983.745081274355;51084;32355.838220809215;33367.3326533468;33444.1638959028;52524;52713.47286527162;13994.16035037901;14006;14059.297035148202;14073.788893166611;14119.78820317696;10399.428031458343;10438.791224175475;10475.214358923111;10477;10479.84280235797;17803.46589602314;17869.821301786815;17973;17984.9100754498;17988.820111798716;6705.899411508832;6807.115075040213;6878.965605171942;6996.6151861648095;7061.329173728487;763.6410886883156;808.9433739638168;927.9375115492858;973.7468258252763;982.5824024789579;25989.870050649624;27483.725162748116;27605.723942760316;27720.861395693297;27920.44159116847;920.9447433153898;922.9353945223904;976.946267955255;993.1508560181086;995.2336700740534;14071.366788494337;15027.474038408822;15122.773158402633;15207.08757474555;15272.236388180547;405430;407222;411979;412186;413760;49107.75446122818;49460.50539494631;49590.75204623954;49700;49898.25152622713;1157.7568710570706;1160.0951258018758;1193.2661413230974;1202.1404695642657;1207.6014915078003;25807.612885807102;27291.590626140227;27888.816677498537;28307.858460707565;28363.71636283611;41213.381799272436;41936;41974.16051679011;42002.579974201086;42127.36808947807;360659;361539;361560;361681;363019;24555.386115346544;24702.382440438414;24762.752372476767;25005.12482063119;25045.248642540024;40090.599094008685;41121.38317925293;41238.38142427926;41491.37762933619;41985.58014419817;35276.647233527336;35327.646723533464;35337.46993795044;36280.81859590685;36425.08937276589;35420.645793541735;35653.465198021535;35748.748793792096;35828.64171358357;36095.81952090223;33875.66124338824;33900.3219935595;33974.66025339715;34276.828615856764;34291.4856277161;30417.84791076119;32820.179495512806;32822;32862;33129.83435082809;25088.49823003566;25220;25294.494110117328;25337.239882803544;25657.871710642074 16:18:40 INFO - PROCESS | 22424 | |2;jquery.html;358.19585031604055;362.358625233337;364.27691033298896;377.4281962826317;381.3973921204497;15658.373665053385;16686.833131668678;17449.7382539262;17499.73750393742;17721.468355949342;16677.24952377143;17124.143792810373;17485.388011419604;17575.648487030285;17581.120943952785;4925.458199598051;5140.280360749498;5142.997115562467;5143.074246635604;5157.638965272433;3735.9066023349496;5054.494550544953;5661.320641523002;5895.705214739267;5912.645241285537;5964.314103878044;5978.8505287367725;5985.281766188042;6012.068129439944;6013.518918486532;5913.7338819752995;5920.141579470974;5921.141434491975;5959.255093113361;5973.462388385066;5080;5124.154514505102;5170.069387510247;5175.068487672217;5220.686758794484;18345.357912473133;19304.90347548267;20671.069801858954;21032.26387076445;21052.578948420945;1736.157963387756;1801.4505575799376;1877.8591605629633;1971.7338159348449;1976.3478052242726;9279.536023198812;9568.234541236685;9987.700368988943;10987.285826421257;13688.452461901512;1721.3372851452157;1734.765806616116;1735.4446577095334;1764.5323989142887;1769.4426255729534;69490.65254673694;69652.65173674149;70228.29771702268;70939;71265;9580.856287155699;9790.510474476248;9876.60493580263;9977.60089596408;10174.796504069876;13746.587602371945;13753.656158595915;13764.380602872894;13768.93115534436;13794;6762.222344430355;6953.200381956039;6998.965005174941;7098.219195888448;7204.0994875640545;6598.568744252962;6693.263740988487;6704;6774.93225067743;6884.483663725241;4122.42286079949;4148.128892932457;4176.832926682899;4214.262504061777;4354.695171337976;1605.871530277575;1644.7203975324223;1647.8599319057776;1711.2042900051536;1851.3890416162635;847.576211894053;860.1097863711029;865.299107722734;867.1631875240423;926.1294383279695;16794;16940.491785246217;17174;17539.210735516932;17682;802.6107337941094;846.9703560375481;850.1243718969348;852.48424703055;920.7375897869075;9291.907080929104;9611.615535378507;9756.560954757053;9776.217902567778;9982.201423886218;361660;366335;368401;369000;371867;74789.62605187048;75121.62439187769;75403;78329;78810.21189788029;827.8220182660878;875.899271583776;888.2893685051932;892.2594246775161;898.2903506230135;14786.359146925428;15059.698806024036;15566.610834729223;15627.843721562638;15717.764233536278;35394.46908296326;35914.820425897706;36239;36241;36665;44618.10763784641;46207.30689039734;46669.299960501296;47686.523134768206;53832.73083634713;7414.703411863465;7592.4305677075545;7594.924050759642;7620.161782203842;7714.614269286401;9012.459252444874;11227.27022743519;11320.26418282809;11451.198416110792;11662.70843228926;9598.66404675861;9841.261905356983;9944;9970.551325190529;10053.145482634058;8795.47227166372;9071.410358326688;10041.748956276151;10285.485725713535;10293.845592316271;9537;9745.463999480096;9758.75603109928;9943.154831839085;10420.68737937863;7423.888641670487;7502.249775022454;7570.621468926422;7717;7717.729879454417;9627;9796.608135674493;9961.35251208669;10030.247731420319;10241.692749217535 16:18:40 INFO - PROCESS | 22424 | |3;mootools.html;1356.270754787646;1405.0515901766307;1483.9389836267067;1723.3968111161103;1743.1545700335344;6938.340857618531;7748.961255193716;7777;8289.29540989016;8293.377996650253;7750.186230445806;7999.32005779508;8008.27925486706;8028.678852845879;8054.194580541943;2230.208276062003;2248.325502349297;2249.0778780699916;2255.1430456426533;2261.389424855288;2176.281826997095;2228.487447886987;2263.54729054189;2266.7393249776324;2269.217120093565;2240.1711366794307;2249.347689170139;2257.6500642400374;2258.4015235962484;2261.321603518946;2143.20701340505;2150.1506904772605;2176.1186719378597;2178.564287142578;2182.1707751054655;2121.63932131538;2142.7535833379206;2147.9785202147937;2148.9785102148935;2150.924717634891;7955.801104972365;7963.64163612633;7980.640871160812;8023.558704271263;8063.596820159028;4726.196546587088;4802.639802014863;4807;4814.940713043125;4854.223324268136;2778.978813725877;2933.1493866778824;2965.8220506769662;2972.212363723615;2975.4792911240447;847.3009766942236;884.2748945864394;890.9821803563957;892.8705337726059;900.045951291633;11202.159838012181;11211.439428028647;11238.887611123948;11240.269382490113;11247.83128253077;4169.645580125723;4278.7860606969525;4397.164538737629;4413.801378937956;4420.557944205618;9475;9502.239820814457;9520.619175233052;9554.808903822024;9568.521573921276;4891.902161956812;4892.951070489321;4892.996935628188;4904.043711476228;4905.190643543775;3721.292954338667;4246.171996460722;4411.448568928884;4423.889402764892;4457.286834106528;3694.556653201579;3760.8683696070507;3766.246750649826;3839.1937693084765;3871.1870507193803;1162.3258510064143;1204.3015051270243;1228.784962631536;1230.5754514692596;1232.0820988363726;770.210534202447;811.9553424561587;813.7070654564352;816.4325793573528;820.122468958209;5066.923996140061;5127.589792816566;5142.51146141116;5233.842984710464;5317.946820531823;375.51746006381666;387.0285583186223;388.1964333828947;388.60556535116876;395.5787086752599;3457.930841383158;3468.150303175738;3495.580530336376;3514.7715398499017;3585.8027808470265;9870.16103631185;10118.797624047478;10238.692839214835;10246.692599222035;10252.026057524523;10157.69526914179;10159.288849780445;10168.135708464715;10195.847062294071;10229;7483.550986940801;7484.671153807819;7711.03612048494;7716.845663086707;7753.8449231015065;5103.821366252163;5135.486451354984;5180.197069454241;5450.809221677222;5523.28197334344;9172.862407064033;9175.54122293896;9256.352055356061;9270.814583708423;9312;8865.955670221607;9201.631934722536;9227.35408521397;9262.44425334482;9500.619975200914;6239.625622462667;6834.350736680008;6950.131233595801;7195.640217988975;7338.046054012944;7528.623568821647;7600.859871019391;7637.389008879165;7643.312101910855;7662.540247585162;6987.091678081817;7027.648617569203;7089.574625522485;7136.964315178391;7286.744963926237;6868.244493105654;6948.861022779415;6984.79045628632;6985.860282794417;6995.895061574182;6332.113504109337;6344.397282258178;6360.650164240826;6535.3464653534265;6618.602883826793;4496.662750293806;4585.380973568525;4587.082583483383;4660.370849935351;4751.7861696224445;4382.758948257876;4490.506044335055;4574.268117101248;4576.290674945389;4592.88517787058 16:18:40 INFO - PROCESS | 22424 | |4;prototype.html;296.1544789625619;298.2781668362562;300.340752049252;302.9727324540792;306.6687976984856;4973.751312434382;5049.949500504994;5051.040302342552;5060.898782024357;5071.594272458204;4957.801687932488;4970.950290497094;4980.825671101512;5009.722520757211;5028.522290382408;3710.4248841429553;3773;3852.595477474867;3880.3597406427907;3891.5330160380795;3886.397608370707;3889.2999260133165;3903.726739128262;3920.157525962793;3940.8226629801584;3881.961180388202;3906.101596632762;3912.256671232471;3912.2957867583823;3930.4648501716374;3818.885433437001;3896.2856343208896;3900.317444447239;3930.6855451563947;3932.5084364454588;3418.1967237699123;3422.1273575238406;3426.9828650856834;3439.518467414564;3440.7247420206572;4825.455854126681;4840.661153719241;4883.780229889663;4890.682105663121;4920.827771027997;4384.802683879233;4489.842855500042;4501.347304640842;4502.469160485451;4512.548745125494;5156.278121063054;5197.376314842205;5230.738463076831;5235.424103348629;5236.92144617831;3729.1236559408517;3783.375743002401;3784.829682664259;3793.8103094845146;3798.2213646202463;5373.435789242151;5455.399906010336;5469.945300546983;5497.615166938316;5515.972420137914;3865.130345672201;3867.7679339239735;3873.748206366577;3891.2412079644196;3900.2589507993957;3949.8025098744947;3962.5244970603135;3967.3652215645357;3968.40473928913;3976.940345894814;4477.350784136282;4481.2381895077915;4490.967077572177;4500.729956202638;4513.119941611354;4983.725895075733;5254.238135470336;5258.39528454225;5261.815836445782;5263.368395792453;1311.6851955530603;1320.8679132086907;1329.315402567659;1333.6932505523785;1334.1528129637557;806.6853926968487;832.138736407815;844.8943882014748;848.1476116502998;851.9275861551714;4302.935455968163;4403.493598236244;4572.233798551894;4587.403637527167;4590.334401511762;5418.729063546807;5430.67415955044;5453.263809385682;5459.890802183934;5463;4544.7276361819095;4557.680962332671;4559.6124329431705;4570.651657760968;4578.793954272066;2723.891044358243;2885.5383138697707;2885.653721553385;2888.7400133988044;2901.608282881826;4993.625478089158;5017.297578339036;5020.146575082244;5040.143175660147;5055.115354812893;5346.492083252085;5507.201455788888;5521.481592561997;5534.817479949045;5539.723013849291;4939.975300123477;4949.851504454872;4953.504649535018;4982.252662100714;4983.202687569971;5378.300820893259;5399.217113518596;5448.83653490396;5463.72681365938;5474.6715197086705;5085.288059671575;5230.372355317386;5276.314079169683;5288.101022826052;5311.49540793624;4944.703317800943;4958.710735208944;4960.950390496048;4966.602671786321;5022.171341728574;3456.75802693809;3487.8898266549386;3497.720182385352;3499.6675315844955;3534.381483240474;4611.6310695144975;4750.833720819893;4844.975775121102;4880.658353915192;4887.951120488749;4584.266517357207;4615.330777037378;4616.884577885579;4725.952740472551;4770.880727981828;4651.604613607881;4668.369770080995;4695.647826412965;4762.809487620457;4764.142454358249;4644.37300964379;4674.555917187861;4677.32178834074;4733.337332773345;4805.975970120127;5029.723365214948;5157.793688252578;5300.522952934254;5329.600279978939;5343.625946183885;5192.532672059382;5202.401723801811;5209.931963947306;5212.035773381936;5224.373075230997 16:18:40 INFO - PROCESS | 22424 | |5;yui.html;573.1059547106512;582.5106910195435;598.3029770317575;635.098160611931;647.8218489915274;11892.167548271624;12395.814062789053;12474.93762531186;12868.806967895465;13142.60572182836;14977.625559360995;15185;15191.848081519182;15220.695586088272;15385.461508847193;770.7995921060536;784.2784638132903;785.35600807338;787.5235482533071;787.940904432167;628.9308176100625;749.5502698380982;763.8319569694659;775.4494309040588;788.7239466186846;823.2631794543879;824.517657170553;825.1913125137369;825.7357645553425;828.6933834481221;818.0878320672438;818.9058258300312;824.0482243009304;826.5701835045803;827.0984626756804;596.2427716799683;597.0954004682909;600.051917969607;603.1284793473433;603.2730559675624;12561.685957851036;12562.434690438951;12583.685407864876;12613.306268155247;12633.368331583475;12372.81440778389;12557.623271301876;12637.43131559082;12710.173838700548;12923.289219092947;9378.155965963097;9480.288978326653;9599.952000239955;9762.707118786448;9900.752481187956;3215.903522894317;3243.9026829195163;3245.7403407727325;3269.395161895057;3286.5234540991423;58690.41309586892;59579.40420595782;59953.40046599522;60428.395716042716;61044.38955610432;9062;9628.855567166498;9705.417674939526;9835.508224588742;9956.850647240297;16927;17412.91293543524;17520.21159047846;17574.121293935506;17598;6374.490040796725;6415.1981002374705;6461.57999730016;6470.870582588322;6576.934230657728;3521;3629.673329400314;3699.2601479704167;3711.9072023199637;3788.583255841855;2744.300203448108;2844.6159768431;2848.0886116442953;2863.727945845141;2868.3116052147334;495.4253066442909;497.78043792708013;501.52104739973237;508.9923651145236;518.6032684995981;435.63084977650584;480;515.4819406496447;529.3198240261246;538.3916174722617;6584.76953306632;6614.437772789271;6624.701888415033;6705.262421133769;6946.0970073891085;395.97426167299034;441.3490102099378;462.26961400986363;507.6471852062855;552.828623126832;3267.9019629411155;3401.132711158639;3421.3328400962073;3434.8969530913614;3482.495038219444;76847;78085;78947.21052789399;92162.53918730363;100089.49955250323;80880.78678819822;82887;83267.58366208251;83416;83500.16499835045;67168.6641566789;68283.65858170777;75678.24321756711;75730.24269757343;76198;7176.569405835667;7526.9085982533325;7740.187280335709;7812.960935195288;7830.804229894298;31536.842315788275;33854.66145338515;39849.40225896556;42885.785571071945;43924.56075439205;63941.36058639354;64481;64859.67570162119;65069;66169.33830661632;10326.896731032593;10609.20430967665;10628.468576571295;10668.30656007357;10835.945820270848;11697;11733.706657333634;11765.941170294094;11776.52893884235;11785.823212651645;10804.891951080703;11176.441177940907;11273;11815.940920295343;11859.762804744028;10864.402457864893;11263.26788758728;11350.489227984926;11778.234414763014;11821.349825759666;10461.790764184825;10547;10589.311694739818;10596.364218146937;11121.833172502256;8540.615672294885;8733.737987860375;8900.465972041698;8904.688335908211;8965.462072275423;8567.700130495652;9038.276937844825;9101.908980910372;9110.316726245426;9118.726438206864 16:18:40 INFO - PROCESS | 22424 | __end_tp_report 16:18:40 INFO - PROCESS | 22424 | __start_cc_report 16:18:40 INFO - PROCESS | 22424 | _x_x_mozilla_cycle_collect,410 16:18:40 INFO - PROCESS | 22424 | __end_cc_report 16:18:40 INFO - PROCESS | 22424 | __startTimestamp1469143120975__endTimestamp 16:18:40 INFO - PROCESS | 22424 | 16:18:40 INFO - PROCESS | 22424 | ------- Summary: start ------- 16:18:40 INFO - PROCESS | 22424 | Number of tests: 6 16:18:40 INFO - PROCESS | 22424 | 16:18:40 INFO - PROCESS | 22424 | [#0] dojo.html Cycles:165 Average:4741.77 Median:4827.76 stddev:505.33 (10.5%) stddev-sans-first:477.25 16:18:40 INFO - PROCESS | 22424 | Values: 2568.6 2596.5 2607.9 2611.4 2621.1 4645.5 4746.8 4765.8 4812.5 4849.8 4648.5 4781.7 4788.0 4814.0 4818.9 4400.1 4401.6 4441.5 4521.2 4572.6 4202.3 4450.6 4508.2 4550.2 4551.9 4305.3 4371.4 4457.9 4501.9 4509.8 4400.4 4407.1 4454.5 4458.8 4482.6 4409.7 4410.3 4413.0 4431.8 4457.6 4628.1 4734.1 4758.2 4788.9 4800.7 5122.8 5185.8 5195.4 5197.1 5231.5 5212.4 5214.8 5215.5 5219.3 5258.7 4699.8 4784.0 4862.2 4874.9 4877.7 5282.9 5334.1 5340.6 5384.5 5399.1 5117.4 5121.2 5122.5 5129.8 5157.6 4951.9 5020.8 5183.1 5197.7 5198.7 5045.3 5068.6 5072.5 5111.8 5118.3 4983.3 5054.0 5058.0 5088.3 5109.3 4317.4 4329.2 4343.3 4412.2 4419.6 3798.6 3804.2 3847.8 3869.4 3897.5 4332.2 4410.3 4426.2 4452.1 4470.1 5017.6 5162.0 5165.9 5173.3 5175.5 4390.1 4405.7 4425.1 4441.6 4479.7 4642.9 4668.4 4682.8 4691.1 4731.8 4609.1 4745.9 4766.8 4778.5 4819.5 5104.4 5130.1 5142.7 5150.8 5204.4 4727.1 4737.9 4755.0 4766.2 4804.8 4903.7 4989.6 5085.4 5092.4 5101.8 5042.5 5048.1 5052.8 5147.6 5175.9 4963.2 4973.3 4977.0 4987.2 5029.7 4916.9 4933.2 4957.5 4961.9 5024.4 4768.2 4827.8 4835.6 4851.2 4983.2 5033.6 5041.6 5047.6 5073.1 5087.7 4835.2 4927.4 4934.5 4935.6 4957.1 16:18:40 INFO - PROCESS | 22424 | 16:18:40 INFO - PROCESS | 22424 | [#1] ext.html Cycles:180 Average:48603.65 Median:198980.91 stddev:92163.06 (46.3%) stddev-sans-first:92350.98 16:18:40 INFO - PROCESS | 22424 | Values: 551.0 555.9 558.5 573.9 594.4 33782.5 37784.2 37989.2 37992.0 38112.6 38508.8 38785.0 38922.0 38960.8 39045.8 7637.3 7750.8 7760.3 7771.7 7778.6 7589.1 7594.7 7667.4 7677.9 7688.7 7684.3 7692.7 7715.8 7741.8 7755.3 7619.8 7630.1 7632.6 7681.2 7686.7 7588.5 7659.6 7682.8 7697.3 7707.0 36375.5 36514.6 36741.3 36800.8 36967.6 3082.6 3112.8 3172.9 3201.3 3356.9 28333.0 28648.7 28719.6 28819.4 29091.0 2772.2 2780.6 2785.8 2803.5 2894.8 255345.0 257092.0 257194.0 257481.7 257822.0 50650.7 50653.5 50893.0 50983.7 51084.0 32355.8 33367.3 33444.2 52524.0 52713.5 13994.2 14006.0 14059.3 14073.8 14119.8 10399.4 10438.8 10475.2 10477.0 10479.8 17803.5 17869.8 17973.0 17984.9 17988.8 6705.9 6807.1 6879.0 6996.6 7061.3 763.6 808.9 927.9 973.7 982.6 25989.9 27483.7 27605.7 27720.9 27920.4 920.9 922.9 976.9 993.2 995.2 14071.4 15027.5 15122.8 15207.1 15272.2 405430.0 407222.0 411979.0 412186.0 413760.0 49107.8 49460.5 49590.8 49700.0 49898.3 1157.8 1160.1 1193.3 1202.1 1207.6 25807.6 27291.6 27888.8 28307.9 28363.7 41213.4 41936.0 41974.2 42002.6 42127.4 360659.0 361539.0 361560.0 361681.0 363019.0 24555.4 24702.4 24762.8 25005.1 25045.2 40090.6 41121.4 41238.4 41491.4 41985.6 35276.6 35327.6 35337.5 36280.8 36425.1 35420.6 35653.5 35748.7 35828.6 36095.8 33875.7 33900.3 33974.7 34276.8 34291.5 30417.8 32820.2 32822.0 32862.0 33129.8 25088.5 25220.0 25294.5 25337.2 25657.9 16:18:40 INFO - PROCESS | 22424 | 16:18:40 INFO - PROCESS | 22424 | [#2] jquery.html Cycles:180 Average:23563.65 Median:5150.36 stddev:60805.67 (1180.6%) stddev-sans-first:60951.28 16:18:40 INFO - PROCESS | 22424 | Values: 358.2 362.4 364.3 377.4 381.4 15658.4 16686.8 17449.7 17499.7 17721.5 16677.2 17124.1 17485.4 17575.6 17581.1 4925.5 5140.3 5143.0 5143.1 5157.6 3735.9 5054.5 5661.3 5895.7 5912.6 5964.3 5978.9 5985.3 6012.1 6013.5 5913.7 5920.1 5921.1 5959.3 5973.5 5080.0 5124.2 5170.1 5175.1 5220.7 18345.4 19304.9 20671.1 21032.3 21052.6 1736.2 1801.5 1877.9 1971.7 1976.3 9279.5 9568.2 9987.7 10987.3 13688.5 1721.3 1734.8 1735.4 1764.5 1769.4 69490.7 69652.7 70228.3 70939.0 71265.0 9580.9 9790.5 9876.6 9977.6 10174.8 13746.6 13753.7 13764.4 13768.9 13794.0 6762.2 6953.2 6999.0 7098.2 7204.1 6598.6 6693.3 6704.0 6774.9 6884.5 4122.4 4148.1 4176.8 4214.3 4354.7 1605.9 1644.7 1647.9 1711.2 1851.4 847.6 860.1 865.3 867.2 926.1 16794.0 16940.5 17174.0 17539.2 17682.0 802.6 847.0 850.1 852.5 920.7 9291.9 9611.6 9756.6 9776.2 9982.2 361660.0 366335.0 368401.0 369000.0 371867.0 74789.6 75121.6 75403.0 78329.0 78810.2 827.8 875.9 888.3 892.3 898.3 14786.4 15059.7 15566.6 15627.8 15717.8 35394.5 35914.8 36239.0 36241.0 36665.0 44618.1 46207.3 46669.3 47686.5 53832.7 7414.7 7592.4 7594.9 7620.2 7714.6 9012.5 11227.3 11320.3 11451.2 11662.7 9598.7 9841.3 9944.0 9970.6 10053.1 8795.5 9071.4 10041.7 10285.5 10293.8 9537.0 9745.5 9758.8 9943.2 10420.7 7423.9 7502.2 7570.6 7717.0 7717.7 9627.0 9796.6 9961.4 10030.2 10241.7 16:18:40 INFO - PROCESS | 22424 | 16:18:40 INFO - PROCESS | 22424 | [#3] mootools.html Cycles:180 Average:5276.14 Median:4804.82 stddev:3037.23 (63.2%) stddev-sans-first:3031.46 16:18:40 INFO - PROCESS | 22424 | Values: 1356.3 1405.1 1483.9 1723.4 1743.2 6938.3 7749.0 7777.0 8289.3 8293.4 7750.2 7999.3 8008.3 8028.7 8054.2 2230.2 2248.3 2249.1 2255.1 2261.4 2176.3 2228.5 2263.5 2266.7 2269.2 2240.2 2249.3 2257.7 2258.4 2261.3 2143.2 2150.2 2176.1 2178.6 2182.2 2121.6 2142.8 2148.0 2149.0 2150.9 7955.8 7963.6 7980.6 8023.6 8063.6 4726.2 4802.6 4807.0 4814.9 4854.2 2779.0 2933.1 2965.8 2972.2 2975.5 847.3 884.3 891.0 892.9 900.0 11202.2 11211.4 11238.9 11240.3 11247.8 4169.6 4278.8 4397.2 4413.8 4420.6 9475.0 9502.2 9520.6 9554.8 9568.5 4891.9 4893.0 4893.0 4904.0 4905.2 3721.3 4246.2 4411.4 4423.9 4457.3 3694.6 3760.9 3766.2 3839.2 3871.2 1162.3 1204.3 1228.8 1230.6 1232.1 770.2 812.0 813.7 816.4 820.1 5066.9 5127.6 5142.5 5233.8 5317.9 375.5 387.0 388.2 388.6 395.6 3457.9 3468.2 3495.6 3514.8 3585.8 9870.2 10118.8 10238.7 10246.7 10252.0 10157.7 10159.3 10168.1 10195.8 10229.0 7483.6 7484.7 7711.0 7716.8 7753.8 5103.8 5135.5 5180.2 5450.8 5523.3 9172.9 9175.5 9256.4 9270.8 9312.0 8866.0 9201.6 9227.4 9262.4 9500.6 6239.6 6834.4 6950.1 7195.6 7338.0 7528.6 7600.9 7637.4 7643.3 7662.5 6987.1 7027.6 7089.6 7137.0 7286.7 6868.2 6948.9 6984.8 6985.9 6995.9 6332.1 6344.4 6360.7 6535.3 6618.6 4496.7 4585.4 4587.1 4660.4 4751.8 4382.8 4490.5 4574.3 4576.3 4592.9 16:18:40 INFO - PROCESS | 22424 | 16:18:40 INFO - PROCESS | 22424 | [#4] prototype.html Cycles:180 Average:4280.16 Median:4729.65 stddev:1238.36 (26.2%) stddev-sans-first:1205.19 16:18:40 INFO - PROCESS | 22424 | Values: 296.2 298.3 300.3 303.0 306.7 4973.8 5049.9 5051.0 5060.9 5071.6 4957.8 4971.0 4980.8 5009.7 5028.5 3710.4 3773.0 3852.6 3880.4 3891.5 3886.4 3889.3 3903.7 3920.2 3940.8 3882.0 3906.1 3912.3 3912.3 3930.5 3818.9 3896.3 3900.3 3930.7 3932.5 3418.2 3422.1 3427.0 3439.5 3440.7 4825.5 4840.7 4883.8 4890.7 4920.8 4384.8 4489.8 4501.3 4502.5 4512.5 5156.3 5197.4 5230.7 5235.4 5236.9 3729.1 3783.4 3784.8 3793.8 3798.2 5373.4 5455.4 5469.9 5497.6 5516.0 3865.1 3867.8 3873.7 3891.2 3900.3 3949.8 3962.5 3967.4 3968.4 3976.9 4477.4 4481.2 4491.0 4500.7 4513.1 4983.7 5254.2 5258.4 5261.8 5263.4 1311.7 1320.9 1329.3 1333.7 1334.2 806.7 832.1 844.9 848.1 851.9 4302.9 4403.5 4572.2 4587.4 4590.3 5418.7 5430.7 5453.3 5459.9 5463.0 4544.7 4557.7 4559.6 4570.7 4578.8 2723.9 2885.5 2885.7 2888.7 2901.6 4993.6 5017.3 5020.1 5040.1 5055.1 5346.5 5507.2 5521.5 5534.8 5539.7 4940.0 4949.9 4953.5 4982.3 4983.2 5378.3 5399.2 5448.8 5463.7 5474.7 5085.3 5230.4 5276.3 5288.1 5311.5 4944.7 4958.7 4961.0 4966.6 5022.2 3456.8 3487.9 3497.7 3499.7 3534.4 4611.6 4750.8 4845.0 4880.7 4888.0 4584.3 4615.3 4616.9 4726.0 4770.9 4651.6 4668.4 4695.6 4762.8 4764.1 4644.4 4674.6 4677.3 4733.3 4806.0 5029.7 5157.8 5300.5 5329.6 5343.6 5192.5 5202.4 5209.9 5212.0 5224.4 16:18:40 INFO - PROCESS | 22424 | 16:18:40 INFO - PROCESS | 22424 | [#5] yui.html Cycles:180 Average:16859.50 Median:562.97 stddev:24067.82 (4275.2%) stddev-sans-first:24104.27 16:18:40 INFO - PROCESS | 22424 | Values: 573.1 582.5 598.3 635.1 647.8 11892.2 12395.8 12474.9 12868.8 13142.6 14977.6 15185.0 15191.8 15220.7 15385.5 770.8 784.3 785.4 787.5 787.9 628.9 749.6 763.8 775.4 788.7 823.3 824.5 825.2 825.7 828.7 818.1 818.9 824.0 826.6 827.1 596.2 597.1 600.1 603.1 603.3 12561.7 12562.4 12583.7 12613.3 12633.4 12372.8 12557.6 12637.4 12710.2 12923.3 9378.2 9480.3 9600.0 9762.7 9900.8 3215.9 3243.9 3245.7 3269.4 3286.5 58690.4 59579.4 59953.4 60428.4 61044.4 9062.0 9628.9 9705.4 9835.5 9956.9 16927.0 17412.9 17520.2 17574.1 17598.0 6374.5 6415.2 6461.6 6470.9 6576.9 3521.0 3629.7 3699.3 3711.9 3788.6 2744.3 2844.6 2848.1 2863.7 2868.3 495.4 497.8 501.5 509.0 518.6 435.6 480.0 515.5 529.3 538.4 6584.8 6614.4 6624.7 6705.3 6946.1 396.0 441.3 462.3 507.6 552.8 3267.9 3401.1 3421.3 3434.9 3482.5 76847.0 78085.0 78947.2 92162.5 100089.5 80880.8 82887.0 83267.6 83416.0 83500.2 67168.7 68283.7 75678.2 75730.2 76198.0 7176.6 7526.9 7740.2 7813.0 7830.8 31536.8 33854.7 39849.4 42885.8 43924.6 63941.4 64481.0 64859.7 65069.0 66169.3 10326.9 10609.2 10628.5 10668.3 10835.9 11697.0 11733.7 11765.9 11776.5 11785.8 10804.9 11176.4 11273.0 11815.9 11859.8 10864.4 11263.3 11350.5 11778.2 11821.3 10461.8 10547.0 10589.3 10596.4 11121.8 8540.6 8733.7 8900.5 8904.7 8965.5 8567.7 9038.3 9101.9 9110.3 9118.7 16:18:40 INFO - PROCESS | 22424 | -------- Summary: end -------- 16:18:40 INFO - PROCESS | 22424 | 16:18:41 INFO - TEST-INFO | 22424: exit 0 16:18:41 INFO - TEST-OK | dromaeo_css | took 1116889ms 16:18:41 INFO - TEST-START | kraken 16:18:41 INFO - operating with platform_type : linux_ 16:18:41 INFO - Initialising browser for kraken test... 16:18:41 INFO - TEST-INFO | started process 22672 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKFOR2A/profile http://localhost:35638/getInfo.html) 16:18:45 INFO - PROCESS | 22672 | JavaScript error: , line 0: uncaught exception: undefined 16:18:46 INFO - PROCESS | 22672 | __metrics Screen width/height:1600/1200 16:18:46 INFO - PROCESS | 22672 | colorDepth:24 16:18:46 INFO - PROCESS | 22672 | Browser inner width/height: 1024/697 16:18:46 INFO - PROCESS | 22672 | __metrics 16:18:47 ERROR - PROCESS | 22672 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 16:18:47 INFO - TEST-INFO | 22672: exit 0 16:18:47 INFO - Browser initialized. 16:18:47 INFO - Running cycle 1/1 for kraken test... 16:18:47 INFO - TEST-INFO | started process 22790 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKFOR2A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:18:59 INFO - PROCESS | 22790 | RSS: Main: 169611264 16:18:59 INFO - PROCESS | 22790 | 16:19:02 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:35638/tests/kraken/driver.html?testName=audio-beat-detection) 16:19:03 INFO - PROCESS | 22790 | RSS: Main: 174505984 16:19:03 INFO - PROCESS | 22790 | 16:19:06 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:35638/tests/kraken/driver.html?testName=audio-dft) 16:19:06 INFO - PROCESS | 22790 | RSS: Main: 173076480 16:19:06 INFO - PROCESS | 22790 | 16:19:09 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:35638/tests/kraken/driver.html?testName=audio-fft) 16:19:10 INFO - PROCESS | 22790 | RSS: Main: 169996288 16:19:10 INFO - PROCESS | 22790 | 16:19:12 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:35638/tests/kraken/driver.html?testName=audio-oscillator) 16:19:13 INFO - PROCESS | 22790 | RSS: Main: 170037248 16:19:13 INFO - PROCESS | 22790 | 16:19:15 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:35638/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:19:16 INFO - PROCESS | 22790 | RSS: Main: 170889216 16:19:16 INFO - PROCESS | 22790 | 16:19:19 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:35638/tests/kraken/driver.html?testName=imaging-darkroom) 16:19:20 INFO - PROCESS | 22790 | RSS: Main: 171483136 16:19:20 INFO - PROCESS | 22790 | 16:19:23 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:35638/tests/kraken/driver.html?testName=imaging-desaturate) 16:19:24 INFO - PROCESS | 22790 | RSS: Main: 168030208 16:19:24 INFO - PROCESS | 22790 | 16:19:27 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:35638/tests/kraken/driver.html?testName=json-parse-financial) 16:19:27 INFO - PROCESS | 22790 | RSS: Main: 169664512 16:19:27 INFO - PROCESS | 22790 | 16:19:29 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:35638/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:19:30 INFO - PROCESS | 22790 | RSS: Main: 170348544 16:19:30 INFO - PROCESS | 22790 | 16:19:32 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:35638/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:19:32 INFO - PROCESS | 22790 | RSS: Main: 170344448 16:19:32 INFO - PROCESS | 22790 | 16:19:34 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:35638/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:19:35 INFO - PROCESS | 22790 | RSS: Main: 170627072 16:19:35 INFO - PROCESS | 22790 | 16:19:38 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:35638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:19:39 INFO - PROCESS | 22790 | RSS: Main: 170594304 16:19:39 INFO - PROCESS | 22790 | 16:19:41 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:35638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:42 INFO - PROCESS | 22790 | RSS: Main: 170496000 16:19:42 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | Cycle 1(1): loaded http://localhost:35638/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:35638/tests/kraken/driver.html?testName=ai-astar) 16:19:44 INFO - PROCESS | 22790 | RSS: Main: 171376640 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | __start_tp_report 16:19:44 INFO - PROCESS | 22790 | _x_x_mozilla_page_load 16:19:44 INFO - PROCESS | 22790 | _x_x_mozilla_page_load_details 16:19:44 INFO - PROCESS | 22790 | |i|pagename|runs| 16:19:44 INFO - PROCESS | 22790 | |0;ai-astar;107;114;107;115;114;116;117;114;114;113 16:19:44 INFO - PROCESS | 22790 | |1;audio-beat-detection;153;123;156;185;126;155;149;126;178;125 16:19:44 INFO - PROCESS | 22790 | |2;audio-dft;164;162;163;167;169;173;162;164;164;164 16:19:44 INFO - PROCESS | 22790 | |3;audio-fft;77;77;76;157;80;77;75;76;173;77 16:19:44 INFO - PROCESS | 22790 | |4;audio-oscillator;86;86;148;86;87;86;140;87;86;140 16:19:44 INFO - PROCESS | 22790 | |5;imaging-gaussian-blur;119;119;118;118;117;121;119;117;118;117 16:19:44 INFO - PROCESS | 22790 | |6;imaging-darkroom;147;155;147;149;150;149;148;149;148;148 16:19:44 INFO - PROCESS | 22790 | |7;imaging-desaturate;96;96;96;96;96;96;96;96;96;101 16:19:44 INFO - PROCESS | 22790 | |8;json-parse-financial;62;63;62;62;65;62;61;61;62;62 16:19:44 INFO - PROCESS | 22790 | |9;json-stringify-tinderbox;65;66;66;67;66;65;66;65;65;66 16:19:44 INFO - PROCESS | 22790 | |10;stanford-crypto-aes;85;82;81;95;82;81;79;80;84;81 16:19:44 INFO - PROCESS | 22790 | |11;stanford-crypto-ccm;143;135;132;136;134;136;134;138;172;148 16:19:44 INFO - PROCESS | 22790 | |12;stanford-crypto-pbkdf2;167;179;165;166;167;166;169;172;171;168 16:19:44 INFO - PROCESS | 22790 | |13;stanford-crypto-sha256-iterative;70;69;70;69;69;76;68;67;66;68 16:19:44 INFO - PROCESS | 22790 | __end_tp_report 16:19:44 INFO - PROCESS | 22790 | __start_cc_report 16:19:44 INFO - PROCESS | 22790 | _x_x_mozilla_cycle_collect,974 16:19:44 INFO - PROCESS | 22790 | __end_cc_report 16:19:44 INFO - PROCESS | 22790 | __startTimestamp1469143184596__endTimestamp 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | ------- Summary: start ------- 16:19:44 INFO - PROCESS | 22790 | Number of tests: 14 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#0] ai-astar Cycles:10 Average:113.10 Median:114.00 stddev:3.41 (3.0%) stddev-sans-first:2.82 16:19:44 INFO - PROCESS | 22790 | Values: 107.0 114.0 107.0 115.0 114.0 116.0 117.0 114.0 114.0 113.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#1] audio-beat-detection Cycles:10 Average:147.60 Median:154.00 stddev:22.43 (14.6%) stddev-sans-first:23.71 16:19:44 INFO - PROCESS | 22790 | Values: 153.0 123.0 156.0 185.0 126.0 155.0 149.0 126.0 178.0 125.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#2] audio-dft Cycles:10 Average:165.20 Median:164.00 stddev:3.49 (2.1%) stddev-sans-first:3.67 16:19:44 INFO - PROCESS | 22790 | Values: 164.0 162.0 163.0 167.0 169.0 173.0 162.0 164.0 164.0 164.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#3] audio-fft Cycles:10 Average:94.50 Median:77.00 stddev:37.37 (48.5%) stddev-sans-first:39.10 16:19:44 INFO - PROCESS | 22790 | Values: 77.0 77.0 76.0 157.0 80.0 77.0 75.0 76.0 173.0 77.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#4] audio-oscillator Cycles:10 Average:103.20 Median:86.00 stddev:27.32 (31.8%) stddev-sans-first:28.26 16:19:44 INFO - PROCESS | 22790 | Values: 86.0 86.0 148.0 86.0 87.0 86.0 140.0 87.0 86.0 140.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#5] imaging-gaussian-blur Cycles:10 Average:118.30 Median:118.50 stddev:1.25 (1.1%) stddev-sans-first:1.30 16:19:44 INFO - PROCESS | 22790 | Values: 119.0 119.0 118.0 118.0 117.0 121.0 119.0 117.0 118.0 117.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#6] imaging-darkroom Cycles:10 Average:149.00 Median:149.00 stddev:2.31 (1.5%) stddev-sans-first:2.33 16:19:44 INFO - PROCESS | 22790 | Values: 147.0 155.0 147.0 149.0 150.0 149.0 148.0 149.0 148.0 148.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#7] imaging-desaturate Cycles:10 Average:96.50 Median:96.00 stddev:1.58 (1.6%) stddev-sans-first:1.67 16:19:44 INFO - PROCESS | 22790 | Values: 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 96.0 101.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#8] json-parse-financial Cycles:10 Average:62.20 Median:62.00 stddev:1.14 (1.8%) stddev-sans-first:1.20 16:19:44 INFO - PROCESS | 22790 | Values: 62.0 63.0 62.0 62.0 65.0 62.0 61.0 61.0 62.0 62.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#9] json-stringify-tinderbox Cycles:10 Average:65.70 Median:66.00 stddev:0.67 (1.0%) stddev-sans-first:0.67 16:19:44 INFO - PROCESS | 22790 | Values: 65.0 66.0 66.0 67.0 66.0 65.0 66.0 65.0 65.0 66.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#10] stanford-crypto-aes Cycles:10 Average:83.00 Median:82.00 stddev:4.57 (5.6%) stddev-sans-first:4.79 16:19:44 INFO - PROCESS | 22790 | Values: 85.0 82.0 81.0 95.0 82.0 81.0 79.0 80.0 84.0 81.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#11] stanford-crypto-ccm Cycles:10 Average:140.80 Median:137.00 stddev:11.96 (8.7%) stddev-sans-first:12.66 16:19:44 INFO - PROCESS | 22790 | Values: 143.0 135.0 132.0 136.0 134.0 136.0 134.0 138.0 172.0 148.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.00 Median:168.50 stddev:4.16 (2.5%) stddev-sans-first:4.35 16:19:44 INFO - PROCESS | 22790 | Values: 167.0 179.0 165.0 166.0 167.0 166.0 169.0 172.0 171.0 168.0 16:19:44 INFO - PROCESS | 22790 | 16:19:44 INFO - PROCESS | 22790 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.00 stddev:2.70 (3.9%) stddev-sans-first:2.85 16:19:44 INFO - PROCESS | 22790 | Values: 70.0 69.0 70.0 69.0 69.0 76.0 68.0 67.0 66.0 68.0 16:19:44 INFO - PROCESS | 22790 | -------- Summary: end -------- 16:19:44 INFO - PROCESS | 22790 | 16:19:45 INFO - TEST-INFO | 22790: exit 0 16:19:45 INFO - TEST-OK | kraken | took 63919ms 16:19:45 INFO - SUITE-END | took 1180s 16:19:45 INFO - Completed test suite (00:19:40) 16:19:45 INFO - javascript benchmark 16:19:45 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6345.340516447024, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2568.6275490053945, 2596.467724116556, 2607.9478410431802, 2611.360216746896, 2621.1219241554077, 4645.465771436282, 4746.810127594897, 4765.833195838146, 4812.494688057756, 4849.830255941043, 4648.48866624671, 4781.7130972141695, 4787.976060119703, 4814.0, 4818.9036219275595, 4400.119976004796, 4401.581849724279, 4441.467023957113, 4521.231390663579, 4572.588467037983, 4202.2856114460465, 4450.643948484129, 4508.188526065307, 4550.203714349992, 4551.931721024187, 4305.268104422255, 4371.388005679208, 4457.866264012085, 4501.909961800746, 4509.79705913233, 4400.427944367212, 4407.0524837160165, 4454.510003899569, 4458.799354029076, 4482.618977386926, 4409.691321607489, 4410.316400957857, 4413.0, 4431.800568974404, 4457.621102206316, 4628.074385122989, 4734.124187025412, 4758.1673207188605, 4788.880277993043, 4800.711957282574, 5122.769475373617, 5185.766640501187, 5195.428502864682, 5197.064528384889, 5231.450697676727, 5212.40057393397, 5214.843554693365, 5215.504527069922, 5219.347581552306, 5258.737063146866, 4699.78850951708, 4784.0, 4862.222044472867, 4874.902501949941, 4877.707337559757, 5282.920756188661, 5334.0665383557725, 5340.626156169109, 5384.515393614593, 5399.1091469907815, 5117.437081920985, 5121.155009423478, 5122.487751224848, 5129.79480820763, 5157.58739300855, 4951.876203094951, 5020.849374518771, 5183.144781111075, 5197.688138711689, 5198.740062996835, 5045.318881950963, 5068.56917162038, 5072.543471087546, 5111.846644600668, 5118.25785261135, 4983.277424773388, 5054.0, 5057.974710126426, 5088.262201980692, 5109.284700141983, 4317.395564620955, 4329.242382583036, 4343.326784348431, 4412.205802955435, 4419.602235798793, 3798.582155962842, 3804.2201348723447, 3847.788371639587, 3869.438931354994, 3897.5322961244833, 4332.1985432695055, 4410.29435290352, 4426.18115648606, 4452.065066336106, 4470.1059788041875, 5017.598592112622, 5162.045021671003, 5165.870853228699, 5173.275741396207, 5175.482451754794, 4390.1000294940095, 4405.691601587922, 4425.114977004612, 4441.578050085302, 4479.664025198123, 4642.860714178512, 4668.393108895822, 4682.765861706901, 4691.108689349013, 4731.834385796549, 4609.055143695601, 4745.9050818984115, 4766.7854946526795, 4778.522147785194, 4819.469858315582, 5104.387473503055, 5130.050940576006, 5142.665726727751, 5150.819721309736, 5204.401493828258, 4727.101850648366, 4737.9052418952115, 4755.048990201904, 4766.189747742961, 4804.783784729765, 4903.730294833818, 4989.625778066732, 5085.415177254663, 5092.41437234708, 5101.846944591668, 5042.520960508746, 5048.116579598629, 5052.797888084436, 5147.5881929446305, 5175.896482070413, 4963.181075122564, 4973.328600638867, 4976.950230497649, 4987.152184128634, 5029.673071250357, 4916.901661966812, 4933.235348520985, 4957.529034741694, 4961.8511444656715, 5024.42219144803, 4768.237082066853, 4827.758612069312, 4835.58897493717, 4851.223804191312, 4983.177775666974, 5033.597312214941, 5041.571466425248, 5047.596192304533, 5073.11220536412, 5087.745612719424, 4835.153848076643, 4927.433345165208, 4934.50654934518, 4935.629827763004, 4957.107720610181], "value": 4708.54968164242, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [551.0494397164889, 555.9360673522544, 558.5168828962949, 573.921028466483, 594.4323171371341, 33782.49326260105, 37784.24431511371, 37989.24021519568, 37992.0, 38112.618873811254, 38508.80745596275, 38785.0, 38922.0, 38960.80519597398, 39045.80477097611, 7637.312641862231, 7750.806229844243, 7760.301572858441, 7771.727989520368, 7778.5721785301785, 7589.127250366196, 7594.73418430355, 7667.42494312926, 7677.884831727529, 7688.730894418696, 7684.269994350528, 7692.730754423596, 7715.807104822368, 7741.806454838646, 7755.26324999127, 7619.80950476237, 7630.0843898731955, 7632.61836908158, 7681.193474685189, 7686.730964416219, 7588.544687318778, 7659.578723170223, 7682.8079298018, 7697.30724234816, 7707.036620422447, 36375.454368184495, 36514.63485365139, 36741.26517469635, 36800.815995919846, 36967.630323696685, 3082.5530298106873, 3112.766542509321, 3172.888948886778, 3201.3437245364644, 3356.9328613427597, 28333.0, 28648.713512865022, 28719.56920646171, 28819.42361152765, 29091.0, 2772.1544928796707, 2780.624615676878, 2785.832850029005, 2803.509385857467, 2894.8118372305735, 255345.0, 257092.0, 257194.0, 257481.7125914377, 257822.0, 50650.74674626677, 50653.49346506488, 50893.0, 50983.745081274355, 51084.0, 32355.838220809215, 33367.3326533468, 33444.1638959028, 52524.0, 52713.47286527162, 13994.16035037901, 14006.0, 14059.297035148202, 14073.788893166611, 14119.78820317696, 10399.428031458343, 10438.791224175475, 10475.214358923111, 10477.0, 10479.84280235797, 17803.46589602314, 17869.821301786815, 17973.0, 17984.9100754498, 17988.820111798716, 6705.899411508832, 6807.115075040213, 6878.965605171942, 6996.6151861648095, 7061.329173728487, 763.6410886883156, 808.9433739638168, 927.9375115492858, 973.7468258252763, 982.5824024789579, 25989.870050649624, 27483.725162748116, 27605.723942760316, 27720.861395693297, 27920.44159116847, 920.9447433153898, 922.9353945223904, 976.946267955255, 993.1508560181086, 995.2336700740534, 14071.366788494337, 15027.474038408822, 15122.773158402633, 15207.08757474555, 15272.236388180547, 405430.0, 407222.0, 411979.0, 412186.0, 413760.0, 49107.75446122818, 49460.50539494631, 49590.75204623954, 49700.0, 49898.25152622713, 1157.7568710570706, 1160.0951258018758, 1193.2661413230974, 1202.1404695642657, 1207.6014915078003, 25807.612885807102, 27291.590626140227, 27888.816677498537, 28307.858460707565, 28363.71636283611, 41213.381799272436, 41936.0, 41974.16051679011, 42002.579974201086, 42127.36808947807, 360659.0, 361539.0, 361560.0, 361681.0, 363019.0, 24555.386115346544, 24702.382440438414, 24762.752372476767, 25005.12482063119, 25045.248642540024, 40090.599094008685, 41121.38317925293, 41238.38142427926, 41491.37762933619, 41985.58014419817, 35276.647233527336, 35327.646723533464, 35337.46993795044, 36280.81859590685, 36425.08937276589, 35420.645793541735, 35653.465198021535, 35748.748793792096, 35828.64171358357, 36095.81952090223, 33875.66124338824, 33900.3219935595, 33974.66025339715, 34276.828615856764, 34291.4856277161, 30417.84791076119, 32820.179495512806, 32822.0, 32862.0, 33129.83435082809, 25088.49823003566, 25220.0, 25294.494110117328, 25337.239882803544, 25657.871710642074], "value": 17125.045558217804, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [358.19585031604055, 362.358625233337, 364.27691033298896, 377.4281962826317, 381.3973921204497, 15658.373665053385, 16686.833131668678, 17449.7382539262, 17499.73750393742, 17721.468355949342, 16677.24952377143, 17124.143792810373, 17485.388011419604, 17575.648487030285, 17581.120943952785, 4925.458199598051, 5140.280360749498, 5142.997115562467, 5143.074246635604, 5157.638965272433, 3735.9066023349496, 5054.494550544953, 5661.320641523002, 5895.705214739267, 5912.645241285537, 5964.314103878044, 5978.8505287367725, 5985.281766188042, 6012.068129439944, 6013.518918486532, 5913.7338819752995, 5920.141579470974, 5921.141434491975, 5959.255093113361, 5973.462388385066, 5080.0, 5124.154514505102, 5170.069387510247, 5175.068487672217, 5220.686758794484, 18345.357912473133, 19304.90347548267, 20671.069801858954, 21032.26387076445, 21052.578948420945, 1736.157963387756, 1801.4505575799376, 1877.8591605629633, 1971.7338159348449, 1976.3478052242726, 9279.536023198812, 9568.234541236685, 9987.700368988943, 10987.285826421257, 13688.452461901512, 1721.3372851452157, 1734.765806616116, 1735.4446577095334, 1764.5323989142887, 1769.4426255729534, 69490.65254673694, 69652.65173674149, 70228.29771702268, 70939.0, 71265.0, 9580.856287155699, 9790.510474476248, 9876.60493580263, 9977.60089596408, 10174.796504069876, 13746.587602371945, 13753.656158595915, 13764.380602872894, 13768.93115534436, 13794.0, 6762.222344430355, 6953.200381956039, 6998.965005174941, 7098.219195888448, 7204.0994875640545, 6598.568744252962, 6693.263740988487, 6704.0, 6774.93225067743, 6884.483663725241, 4122.42286079949, 4148.128892932457, 4176.832926682899, 4214.262504061777, 4354.695171337976, 1605.871530277575, 1644.7203975324223, 1647.8599319057776, 1711.2042900051536, 1851.3890416162635, 847.576211894053, 860.1097863711029, 865.299107722734, 867.1631875240423, 926.1294383279695, 16794.0, 16940.491785246217, 17174.0, 17539.210735516932, 17682.0, 802.6107337941094, 846.9703560375481, 850.1243718969348, 852.48424703055, 920.7375897869075, 9291.907080929104, 9611.615535378507, 9756.560954757053, 9776.217902567778, 9982.201423886218, 361660.0, 366335.0, 368401.0, 369000.0, 371867.0, 74789.62605187048, 75121.62439187769, 75403.0, 78329.0, 78810.21189788029, 827.8220182660878, 875.899271583776, 888.2893685051932, 892.2594246775161, 898.2903506230135, 14786.359146925428, 15059.698806024036, 15566.610834729223, 15627.843721562638, 15717.764233536278, 35394.46908296326, 35914.820425897706, 36239.0, 36241.0, 36665.0, 44618.10763784641, 46207.30689039734, 46669.299960501296, 47686.523134768206, 53832.73083634713, 7414.703411863465, 7592.4305677075545, 7594.924050759642, 7620.161782203842, 7714.614269286401, 9012.459252444874, 11227.27022743519, 11320.26418282809, 11451.198416110792, 11662.70843228926, 9598.66404675861, 9841.261905356983, 9944.0, 9970.551325190529, 10053.145482634058, 8795.47227166372, 9071.410358326688, 10041.748956276151, 10285.485725713535, 10293.845592316271, 9537.0, 9745.463999480096, 9758.75603109928, 9943.154831839085, 10420.68737937863, 7423.888641670487, 7502.249775022454, 7570.621468926422, 7717.0, 7717.729879454417, 9627.0, 9796.608135674493, 9961.35251208669, 10030.247731420319, 10241.692749217535], "value": 8130.166286694904, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1356.270754787646, 1405.0515901766307, 1483.9389836267067, 1723.3968111161103, 1743.1545700335344, 6938.340857618531, 7748.961255193716, 7777.0, 8289.29540989016, 8293.377996650253, 7750.186230445806, 7999.32005779508, 8008.27925486706, 8028.678852845879, 8054.194580541943, 2230.208276062003, 2248.325502349297, 2249.0778780699916, 2255.1430456426533, 2261.389424855288, 2176.281826997095, 2228.487447886987, 2263.54729054189, 2266.7393249776324, 2269.217120093565, 2240.1711366794307, 2249.347689170139, 2257.6500642400374, 2258.4015235962484, 2261.321603518946, 2143.20701340505, 2150.1506904772605, 2176.1186719378597, 2178.564287142578, 2182.1707751054655, 2121.63932131538, 2142.7535833379206, 2147.9785202147937, 2148.9785102148935, 2150.924717634891, 7955.801104972365, 7963.64163612633, 7980.640871160812, 8023.558704271263, 8063.596820159028, 4726.196546587088, 4802.639802014863, 4807.0, 4814.940713043125, 4854.223324268136, 2778.978813725877, 2933.1493866778824, 2965.8220506769662, 2972.212363723615, 2975.4792911240447, 847.3009766942236, 884.2748945864394, 890.9821803563957, 892.8705337726059, 900.045951291633, 11202.159838012181, 11211.439428028647, 11238.887611123948, 11240.269382490113, 11247.83128253077, 4169.645580125723, 4278.7860606969525, 4397.164538737629, 4413.801378937956, 4420.557944205618, 9475.0, 9502.239820814457, 9520.619175233052, 9554.808903822024, 9568.521573921276, 4891.902161956812, 4892.951070489321, 4892.996935628188, 4904.043711476228, 4905.190643543775, 3721.292954338667, 4246.171996460722, 4411.448568928884, 4423.889402764892, 4457.286834106528, 3694.556653201579, 3760.8683696070507, 3766.246750649826, 3839.1937693084765, 3871.1870507193803, 1162.3258510064143, 1204.3015051270243, 1228.784962631536, 1230.5754514692596, 1232.0820988363726, 770.210534202447, 811.9553424561587, 813.7070654564352, 816.4325793573528, 820.122468958209, 5066.923996140061, 5127.589792816566, 5142.51146141116, 5233.842984710464, 5317.946820531823, 375.51746006381666, 387.0285583186223, 388.1964333828947, 388.60556535116876, 395.5787086752599, 3457.930841383158, 3468.150303175738, 3495.580530336376, 3514.7715398499017, 3585.8027808470265, 9870.16103631185, 10118.797624047478, 10238.692839214835, 10246.692599222035, 10252.026057524523, 10157.69526914179, 10159.288849780445, 10168.135708464715, 10195.847062294071, 10229.0, 7483.550986940801, 7484.671153807819, 7711.03612048494, 7716.845663086707, 7753.8449231015065, 5103.821366252163, 5135.486451354984, 5180.197069454241, 5450.809221677222, 5523.28197334344, 9172.862407064033, 9175.54122293896, 9256.352055356061, 9270.814583708423, 9312.0, 8865.955670221607, 9201.631934722536, 9227.35408521397, 9262.44425334482, 9500.619975200914, 6239.625622462667, 6834.350736680008, 6950.131233595801, 7195.640217988975, 7338.046054012944, 7528.623568821647, 7600.859871019391, 7637.389008879165, 7643.312101910855, 7662.540247585162, 6987.091678081817, 7027.648617569203, 7089.574625522485, 7136.964315178391, 7286.744963926237, 6868.244493105654, 6948.861022779415, 6984.79045628632, 6985.860282794417, 6995.895061574182, 6332.113504109337, 6344.397282258178, 6360.650164240826, 6535.3464653534265, 6618.602883826793, 4496.662750293806, 4585.380973568525, 4587.082583483383, 4660.370849935351, 4751.7861696224445, 4382.758948257876, 4490.506044335055, 4574.268117101248, 4576.290674945389, 4592.88517787058], "value": 4135.366810052675, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.1544789625619, 298.2781668362562, 300.340752049252, 302.9727324540792, 306.6687976984856, 4973.751312434382, 5049.949500504994, 5051.040302342552, 5060.898782024357, 5071.594272458204, 4957.801687932488, 4970.950290497094, 4980.825671101512, 5009.722520757211, 5028.522290382408, 3710.4248841429553, 3773.0, 3852.595477474867, 3880.3597406427907, 3891.5330160380795, 3886.397608370707, 3889.2999260133165, 3903.726739128262, 3920.157525962793, 3940.8226629801584, 3881.961180388202, 3906.101596632762, 3912.256671232471, 3912.2957867583823, 3930.4648501716374, 3818.885433437001, 3896.2856343208896, 3900.317444447239, 3930.6855451563947, 3932.5084364454588, 3418.1967237699123, 3422.1273575238406, 3426.9828650856834, 3439.518467414564, 3440.7247420206572, 4825.455854126681, 4840.661153719241, 4883.780229889663, 4890.682105663121, 4920.827771027997, 4384.802683879233, 4489.842855500042, 4501.347304640842, 4502.469160485451, 4512.548745125494, 5156.278121063054, 5197.376314842205, 5230.738463076831, 5235.424103348629, 5236.92144617831, 3729.1236559408517, 3783.375743002401, 3784.829682664259, 3793.8103094845146, 3798.2213646202463, 5373.435789242151, 5455.399906010336, 5469.945300546983, 5497.615166938316, 5515.972420137914, 3865.130345672201, 3867.7679339239735, 3873.748206366577, 3891.2412079644196, 3900.2589507993957, 3949.8025098744947, 3962.5244970603135, 3967.3652215645357, 3968.40473928913, 3976.940345894814, 4477.350784136282, 4481.2381895077915, 4490.967077572177, 4500.729956202638, 4513.119941611354, 4983.725895075733, 5254.238135470336, 5258.39528454225, 5261.815836445782, 5263.368395792453, 1311.6851955530603, 1320.8679132086907, 1329.315402567659, 1333.6932505523785, 1334.1528129637557, 806.6853926968487, 832.138736407815, 844.8943882014748, 848.1476116502998, 851.9275861551714, 4302.935455968163, 4403.493598236244, 4572.233798551894, 4587.403637527167, 4590.334401511762, 5418.729063546807, 5430.67415955044, 5453.263809385682, 5459.890802183934, 5463.0, 4544.7276361819095, 4557.680962332671, 4559.6124329431705, 4570.651657760968, 4578.793954272066, 2723.891044358243, 2885.5383138697707, 2885.653721553385, 2888.7400133988044, 2901.608282881826, 4993.625478089158, 5017.297578339036, 5020.146575082244, 5040.143175660147, 5055.115354812893, 5346.492083252085, 5507.201455788888, 5521.481592561997, 5534.817479949045, 5539.723013849291, 4939.975300123477, 4949.851504454872, 4953.504649535018, 4982.252662100714, 4983.202687569971, 5378.300820893259, 5399.217113518596, 5448.83653490396, 5463.72681365938, 5474.6715197086705, 5085.288059671575, 5230.372355317386, 5276.314079169683, 5288.101022826052, 5311.49540793624, 4944.703317800943, 4958.710735208944, 4960.950390496048, 4966.602671786321, 5022.171341728574, 3456.75802693809, 3487.8898266549386, 3497.720182385352, 3499.6675315844955, 3534.381483240474, 4611.6310695144975, 4750.833720819893, 4844.975775121102, 4880.658353915192, 4887.951120488749, 4584.266517357207, 4615.330777037378, 4616.884577885579, 4725.952740472551, 4770.880727981828, 4651.604613607881, 4668.369770080995, 4695.647826412965, 4762.809487620457, 4764.142454358249, 4644.37300964379, 4674.555917187861, 4677.32178834074, 4733.337332773345, 4805.975970120127, 5029.723365214948, 5157.793688252578, 5300.522952934254, 5329.600279978939, 5343.625946183885, 5192.532672059382, 5202.401723801811, 5209.931963947306, 5212.035773381936, 5224.373075230997], "value": 3882.597304316421, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.1059547106512, 582.5106910195435, 598.3029770317575, 635.098160611931, 647.8218489915274, 11892.167548271624, 12395.814062789053, 12474.93762531186, 12868.806967895465, 13142.60572182836, 14977.625559360995, 15185.0, 15191.848081519182, 15220.695586088272, 15385.461508847193, 770.7995921060536, 784.2784638132903, 785.35600807338, 787.5235482533071, 787.940904432167, 628.9308176100625, 749.5502698380982, 763.8319569694659, 775.4494309040588, 788.7239466186846, 823.2631794543879, 824.517657170553, 825.1913125137369, 825.7357645553425, 828.6933834481221, 818.0878320672438, 818.9058258300312, 824.0482243009304, 826.5701835045803, 827.0984626756804, 596.2427716799683, 597.0954004682909, 600.051917969607, 603.1284793473433, 603.2730559675624, 12561.685957851036, 12562.434690438951, 12583.685407864876, 12613.306268155247, 12633.368331583475, 12372.81440778389, 12557.623271301876, 12637.43131559082, 12710.173838700548, 12923.289219092947, 9378.155965963097, 9480.288978326653, 9599.952000239955, 9762.707118786448, 9900.752481187956, 3215.903522894317, 3243.9026829195163, 3245.7403407727325, 3269.395161895057, 3286.5234540991423, 58690.41309586892, 59579.40420595782, 59953.40046599522, 60428.395716042716, 61044.38955610432, 9062.0, 9628.855567166498, 9705.417674939526, 9835.508224588742, 9956.850647240297, 16927.0, 17412.91293543524, 17520.21159047846, 17574.121293935506, 17598.0, 6374.490040796725, 6415.1981002374705, 6461.57999730016, 6470.870582588322, 6576.934230657728, 3521.0, 3629.673329400314, 3699.2601479704167, 3711.9072023199637, 3788.583255841855, 2744.300203448108, 2844.6159768431, 2848.0886116442953, 2863.727945845141, 2868.3116052147334, 495.4253066442909, 497.78043792708013, 501.52104739973237, 508.9923651145236, 518.6032684995981, 435.63084977650584, 480.0, 515.4819406496447, 529.3198240261246, 538.3916174722617, 6584.76953306632, 6614.437772789271, 6624.701888415033, 6705.262421133769, 6946.0970073891085, 395.97426167299034, 441.3490102099378, 462.26961400986363, 507.6471852062855, 552.828623126832, 3267.9019629411155, 3401.132711158639, 3421.3328400962073, 3434.8969530913614, 3482.495038219444, 76847.0, 78085.0, 78947.21052789399, 92162.53918730363, 100089.49955250323, 80880.78678819822, 82887.0, 83267.58366208251, 83416.0, 83500.16499835045, 67168.6641566789, 68283.65858170777, 75678.24321756711, 75730.24269757343, 76198.0, 7176.569405835667, 7526.9085982533325, 7740.187280335709, 7812.960935195288, 7830.804229894298, 31536.842315788275, 33854.66145338515, 39849.40225896556, 42885.785571071945, 43924.56075439205, 63941.36058639354, 64481.0, 64859.67570162119, 65069.0, 66169.33830661632, 10326.896731032593, 10609.20430967665, 10628.468576571295, 10668.30656007357, 10835.945820270848, 11697.0, 11733.706657333634, 11765.941170294094, 11776.52893884235, 11785.823212651645, 10804.891951080703, 11176.441177940907, 11273.0, 11815.940920295343, 11859.762804744028, 10864.402457864893, 11263.26788758728, 11350.489227984926, 11778.234414763014, 11821.349825759666, 10461.790764184825, 10547.0, 10589.311694739818, 10596.364218146937, 11121.833172502256, 8540.615672294885, 8733.737987860375, 8900.465972041698, 8904.688335908211, 8965.462072275423, 8567.700130495652, 9038.276937844825, 9101.908980910372, 9110.316726245426, 9118.726438206864], "value": 6200.513138839656, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1577.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 114.0, 107.0, 115.0, 114.0, 116.0, 117.0, 114.0, 114.0, 113.0], "value": 113.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 156.0, 185.0, 126.0, 155.0, 149.0, 126.0, 178.0, 125.0], "value": 147.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 162.0, 163.0, 167.0, 169.0, 173.0, 162.0, 164.0, 164.0, 164.0], "value": 165.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 77.0, 76.0, 157.0, 80.0, 77.0, 75.0, 76.0, 173.0, 77.0], "value": 94.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 148.0, 86.0, 87.0, 86.0, 140.0, 87.0, 86.0, 140.0], "value": 103.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [119.0, 119.0, 118.0, 118.0, 117.0, 121.0, 119.0, 117.0, 118.0, 117.0], "value": 118.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 155.0, 147.0, 149.0, 150.0, 149.0, 148.0, 149.0, 148.0, 148.0], "value": 149.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 101.0], "value": 96.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 62.0, 62.0, 65.0, 62.0, 61.0, 61.0, 62.0, 62.0], "value": 62.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 66.0, 67.0, 66.0, 65.0, 66.0, 65.0, 65.0, 66.0], "value": 65.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 82.0, 81.0, 95.0, 82.0, 81.0, 79.0, 80.0, 84.0, 81.0], "value": 83.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 135.0, 132.0, 136.0, 134.0, 136.0, 134.0, 138.0, 172.0, 148.0], "value": 140.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 179.0, 165.0, 166.0, 167.0, 166.0, 169.0, 172.0, 171.0, 168.0], "value": 169.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 69.0, 70.0, 69.0, 69.0, 76.0, 68.0, 67.0, 66.0, 68.0], "value": 69.2, "unit": "score"}]}]} 16:19:45 INFO - Return code: 0 16:19:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 16:19:45 ERROR - # TBPL SUCCESS # 16:19:45 INFO - Running post-action listener: _resource_record_post_action 16:19:45 INFO - [mozharness: 2016-07-21 23:19:45.904474Z] Finished run-tests step (success) 16:19:45 INFO - Running post-run listener: _resource_record_post_run 16:19:45 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 537251840; Read time: 12; Write time: 490196 16:19:45 INFO - TinderboxPrint: CPU usage
13.3% 16:19:45 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 16:19:45 INFO - TinderboxPrint: I/O write bytes / time
537,251,840 / 490,196 16:19:45 INFO - TinderboxPrint: CPU idle
8,275.0 (86.6%) 16:19:45 INFO - TinderboxPrint: CPU user
1,220.6 (12.8%) 16:19:45 INFO - TinderboxPrint: Swap in / out
0 / 0 16:19:45 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246542336; Read time: 0; Write time: 272692 16:19:46 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 290144256; Read time: 0; Write time: 217504 16:19:46 INFO - Running post-run listener: _upload_blobber_files 16:19:46 INFO - Blob upload gear active. 16:19:46 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 16:19:46 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 16:19:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 16:19:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 16:19:47 INFO - (blobuploader) - INFO - Open directory for files ... 16:19:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 16:19:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:47 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 16:19:47 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:47 INFO - (blobuploader) - INFO - Done attempting. 16:19:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 16:19:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:19:48 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 16:19:48 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:19:48 INFO - (blobuploader) - INFO - Done attempting. 16:19:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 16:19:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 16:19:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 16:20:05 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 16:20:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 16:20:05 INFO - (blobuploader) - INFO - Done attempting. 16:20:05 INFO - (blobuploader) - INFO - Iteration through files over. 16:20:05 INFO - Return code: 0 16:20:05 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 16:20:05 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 16:20:05 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdda92013a607667bd6e908be3dda65e6eb8d4d650cc70a63ac99c2c258c2e04f710cdc51fab27c670f5c68d13a26bf7ef363a48b7a8a400e507311a2dec0cff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9bc5dccdbd8c59d1648e569e3cacad0d9655f1e2d55aaff9599152e778ef12d2e30b33c453127c463e97148b2e7a02b425e38c072c6a9eab7540dc0c4df4cb4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0266dcb02d11525a5cda6a8e7025047c1dc7b7f39689710ac14dad2bc0b3511bce64ff4a5ba3cd4b3355339ff3f08b2d32d5218a38e2a1690f590a55725b7b0e"} 16:20:05 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 16:20:05 INFO - Writing to file /builds/slave/test/properties/blobber_files 16:20:05 INFO - Contents: 16:20:05 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdda92013a607667bd6e908be3dda65e6eb8d4d650cc70a63ac99c2c258c2e04f710cdc51fab27c670f5c68d13a26bf7ef363a48b7a8a400e507311a2dec0cff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9bc5dccdbd8c59d1648e569e3cacad0d9655f1e2d55aaff9599152e778ef12d2e30b33c453127c463e97148b2e7a02b425e38c072c6a9eab7540dc0c4df4cb4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0266dcb02d11525a5cda6a8e7025047c1dc7b7f39689710ac14dad2bc0b3511bce64ff4a5ba3cd4b3355339ff3f08b2d32d5218a38e2a1690f590a55725b7b0e"} 16:20:05 INFO - Running post-run listener: copy_logs_to_upload_dir 16:20:05 INFO - Copying logs to upload dir... 16:20:05 INFO - mkdir: /builds/slave/test/build/upload/logs 16:20:05 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.826201 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-07-21 16:20:05.157899) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 16:20:05.161743) ========= 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=652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdda92013a607667bd6e908be3dda65e6eb8d4d650cc70a63ac99c2c258c2e04f710cdc51fab27c670f5c68d13a26bf7ef363a48b7a8a400e507311a2dec0cff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9bc5dccdbd8c59d1648e569e3cacad0d9655f1e2d55aaff9599152e778ef12d2e30b33c453127c463e97148b2e7a02b425e38c072c6a9eab7540dc0c4df4cb4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0266dcb02d11525a5cda6a8e7025047c1dc7b7f39689710ac14dad2bc0b3511bce64ff4a5ba3cd4b3355339ff3f08b2d32d5218a38e2a1690f590a55725b7b0e"} build_url:https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011465 build_url: 'https://queue.taskcluster.net/v1/task/JYRAzwcmSci5-mG6CSINfg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/bdda92013a607667bd6e908be3dda65e6eb8d4d650cc70a63ac99c2c258c2e04f710cdc51fab27c670f5c68d13a26bf7ef363a48b7a8a400e507311a2dec0cff", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/9bc5dccdbd8c59d1648e569e3cacad0d9655f1e2d55aaff9599152e778ef12d2e30b33c453127c463e97148b2e7a02b425e38c072c6a9eab7540dc0c4df4cb4d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0266dcb02d11525a5cda6a8e7025047c1dc7b7f39689710ac14dad2bc0b3511bce64ff4a5ba3cd4b3355339ff3f08b2d32d5218a38e2a1690f590a55725b7b0e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-21 16:20:05.186740) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 16:20:05.187095) ========= 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=652eb03db935cfc1c15ebda0000001ad-1469139734.288630-2002043968 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004551 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-21 16:20:05.271059) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 16:20:05.271419) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-21 16:20:05.271703) ========= ========= Total master_lag: 0.18 =========