builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-053 starttime: 1467285213.14 results: success (0) buildid: 20160630025327 builduid: 41050aa33e8a4acba96e2d6d61079be8 revision: 0edb9df3c97ff7d205a99f8af607f99a858f140b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.136312) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.136767) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.137062) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.188445) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.188757) ========= 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=920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 04:13:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 223M=0s 2016-06-30 04:13:34 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.074941 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.281621) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.281932) ========= 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=920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016330 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.337081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 04:13:33.337421) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 0edb9df3c97ff7d205a99f8af607f99a858f140b --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 0edb9df3c97ff7d205a99f8af607f99a858f140b --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=920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 04:13:34,163 truncating revision to first 12 chars 2016-06-30 04:13:34,163 Setting DEBUG logging. 2016-06-30 04:13:34,163 attempt 1/10 2016-06-30 04:13:34,163 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/0edb9df3c97f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 04:13:35,136 unpacking tar archive at: mozilla-central-0edb9df3c97f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.321382 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-06-30 04:13:34.673576) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:34.673879) ========= script_repo_revision: 0edb9df3c97ff7d205a99f8af607f99a858f140b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:34.674270) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:34.674532) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:34.686333) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-30 04:13:34.686765) ========= /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=920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:35 INFO - MultiFileLogger online at 20160630 04:13:35 in /builds/slave/test 04:13:35 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 04:13:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:35 INFO - {'append_to_log': False, 04:13:35 INFO - 'base_work_dir': '/builds/slave/test', 04:13:35 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:13:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:35 INFO - 'branch': 'Firefox-Non-PGO', 04:13:35 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:35 INFO - 'config_files': ('talos/linux_config.py',), 04:13:35 INFO - 'default_actions': ('clobber', 04:13:35 INFO - 'read-buildbot-config', 04:13:35 INFO - 'download-and-extract', 04:13:35 INFO - 'populate-webroot', 04:13:35 INFO - 'create-virtualenv', 04:13:35 INFO - 'install', 04:13:35 INFO - 'run-tests'), 04:13:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:35 INFO - 'download_minidump_stackwalk': True, 04:13:35 INFO - 'download_symbols': 'ondemand', 04:13:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:35 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:35 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:35 INFO - 'installer_path': 'installer.exe', 04:13:35 INFO - 'log_level': 'info', 04:13:35 INFO - 'log_name': 'talos', 04:13:35 INFO - 'log_to_console': True, 04:13:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:35 INFO - 'opt_config_files': (), 04:13:35 INFO - 'pip_index': False, 04:13:35 INFO - 'sps_profile': False, 04:13:35 INFO - 'sps_profile_interval': 0, 04:13:35 INFO - 'suite': 'dromaeojs-e10s', 04:13:35 INFO - 'system_bits': '32', 04:13:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:35 INFO - 'title': 'talos-linux64-ix-053', 04:13:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:35 INFO - 'use_talos_json': True, 04:13:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:35 INFO - 'work_dir': 'build'} 04:13:35 INFO - ##### 04:13:35 INFO - ##### Running clobber step. 04:13:35 INFO - ##### 04:13:35 INFO - Running pre-action listener: _resource_record_pre_action 04:13:35 INFO - Running main action method: clobber 04:13:35 INFO - rmtree: /builds/slave/test/build 04:13:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:36 INFO - Running post-action listener: _resource_record_post_action 04:13:36 INFO - ##### 04:13:36 INFO - ##### Finished clobber step (success) 04:13:36 INFO - ##### 04:13:36 INFO - ##### 04:13:36 INFO - ##### Running read-buildbot-config step. 04:13:36 INFO - ##### 04:13:36 INFO - Running pre-action listener: _resource_record_pre_action 04:13:36 INFO - Running main action method: read_buildbot_config 04:13:36 INFO - Using buildbot properties: 04:13:36 INFO - { 04:13:36 INFO - "project": "", 04:13:36 INFO - "product": "firefox", 04:13:36 INFO - "script_repo_revision": "production", 04:13:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:13:36 INFO - "repository": "", 04:13:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:13:36 INFO - "buildid": "20160630025327", 04:13:36 INFO - "pgo_build": "False", 04:13:36 INFO - "basedir": "/builds/slave/test", 04:13:36 INFO - "buildnumber": 384, 04:13:36 INFO - "slavename": "talos-linux64-ix-053", 04:13:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:13:36 INFO - "platform": "ubuntu64_hw", 04:13:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:13:36 INFO - "branch": "mozilla-central", 04:13:36 INFO - "repo_path": "mozilla-central", 04:13:36 INFO - "revision": "0edb9df3c97ff7d205a99f8af607f99a858f140b", 04:13:36 INFO - "stage_platform": "linux64", 04:13:36 INFO - "builduid": "41050aa33e8a4acba96e2d6d61079be8", 04:13:36 INFO - "slavebuilddir": "test" 04:13:36 INFO - } 04:13:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:13:36 INFO - Running post-action listener: _resource_record_post_action 04:13:36 INFO - ##### 04:13:36 INFO - ##### Finished read-buildbot-config step (success) 04:13:36 INFO - ##### 04:13:36 INFO - ##### 04:13:36 INFO - ##### Running download-and-extract step. 04:13:36 INFO - ##### 04:13:36 INFO - Running pre-action listener: _resource_record_pre_action 04:13:36 INFO - Running main action method: download_and_extract 04:13:36 INFO - mkdir: /builds/slave/test/build/tests 04:13: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')]} 04:13:36 INFO - https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:13:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 04:13:39 INFO - Downloaded 1361 bytes. 04:13:39 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:39 INFO - Using the following test package requirements: 04:13:39 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:39 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:39 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:13:39 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'jsshell-linux-x86_64.zip'], 04:13:39 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:39 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:39 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:39 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:39 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:39 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:39 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:39 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:39 INFO - https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:40 INFO - Downloaded 22701705 bytes. 04:13:40 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:13:41 INFO - Return code: 0 04:13:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 04:13:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:41 INFO - https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:13:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 04:13:43 INFO - Downloaded 22701705 bytes. 04:13:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 04:13:45 INFO - Return code: 0 04:13:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:45 INFO - https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 04:13:46 INFO - Downloaded 14405245 bytes. 04:13:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:13:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 04:13:46 INFO - Return code: 0 04:13:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:46 INFO - https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 04:13:48 INFO - Downloaded 56476207 bytes. 04:13:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:48 INFO - mkdir: /builds/slave/test/properties 04:13:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:48 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:48 INFO - Contents: 04:13:48 INFO - build_url:https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:13:49 INFO - Running post-action listener: _resource_record_post_action 04:13:49 INFO - Running post-action listener: set_extra_try_arguments 04:13:49 INFO - ##### 04:13:49 INFO - ##### Finished download-and-extract step (success) 04:13:49 INFO - ##### 04:13:49 INFO - ##### 04:13:49 INFO - ##### Running populate-webroot step. 04:13:49 INFO - ##### 04:13:49 INFO - Running pre-action listener: _resource_record_pre_action 04:13:49 INFO - Running main action method: populate_webroot 04:13:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:49 INFO - '--tppagecycles', 04:13:49 INFO - '7'], 04:13:49 INFO - 'tests': ['tsvgm']}}, 04:13:49 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:49 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:49 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:49 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:49 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:49 INFO - 'talos_options': ['--disable-e10s'], 04:13:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:49 INFO - 'talos_options': ['--disable-e10s'], 04:13:49 INFO - 'tests': ['damp', 'tps']}, 04:13:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:49 INFO - 'tests': ['damp', 'tps']}, 04:13:49 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:49 INFO - 'tests': ['dromaeo_dom']}, 04:13:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:49 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:13:49 INFO - 'tests': ['basic_compositor_video']}, 04:13:49 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:13:49 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:49 INFO - 'tests': ['a11yr', 04:13:49 INFO - 'ts_paint', 04:13:49 INFO - 'tpaint', 04:13:49 INFO - 'sessionrestore', 04:13:49 INFO - 'sessionrestore_no_auto_restore', 04:13:49 INFO - 'tabpaint']}, 04:13:49 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:49 INFO - 'ts_paint', 04:13:49 INFO - 'tpaint', 04:13:49 INFO - 'sessionrestore', 04:13:49 INFO - 'sessionrestore_no_auto_restore', 04:13:49 INFO - 'tabpaint']}, 04:13:49 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:49 INFO - 'ts_paint', 04:13:49 INFO - 'tpaint', 04:13:49 INFO - 'sessionrestore', 04:13:49 INFO - 'sessionrestore_no_auto_restore', 04:13:49 INFO - 'tabpaint']}, 04:13:49 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:49 INFO - 'ts_paint', 04:13:49 INFO - 'tpaint', 04:13:49 INFO - 'sessionrestore', 04:13:49 INFO - 'sessionrestore_no_auto_restore', 04:13:49 INFO - 'tabpaint']}, 04:13:49 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:49 INFO - 'tests': ['a11yr', 04:13:49 INFO - 'ts_paint', 04:13:49 INFO - 'tpaint', 04:13:49 INFO - 'sessionrestore', 04:13:49 INFO - 'sessionrestore_no_auto_restore', 04:13:49 INFO - 'tabpaint']}, 04:13:49 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:49 INFO - 'tests': ['a11yr', 04:13:49 INFO - 'ts_paint', 04:13:49 INFO - 'tpaint', 04:13:49 INFO - 'sessionrestore', 04:13:49 INFO - 'sessionrestore_no_auto_restore', 04:13:49 INFO - 'tabpaint']}, 04:13:49 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:49 INFO - 'tests': ['tsvgx', 04:13:49 INFO - 'tsvgr_opacity', 04:13:49 INFO - 'tart', 04:13:49 INFO - 'tscrollx', 04:13:49 INFO - 'cart']}, 04:13:49 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:49 INFO - 'tsvgr_opacity', 04:13:49 INFO - 'tart', 04:13:49 INFO - 'tscrollx', 04:13:49 INFO - 'cart']}, 04:13:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:49 INFO - 'talos_options': ['--disable-e10s'], 04:13:49 INFO - 'tests': ['tp5o']}, 04:13:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:49 INFO - 'tests': ['tp5o']}, 04:13:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:49 INFO - 'talos_options': ['--disable-e10s', 04:13:49 INFO - '--xperf_path', 04:13:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:49 INFO - 'tests': ['tp5n']}, 04:13:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:49 INFO - 'talos_options': ['--xperf_path', 04:13:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:49 INFO - 'tests': ['tp5n']}}, 04:13:49 INFO - 'talos.zip': {'path': '', 04:13:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:49 INFO - Running post-action listener: _resource_record_post_action 04:13:49 INFO - ##### 04:13:49 INFO - ##### Finished populate-webroot step (success) 04:13:49 INFO - ##### 04:13:49 INFO - ##### 04:13:49 INFO - ##### Running create-virtualenv step. 04:13:49 INFO - ##### 04:13:49 INFO - Running pre-action listener: _resource_record_pre_action 04:13:49 INFO - Running main action method: create_virtualenv 04:13:49 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:13:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:49 INFO - Using real prefix '/usr' 04:13:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:50 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:52 INFO - Installing pip.................done. 04:13:52 INFO - Return code: 0 04:13:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:52 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 0x1022030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e0570>, '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 0x12e1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1900>, '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': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:13:52 INFO - Using env: {'DISPLAY': ':0', 04:13:52 INFO - 'HOME': '/home/cltbld', 04:13:52 INFO - 'LANG': 'en_US.UTF-8', 04:13:52 INFO - 'LANGUAGE': 'en_US:en', 04:13:52 INFO - 'LOGNAME': 'cltbld', 04:13:52 INFO - 'MAIL': '/var/mail/cltbld', 04:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:52 INFO - 'MOZ_NO_REMOTE': '1', 04:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:52 INFO - 'NO_EM_RESTART': '1', 04:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:52 INFO - 'PWD': '/builds/slave/test', 04:13:52 INFO - 'SHELL': '/bin/bash', 04:13:52 INFO - 'SHLVL': '1', 04:13:52 INFO - 'TERM': 'linux', 04:13:52 INFO - 'TMOUT': '86400', 04:13:52 INFO - 'USER': 'cltbld', 04:13:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 04:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:52 INFO - '_': '/tools/buildbot/bin/python'} 04:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:13:52 INFO - Cleaning up... 04:13:52 INFO - Return code: 0 04:13:52 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:52 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 0x1022030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e0570>, '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 0x12e1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1900>, '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': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:13:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:13:52 INFO - Using env: {'DISPLAY': ':0', 04:13:52 INFO - 'HOME': '/home/cltbld', 04:13:52 INFO - 'LANG': 'en_US.UTF-8', 04:13:52 INFO - 'LANGUAGE': 'en_US:en', 04:13:52 INFO - 'LOGNAME': 'cltbld', 04:13:52 INFO - 'MAIL': '/var/mail/cltbld', 04:13:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:52 INFO - 'MOZ_NO_REMOTE': '1', 04:13:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:52 INFO - 'NO_EM_RESTART': '1', 04:13:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:52 INFO - 'PWD': '/builds/slave/test', 04:13:52 INFO - 'SHELL': '/bin/bash', 04:13:52 INFO - 'SHLVL': '1', 04:13:52 INFO - 'TERM': 'linux', 04:13:52 INFO - 'TMOUT': '86400', 04:13:52 INFO - 'USER': 'cltbld', 04:13:52 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 04:13:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:52 INFO - '_': '/tools/buildbot/bin/python'} 04:13:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:52 INFO - Downloading/unpacking psutil>=3.1.1 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:54 INFO - Installing collected packages: psutil 04:13:54 INFO - Running setup.py install for psutil 04:13:54 INFO - building 'psutil._psutil_linux' extension 04:13:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 04:13:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 04:13:55 INFO - building 'psutil._psutil_posix' extension 04:13:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 04:13:55 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 04:13:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:55 INFO - Successfully installed psutil 04:13:55 INFO - Cleaning up... 04:13:55 INFO - Return code: 0 04:13:55 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:55 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 0x1022030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e0570>, '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 0x12e1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1900>, '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': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:13:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:13:55 INFO - Using env: {'DISPLAY': ':0', 04:13:55 INFO - 'HOME': '/home/cltbld', 04:13:55 INFO - 'LANG': 'en_US.UTF-8', 04:13:55 INFO - 'LANGUAGE': 'en_US:en', 04:13:55 INFO - 'LOGNAME': 'cltbld', 04:13:55 INFO - 'MAIL': '/var/mail/cltbld', 04:13:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:55 INFO - 'MOZ_NO_REMOTE': '1', 04:13:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:55 INFO - 'NO_EM_RESTART': '1', 04:13:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:55 INFO - 'PWD': '/builds/slave/test', 04:13:55 INFO - 'SHELL': '/bin/bash', 04:13:55 INFO - 'SHLVL': '1', 04:13:55 INFO - 'TERM': 'linux', 04:13:55 INFO - 'TMOUT': '86400', 04:13:55 INFO - 'USER': 'cltbld', 04:13:55 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 04:13:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:55 INFO - '_': '/tools/buildbot/bin/python'} 04:13:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:55 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:57 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:13:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:13:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:13:57 INFO - Installing collected packages: mozsystemmonitor 04:13:57 INFO - Running setup.py install for mozsystemmonitor 04:13:57 INFO - Successfully installed mozsystemmonitor 04:13:57 INFO - Cleaning up... 04:13:57 INFO - Return code: 0 04:13:57 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 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 0x1022030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e0570>, '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 0x12e1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1900>, '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': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:13:57 INFO - Using env: {'DISPLAY': ':0', 04:13:57 INFO - 'HOME': '/home/cltbld', 04:13:57 INFO - 'LANG': 'en_US.UTF-8', 04:13:57 INFO - 'LANGUAGE': 'en_US:en', 04:13:57 INFO - 'LOGNAME': 'cltbld', 04:13:57 INFO - 'MAIL': '/var/mail/cltbld', 04:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:57 INFO - 'MOZ_NO_REMOTE': '1', 04:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:57 INFO - 'NO_EM_RESTART': '1', 04:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:57 INFO - 'PWD': '/builds/slave/test', 04:13:57 INFO - 'SHELL': '/bin/bash', 04:13:57 INFO - 'SHLVL': '1', 04:13:57 INFO - 'TERM': 'linux', 04:13:57 INFO - 'TMOUT': '86400', 04:13:57 INFO - 'USER': 'cltbld', 04:13:57 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 04:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:57 INFO - '_': '/tools/buildbot/bin/python'} 04:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:57 INFO - Downloading/unpacking jsonschema==2.5.1 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:13:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:00 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:00 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:00 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:00 INFO - warning: no files found matching '*.txt' 04:14:00 INFO - no previously-included directories found matching 'build' 04:14:00 INFO - no previously-included directories found matching 'dist' 04:14:00 INFO - no previously-included directories found matching '.git*' 04:14:00 INFO - Installing collected packages: jsonschema, functools32 04:14:00 INFO - Running setup.py install for functools32 04:14:00 INFO - warning: no files found matching '*.txt' 04:14:00 INFO - no previously-included directories found matching 'build' 04:14:00 INFO - no previously-included directories found matching 'dist' 04:14:00 INFO - no previously-included directories found matching '.git*' 04:14:00 INFO - Successfully installed jsonschema functools32 04:14:00 INFO - Cleaning up... 04:14:00 INFO - Return code: 0 04:14:00 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:00 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 0x1022030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e0570>, '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 0x12e1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1900>, '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': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:14:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:14:00 INFO - Using env: {'DISPLAY': ':0', 04:14:00 INFO - 'HOME': '/home/cltbld', 04:14:00 INFO - 'LANG': 'en_US.UTF-8', 04:14:00 INFO - 'LANGUAGE': 'en_US:en', 04:14:00 INFO - 'LOGNAME': 'cltbld', 04:14:00 INFO - 'MAIL': '/var/mail/cltbld', 04:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:00 INFO - 'MOZ_NO_REMOTE': '1', 04:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:00 INFO - 'NO_EM_RESTART': '1', 04:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:00 INFO - 'PWD': '/builds/slave/test', 04:14:00 INFO - 'SHELL': '/bin/bash', 04:14:00 INFO - 'SHLVL': '1', 04:14:00 INFO - 'TERM': 'linux', 04:14:00 INFO - 'TMOUT': '86400', 04:14:00 INFO - 'USER': 'cltbld', 04:14:00 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 04:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:00 INFO - '_': '/tools/buildbot/bin/python'} 04:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:00 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:02 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:02 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:03 INFO - Downloading docopt-0.6.1.tar.gz 04:14:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:03 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:03 INFO - Running setup.py install for blobuploader 04:14:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:03 INFO - Running setup.py install for requests 04:14:03 INFO - Running setup.py install for docopt 04:14:03 INFO - Successfully installed blobuploader requests docopt 04:14:03 INFO - Cleaning up... 04:14:04 INFO - Return code: 0 04:14:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14: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')]} 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14: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')]} 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:04 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 0x1022030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e0570>, '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 0x12e1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1900>, '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': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:14:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:14:04 INFO - Using env: {'DISPLAY': ':0', 04:14:04 INFO - 'HOME': '/home/cltbld', 04:14:04 INFO - 'LANG': 'en_US.UTF-8', 04:14:04 INFO - 'LANGUAGE': 'en_US:en', 04:14:04 INFO - 'LOGNAME': 'cltbld', 04:14:04 INFO - 'MAIL': '/var/mail/cltbld', 04:14:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:04 INFO - 'MOZ_NO_REMOTE': '1', 04:14:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:04 INFO - 'NO_EM_RESTART': '1', 04:14:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:04 INFO - 'PWD': '/builds/slave/test', 04:14:04 INFO - 'SHELL': '/bin/bash', 04:14:04 INFO - 'SHLVL': '1', 04:14:04 INFO - 'TERM': 'linux', 04:14:04 INFO - 'TMOUT': '86400', 04:14:04 INFO - 'USER': 'cltbld', 04:14:04 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 04:14:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:04 INFO - '_': '/tools/buildbot/bin/python'} 04:14:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:04 INFO - Running setup.py (path:/tmp/pip-Vj8xzc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:04 INFO - Running setup.py (path:/tmp/pip-tjCaeq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:04 INFO - Running setup.py (path:/tmp/pip-_WD84f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:04 INFO - Running setup.py (path:/tmp/pip-8TPgMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:04 INFO - Running setup.py (path:/tmp/pip-_UgDYP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:04 INFO - Running setup.py (path:/tmp/pip-Di1WxL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:04 INFO - Running setup.py (path:/tmp/pip-d6uj2o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:04 INFO - Running setup.py (path:/tmp/pip-ZQKdtT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:04 INFO - Running setup.py (path:/tmp/pip-Lhye4g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:04 INFO - Running setup.py (path:/tmp/pip-K0klsU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:04 INFO - Running setup.py (path:/tmp/pip-imH1UL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:05 INFO - Running setup.py (path:/tmp/pip-MW74gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:05 INFO - Running setup.py (path:/tmp/pip-jHNTeH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:05 INFO - Running setup.py (path:/tmp/pip-FuPlC7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:05 INFO - Running setup.py (path:/tmp/pip-JAfgpg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:05 INFO - Running setup.py (path:/tmp/pip-JGL9OQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:05 INFO - Running setup.py (path:/tmp/pip-65oxvq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:05 INFO - Running setup.py install for manifestparser 04:14:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:05 INFO - Running setup.py install for mozcrash 04:14:05 INFO - Running setup.py install for mozdebug 04:14:05 INFO - Running setup.py install for mozdevice 04:14:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:05 INFO - Running setup.py install for mozfile 04:14:05 INFO - Running setup.py install for mozhttpd 04:14:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Running setup.py install for mozinfo 04:14:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Running setup.py install for mozInstall 04:14:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Running setup.py install for mozleak 04:14:06 INFO - Running setup.py install for mozlog 04:14:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Running setup.py install for moznetwork 04:14:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Running setup.py install for mozprocess 04:14:06 INFO - Running setup.py install for mozprofile 04:14:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Running setup.py install for mozrunner 04:14:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:06 INFO - Running setup.py install for mozscreenshot 04:14:07 INFO - Running setup.py install for moztest 04:14:07 INFO - Running setup.py install for mozversion 04:14:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:07 INFO - Cleaning up... 04:14:07 INFO - Return code: 0 04:14:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:07 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 0x1022030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e0570>, '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 0x12e1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1900>, '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': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:14:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:14:07 INFO - Using env: {'DISPLAY': ':0', 04:14:07 INFO - 'HOME': '/home/cltbld', 04:14:07 INFO - 'LANG': 'en_US.UTF-8', 04:14:07 INFO - 'LANGUAGE': 'en_US:en', 04:14:07 INFO - 'LOGNAME': 'cltbld', 04:14:07 INFO - 'MAIL': '/var/mail/cltbld', 04:14:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:07 INFO - 'MOZ_NO_REMOTE': '1', 04:14:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:07 INFO - 'NO_EM_RESTART': '1', 04:14:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:07 INFO - 'PWD': '/builds/slave/test', 04:14:07 INFO - 'SHELL': '/bin/bash', 04:14:07 INFO - 'SHLVL': '1', 04:14:07 INFO - 'TERM': 'linux', 04:14:07 INFO - 'TMOUT': '86400', 04:14:07 INFO - 'USER': 'cltbld', 04:14:07 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 04:14:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:07 INFO - '_': '/tools/buildbot/bin/python'} 04:14:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:07 INFO - Running setup.py (path:/tmp/pip-j8dDmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:07 INFO - Running setup.py (path:/tmp/pip-198WLK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:07 INFO - Running setup.py (path:/tmp/pip-vmpNpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:07 INFO - Running setup.py (path:/tmp/pip-OMHLhK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:07 INFO - Running setup.py (path:/tmp/pip-q6XoMo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:07 INFO - Running setup.py (path:/tmp/pip-r29OB9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:07 INFO - Running setup.py (path:/tmp/pip-1SsPM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:07 INFO - Running setup.py (path:/tmp/pip-YzIN04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:08 INFO - Running setup.py (path:/tmp/pip-EjSHaH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:08 INFO - Running setup.py (path:/tmp/pip-pjxtIa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:08 INFO - Running setup.py (path:/tmp/pip-ru1upF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:08 INFO - Running setup.py (path:/tmp/pip-9rZyf4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:08 INFO - Running setup.py (path:/tmp/pip-Td6Ula-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:08 INFO - Running setup.py (path:/tmp/pip-rUJaIK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:08 INFO - Running setup.py (path:/tmp/pip-ero2P9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:08 INFO - Running setup.py (path:/tmp/pip-ueeUvI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:14:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:08 INFO - Running setup.py (path:/tmp/pip-IJAk21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:14:08 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:10 INFO - Downloading blessings-1.6.tar.gz 04:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:10 INFO - Installing collected packages: blessings 04:14:10 INFO - Running setup.py install for blessings 04:14:10 INFO - Successfully installed blessings 04:14:10 INFO - Cleaning up... 04:14:10 INFO - Return code: 0 04:14:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:11 INFO - Reading from file tmpfile_stdout 04:14:11 INFO - Current package versions: 04:14:11 INFO - argparse == 1.2.1 04:14:11 INFO - blessings == 1.6 04:14:11 INFO - blobuploader == 1.2.4 04:14:11 INFO - docopt == 0.6.1 04:14:11 INFO - functools32 == 3.2.3-2 04:14:11 INFO - jsonschema == 2.5.1 04:14:11 INFO - manifestparser == 1.1 04:14:11 INFO - mozInstall == 1.12 04:14:11 INFO - mozcrash == 0.17 04:14:11 INFO - mozdebug == 0.1 04:14:11 INFO - mozdevice == 0.48 04:14:11 INFO - mozfile == 1.2 04:14:11 INFO - mozhttpd == 0.7 04:14:11 INFO - mozinfo == 0.9 04:14:11 INFO - mozleak == 0.1 04:14:11 INFO - mozlog == 3.2 04:14:11 INFO - moznetwork == 0.27 04:14:11 INFO - mozprocess == 0.22 04:14:11 INFO - mozprofile == 0.28 04:14:11 INFO - mozrunner == 6.11 04:14:11 INFO - mozscreenshot == 0.1 04:14:11 INFO - mozsystemmonitor == 0.3 04:14:11 INFO - moztest == 0.7 04:14:11 INFO - mozversion == 1.4 04:14:11 INFO - psutil == 3.1.1 04:14:11 INFO - requests == 1.2.3 04:14:11 INFO - wsgiref == 0.1.2 04:14:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:11 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 0x1022030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e0570>, '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 0x12e1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1900>, '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': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:14:11 INFO - Using env: {'DISPLAY': ':0', 04:14:11 INFO - 'HOME': '/home/cltbld', 04:14:11 INFO - 'LANG': 'en_US.UTF-8', 04:14:11 INFO - 'LANGUAGE': 'en_US:en', 04:14:11 INFO - 'LOGNAME': 'cltbld', 04:14:11 INFO - 'MAIL': '/var/mail/cltbld', 04:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:11 INFO - 'MOZ_NO_REMOTE': '1', 04:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:11 INFO - 'NO_EM_RESTART': '1', 04:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:11 INFO - 'PWD': '/builds/slave/test', 04:14:11 INFO - 'SHELL': '/bin/bash', 04:14:11 INFO - 'SHLVL': '1', 04:14:11 INFO - 'TERM': 'linux', 04:14:11 INFO - 'TMOUT': '86400', 04:14:11 INFO - 'USER': 'cltbld', 04:14:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 04:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:11 INFO - '_': '/tools/buildbot/bin/python'} 04:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:14:11 INFO - Cleaning up... 04:14:11 INFO - Return code: 0 04:14:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:11 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 0x1022030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11858a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1251400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x12e0570>, '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 0x12e1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1900>, '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': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 04:14:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:14:11 INFO - Using env: {'DISPLAY': ':0', 04:14:11 INFO - 'HOME': '/home/cltbld', 04:14:11 INFO - 'LANG': 'en_US.UTF-8', 04:14:11 INFO - 'LANGUAGE': 'en_US:en', 04:14:11 INFO - 'LOGNAME': 'cltbld', 04:14:11 INFO - 'MAIL': '/var/mail/cltbld', 04:14:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:11 INFO - 'MOZ_NO_REMOTE': '1', 04:14:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:11 INFO - 'NO_EM_RESTART': '1', 04:14:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:11 INFO - 'PWD': '/builds/slave/test', 04:14:11 INFO - 'SHELL': '/bin/bash', 04:14:11 INFO - 'SHLVL': '1', 04:14:11 INFO - 'TERM': 'linux', 04:14:11 INFO - 'TMOUT': '86400', 04:14:11 INFO - 'USER': 'cltbld', 04:14:11 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 04:14:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:11 INFO - '_': '/tools/buildbot/bin/python'} 04:14:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:11 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:14:11 INFO - Cleaning up... 04:14:11 INFO - Return code: 0 04:14:11 INFO - Running post-action listener: _resource_record_post_action 04:14:11 INFO - Running post-action listener: _start_resource_monitoring 04:14:11 INFO - Starting resource monitoring. 04:14:11 INFO - ##### 04:14:11 INFO - ##### Finished create-virtualenv step (success) 04:14:11 INFO - ##### 04:14:11 INFO - ##### 04:14:11 INFO - ##### Running install step. 04:14:11 INFO - ##### 04:14:11 INFO - Running pre-action listener: _resource_record_pre_action 04:14:11 INFO - Running main action method: install 04:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:11 INFO - Reading from file tmpfile_stdout 04:14:11 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:11 INFO - Reading from file tmpfile_stdout 04:14:11 INFO - Output received: 04:14:11 INFO - Usage: mozinstall [options] installer 04:14:11 INFO - Options: 04:14:11 INFO - -h, --help show this help message and exit 04:14:11 INFO - -d DEST, --destination=DEST 04:14:11 INFO - Directory to install application into. [default: 04:14:11 INFO - "/builds/slave/test"] 04:14:11 INFO - --app=APP Application being installed. [default: firefox] 04:14:11 INFO - mkdir: /builds/slave/test/build/application 04:14:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 04:14:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 04:14:28 INFO - Reading from file tmpfile_stdout 04:14:28 INFO - Output received: 04:14:28 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:28 INFO - Running post-action listener: _resource_record_post_action 04:14:28 INFO - ##### 04:14:28 INFO - ##### Finished install step (success) 04:14:28 INFO - ##### 04:14:28 INFO - ##### 04:14:28 INFO - ##### Running run-tests step. 04:14:28 INFO - ##### 04:14:28 INFO - Running pre-action listener: _resource_record_pre_action 04:14:28 INFO - Running main action method: run_tests 04:14:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:28 INFO - Python 2.7.3 04:14:28 INFO - Return code: 0 04:14:28 INFO - grabbing minidump binary from tooltool 04:14:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:28 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 0x12e0570>, '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 0x12e1470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x12e1900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:14:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 04:14:28 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:14:28 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:28 INFO - Return code: 0 04:14:28 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:28 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/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 04:14:28 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/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-053 --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 04:14:28 INFO - Using env: {'DISPLAY': ':0', 04:14:28 INFO - 'HOME': '/home/cltbld', 04:14:28 INFO - 'LANG': 'en_US.UTF-8', 04:14:28 INFO - 'LANGUAGE': 'en_US:en', 04:14:28 INFO - 'LOGNAME': 'cltbld', 04:14:28 INFO - 'MAIL': '/var/mail/cltbld', 04:14:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:28 INFO - 'MOZ_NO_REMOTE': '1', 04:14:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:28 INFO - 'NO_EM_RESTART': '1', 04:14:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:28 INFO - 'PWD': '/builds/slave/test', 04:14:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:28 INFO - 'SHELL': '/bin/bash', 04:14:28 INFO - 'SHLVL': '1', 04:14:28 INFO - 'TERM': 'linux', 04:14:28 INFO - 'TMOUT': '86400', 04:14:28 INFO - 'USER': 'cltbld', 04:14:28 INFO - 'XDG_SESSION_COOKIE': '920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514', 04:14:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:28 INFO - '_': '/tools/buildbot/bin/python'} 04:14:28 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/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-053', '--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 04:14:28 INFO - mozversion application_buildid: 20160630025327 04:14:28 INFO - mozversion application_changeset: 0edb9df3c97ff7d205a99f8af607f99a858f140b 04:14:28 INFO - mozversion application_display_name: Nightly 04:14:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:28 INFO - mozversion application_name: Firefox 04:14:28 INFO - mozversion application_remotingname: firefox 04:14:28 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:14:28 INFO - mozversion application_vendor: Mozilla 04:14:28 INFO - mozversion application_version: 50.0a1 04:14:28 INFO - mozversion platform_buildid: 20160630025327 04:14:28 INFO - mozversion platform_changeset: 0edb9df3c97ff7d205a99f8af607f99a858f140b 04:14:28 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:14:28 INFO - mozversion platform_version: 50.0a1 04:14:28 INFO - using testdate: 1467285268 04:14:28 INFO - actual date: 1467285268 04:14:28 INFO - starting webserver on 'localhost:56180' 04:14:28 INFO - SUITE-START | Running 2 tests 04:14:28 INFO - TEST-START | dromaeo_css 04:14:28 INFO - operating with platform_type : linux_ 04:14:28 INFO - Initialising browser for dromaeo_css test... 04:14:28 INFO - TEST-INFO | started process 30051 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGc2Qba/profile http://localhost:56180/getInfo.html) 04:14:33 INFO - PROCESS | 30051 | __metrics Screen width/height:1600/1200 04:14:33 INFO - PROCESS | 30051 | colorDepth:24 04:14:33 INFO - PROCESS | 30051 | Browser inner width/height: 1024/697 04:14:33 INFO - PROCESS | 30051 | __metrics 04:14:34 ERROR - PROCESS | 30051 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:14:35 INFO - TEST-INFO | 30051: exit 0 04:14:35 INFO - Browser initialized. 04:14:35 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:35 INFO - TEST-INFO | started process 30167 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGc2Qba/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:47 INFO - PROCESS | 30167 | RSS: Main: 169549824 04:14:47 INFO - PROCESS | 30167 | 04:15:36 INFO - PROCESS | 30167 | 1467285336669 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 04:17:49 INFO - PROCESS | 30167 | Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56180/tests/dromaeo/cssquery-ext.html) 04:17:50 INFO - PROCESS | 30167 | RSS: Main: 172683264 04:17:50 INFO - PROCESS | 30167 | 04:20:52 INFO - PROCESS | 30167 | Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-ext.html (next: http://localhost:56180/tests/dromaeo/cssquery-jquery.html) 04:20:53 INFO - PROCESS | 30167 | RSS: Main: 169623552 04:20:53 INFO - PROCESS | 30167 | 04:23:55 INFO - PROCESS | 30167 | Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56180/tests/dromaeo/cssquery-mootools.html) 04:23:55 INFO - PROCESS | 30167 | RSS: Main: 172404736 04:23:55 INFO - PROCESS | 30167 | 04:26:57 INFO - PROCESS | 30167 | Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56180/tests/dromaeo/cssquery-prototype.html) 04:26:58 INFO - PROCESS | 30167 | RSS: Main: 167731200 04:26:58 INFO - PROCESS | 30167 | 04:30:00 INFO - PROCESS | 30167 | Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56180/tests/dromaeo/cssquery-yui.html) 04:30:01 INFO - PROCESS | 30167 | RSS: Main: 168734720 04:30:01 INFO - PROCESS | 30167 | 04:33:04 INFO - PROCESS | 30167 | Cycle 1(1): loaded http://localhost:56180/tests/dromaeo/cssquery-yui.html (next: http://localhost:56180/tests/dromaeo/cssquery-dojo.html) 04:33:04 INFO - PROCESS | 30167 | RSS: Main: 170893312 04:33:04 INFO - PROCESS | 30167 | 04:33:04 INFO - PROCESS | 30167 | __start_tp_report 04:33:04 INFO - PROCESS | 30167 | _x_x_mozilla_page_load 04:33:04 INFO - PROCESS | 30167 | _x_x_mozilla_page_load_details 04:33:04 INFO - PROCESS | 30167 | |i|pagename|runs| 04:33:04 INFO - PROCESS | 30167 | |0;dojo.html;2665.4402575459153;2713.3623598454346;2722.782177425807;2738.6302849115364;2743.9725602743965;4841.709497430156;4919.852404427868;4962.305277261182;4970.279309500121;4983.451820299764;4841.56425921667;4903.730294833792;4920.458749537548;4962.702237865721;4965.3048573199785;4510.639148868091;4542.136993971135;4574.336721175428;4614.515475875019;4648.48866624671;4519.2317306057885;4549.476810166823;4574.908501829961;4605.907881842361;4618;645.5978469819304;4582.083583283324;4613.930791038137;4662.300654901758;4677.087967846272;4551.658625603093;4552.840650577214;4591.724496530219;4601.401817763669;4609.308603709471;4528.954710452919;4538.273876179828;4545.568171023748;4581.2440947243995;4582.312653102062;4820.566149046603;4863.076015557032;4928.088303663833;4999.775010124553;5007.649464537484;5217.895642087137;5266.4733526647415;5364.409914909357;5446.537044351235;5450.645708028966;5405.486478784509;5438.782448702047;5440.047991601454;5452.372977107644;5454.290942177531;5031.723255220962;5038.5969122470115;5039.269305950616;5048.72232027242;5101.20931255656;5388.164834450667;5446.564274858002;5461.344638643388;5472.699001554953;5511.751971161308;5264.184051472028;5286.867828304246;5287.339082614673;5288.65623734456;5292.576593872481;5201.947980520222;5333.519983201453;5405.297311349499;5407.945920540744;5452.645578037414;5192.506711862443;5218.686878787209;5223.138182199895;5227.555657769132;5285.127953887642;5230.2677625131755;5232.136697444955;5238.973805131026;5250.317458730341;5308.893822123536;4338.934915976263;4401.977990110093;4448.332750087513;4452.844150454718;4455.888602784957;3866.903327416837;3899.1032062625754;3911.2568611963634;3943.0339566806315;3945.684345252373;4566.109608626286;4621.399218101626;4630.351750754897;4634.443866736014;4685.320628508847;5218.373795144607;5269.947300527022;5303.151495760737;5364.22218778275;5389.757460914268;4536;4578.03861189154;4581.541845815392;4592.517785632527;4595.241785105487;4743.217369134123;4765.1660959331975;4779;4780.856574302777;4815.711057336571;4899.093667671492;4920.532549407801;5063.594912406998;5073.644844860824;5126.69239845603;5251.317328747238;5325.387580428301;5328.254044433705;5359.785608575613;5394.649347792381;4984.277279794482;4998.525140111684;5000.824971125993;5033.597312214941;5084.059449001798;5181.870453238699;5226.555742761756;5244.580433565229;5256.868578285421;5269;5372.355317361941;5383.461653834585;5386.138217885276;5399.271098401666;5440.455954404528;5185.688858668341;5223.242629818731;5232.058229518723;5239.921401179062;5288.444713305202;5010.09818232707;5099.974500127476;5143.6399452037995;5162.457941916045;5231.424543300158;5069.543741063322;5081.669691470042;5085.160948443613;5116.437191908813;5175.378954525481;5173.92239116406;5178.119719647593;5205.375354957429;5223.216517522402;5224.555912747459;4983.950160498349;5020.3724534433195;5113.795448182031;5123.282740416419;5159.509846564571 04:33:04 INFO - PROCESS | 30167 | |1;ext.html;576.6424816613699;582.1297160744684;590.3742033444549;591.5947575910502;630.1083966187845;36183;40574.59425405745;40652.59347406525;40656.59343406565;40869.18261634773;40192.59807401925;40359.39460908089;40430;40523.59476405235;40581.39127913084;7768.06783186017;7896.289333959942;7923.049234091888;7937.404694647896;7980.3615710743;7809.180036096213;7933.048034235871;7934.404919631022;7966.800829979268;7968.721094761684;7942.761717148494;7990.960045199766;7996.64015119321;8003.039635243779;8033.959830200841;7885.526868387887;7923.643436045391;7940.2456766607365;7945.245201705829;7951.443398962075;7828.960855195744;7853.960730196312;7869.252421019994;7925.28672419485;7932.444728868982;38140.809295953346;38583;38818.417723734165;38875;38924;2720.5511090670016;3027.6366835979825;3066.064850220682;3194.297254603983;3208.1338038729414;27189.162077202345;28176.577351339747;28239.57640635392;28282.29294267639;28548.571771423445;3059.189314831571;3059.9847000765076;3486.877959271413;3602.4596310553366;3602.6757591816863;232992;233751;234290;234737;235586;31915.202119946724;32308.676913231036;32556.837215813768;32687;32692;34458.82770586131;34475.65524344725;34607.82696086504;34619.13452163665;34814.82592587021;13912.791308130387;13960.441582336796;14173.85826141746;14207.71584568303;14217.289135543182;11491;11686.123540734308;11690.649280521598;11699.941500292614;11728.179027467995;8051.355891528664;8071.152528984489;8093.595320233965;8138.308243799225;8173.79565510867;3133.248020475115;3158.7157155855625;3163.8259895705955;3172.5241213818113;3215.469447541176;805.3516918880357;912.9497877616794;920.6915683246053;944.254039308952;973.1922504321396;28226.576601350996;28770.712292877222;29017.56473652897;29697.406051879272;29706.108816735534;924.5100096948628;931.9860202096974;957.7701351675687;981.8527220916919;1005.7370915440259;14737.631559210891;14925.17911514877;15037.924810375878;15144.924275378553;15229.771553426708;119317;399767;400656.9474442038;403333;403920;50599.24101138486;51177;51225.74387128041;51245.743771280904;51268.743656282226;1162.2096974057554;1183.4615250061202;1194.4027986006997;1198.6763573835017;1198.7542553776454;25402.618960715972;26788.732112678623;27098.32254193661;27216.863915680296;27326.45347093087;44196.11607767762;44556.77721611371;44560.33159502675;44585.77707111444;44625.55374446344;274033;278427;279188;279240;279425;25812.741872581035;26134.738652613232;26150.476990460465;26179.34551636148;26188.8690556546;42976.57023429726;43711.12577748491;43906.56093439153;44598.10803783971;44956.77521612371;37833.243335133695;38035;38212.617873820906;38294.2341153181;38511.6148838508;37652;37904;38130.61869381271;38154;38426.807865960494;32208.516872246466;36627.816860915525;37289.067773305884;37392.13039348076;37696.05759855916;30478.542821857245;33287.33425331528;34936.65063349334;34959;35223.82388088043;25985.870070649526;26279.21162365132;26360.736392636594;26401.207963761117;26767.464650706486 04:33:04 INFO - PROCESS | 30167 | |2;jquery.html;368.3278017617847;370.81088644791157;374.34115955917576;380.8457574682255;381.89879681884304;16635.41776037839;16870;17920.910395448038;18019.459416217534;18060.909695451523;16956.3217471301;17682.64634707308;18072.18675159618;18083.276668933227;18203.453896383096;5202.8699282518055;5372.54333381663;5391.056565101111;5402.135658294654;5405.648632838873;5128.282040514331;5233.450487698794;5302.443243459439;5308.566686994509;5324.840254792362;5257.211418287268;5260;5264.210368444745;5297.682139071668;5300.575953923696;5022.6233032522705;5242.685438873642;5275.36695596529;5275.630705850592;5303.071962406563;4709.599684026862;4716.622670186412;4731.787069581843;4743.027679325764;4748.07412554552;17797.288108475645;20615.69076463854;22068.22761203366;22092.33722988313;22169.667454988186;1965.3023176772326;2040.8571400002006;2099.1078791513546;2157.169489746443;2199.9010044548036;13619.319034048358;14082.647933801634;14177.220252886087;14437.783433248405;14467.204303763288;1787.642471505704;1789.105447276362;1795.7126859702516;1803.2696757813108;1894.4222012286248;71821.64089179573;71904.28095719028;72109.27890721131;72206;72400.63799681021;9552.474613896302;9895.80208395828;10210.64262750815;10436.165106791439;10452.16382689383;14100.506482273071;14167.71664566703;14191.361388737325;14215.786763198561;14217.715645687029;7819.960900195576;7820.491668041559;7887.132415434297;7942.880856787153;8033.076196237507;7439.367653749492;7684.077910650758;7711.768646940601;7727.690892364242;7778.377729781604;6255.249370075529;6437.358473589298;6461.127747753993;6494.837629059217;6580.901286480706;1725.7066298729246;1806.4851517317502;1807.328221395204;1864.4965859217934;1901.91441385138;821.5194111444753;901.8376692195336;909.3634455880909;939.2673714502699;956.7990721948469;17601.03194324299;18175.182116804775;18543.35098271554;18618.348357807412;18730;858.1461445861407;907.5099446299057;907.5552979040223;926.5737760630051;947.7488465556632;10368;10756.838647420294;10762.3542587445;10835.458227088615;10838.78322433547;306917;313583;414843;416178;416590;56870;65632.67183664051;89016.10983890078;92668.53665731628;94257;930.4091901642371;940.8870935487786;959.5681943125621;967.1827305926481;969.8690676758688;16812.495625131265;17078.914605426893;17107.828921710625;17208.483745487654;17517.82482175213;39037.804810975766;39678.60321396864;40366.9908252296;41275;41879.37180942227;55973.44026559682;56603.71698141483;57696;58035;58866.41133588781;7744.612769361622;7804.609769511615;7990.280874721303;8005.439619226599;8129.959350203211;11485.885141148481;12176.147669663038;12355.567555135527;12404.441800118835;12496.625101246977;9394;9615.9038409615;9847.852282215916;9943.204543636348;10049.095581397709;10699.518521666389;10868;10937.398443085707;10970.945145274223;11028.338299702044;9099.954500227457;9371.344005919793;9458.243340532603;9585.329026968324;9824.214062875095;7887.979936705026;8062.34721882001;8090.433669643068;8197.590120494071;8223;8580.14198580162;9484;9777.071178238057;9777.560009799718;9900.158486528439 04:33:04 INFO - PROCESS | 30167 | |3;mootools.html;1357.2331632627565;1402.7334806386787;1501.6621260216446;1690.256287233618;1731.4632463936173;7008.614526201057;7729.11115221749;7772.41706871984;8269.751907442771;8318.126596707349;7814.687412503493;7964.0841303250145;8023.67905283788;8092.635831387587;8127.14664960178;2235.6087684655163;2263.309690544383;2274.7725227477204;2275.283285764987;2280.144945645383;2185.4645611825126;2213.5351576169023;2250.6173950428383;2252.4819291562867;2256.2103263857684;2246.382244882654;2253.9774602253933;2265.728112626487;2268.047420083569;2282.2126366403645;2188.124750099957;2190.87950162741;2192.375173075674;2205.283282933053;2205.9779402206013;2171.3811563704426;2180.90185941633;2185.115028413479;2185.5519618478334;2190.145843121184;8033.919660803375;8085.4340196186295;8093.959530202312;8136.47112937663;8173.019237691456;4620.537946205386;4672.556107169813;4692.389989301369;4717.457492388385;4761.0715910397485;2939.1476471823144;3133.9686603133905;3177.348643528071;3177.539256807773;3183.522471629274;938.6198589571235;972.2853702528636;992.3103443107043;994.9303548751591;1003.2074661017787;11033.889661103367;11086.833697494543;11089.944550277198;11090;11104.777904441866;3937.27160475313;4068.1253530491085;4219.78901054946;4231.915361692811;4246.511651160156;9393.5303234838;9458.527073646428;9472.95263523678;9495.240380769523;9517.857232141523;4716.410448693913;4725.881852953635;4732.02993386355;4736.502667219961;4745.715257084517;3775.9433608495897;4169;4301.139772045603;4312.676549258756;4324.113556720865;3628.618995005539;3702.3520883845217;3782;3799.145192331703;3806.71449641278;1169.9941500292443;1195.9940200298943;1209.1838009343658;1211.9091068169923;1213.7754515414676;815.8368326334756;817.1624085312602;835.9122292159358;844.1094645149426;844.8225872566829;5015.548600625962;5092.337996060489;5092.541671249532;5118.104346698731;5221.921671174935;413.9089400331922;424.87678573213424;431.38958373901204;432.5155825475488;433.21587925853675;3430.1596108953468;3467.4452087665854;3475.061733331986;3527.5061491391225;3530.947035794465;9685.41887486739;9863.852042219372;9926.65256716026;9986.550605222783;10085.193184545218;9642.951785241028;9903.306768526134;9914;9943.353682010646;9965.853926798365;7445.329920307198;7456.96271518639;7500.549967001997;7511.812204694927;7526.661300241502;5031.6729412588065;5038.420581633159;5095.694258344512;5117.565006974449;5158.839261166358;9106.317026222927;9137;9161.175494205287;9214.354995150543;9224.354295199271;8957.686480973134;9480.952595237255;9504.47725375111;9511.096445837635;9527.666531671359;6289.371062893674;6699.966500167663;6846.246912839484;6915.792526224222;7013.333733295329;7629.694812207672;7630.1606823248285;7641.579713115832;7699.692012319444;7704.884426733492;6970.512064155663;7169.426445884213;7188.173360063451;7219.639018048972;7275.818104547428;6758.831029224309;6991.615461149686;7063.293670633101;7176.031235783103;7200.927990720026;5683.914741278802;5957.136215248851;5961.523078153824;6009.248843894513;6031.75872965094;4485.05813779097;4561.452625684939;4606.976965115153;4651.906961860812;4735.905281894412;4496.168208881368;4556.567126123013;4608.769561521977;4625.838095666635;4640.396748422683 04:33:04 INFO - PROCESS | 30167 | |4;prototype.html;300.1371058207653;300.5791891352107;304.99085027449155;305.5874569331403;307.36529067475664;5184.429712731597;5188.7146206958605;5192.740362981855;5209.114450543402;5231.7122558259325;5105.234214867763;5115.462876397981;5127.436281859071;5141.434442211363;5160.638755287131;3786.242751449707;3913.158670885759;4003;4004.299247631667;4018.6985976051765;3992.7440995837405;4014.2974979378637;4017.156397156586;4045.5549889512276;4055.634992850643;4005.7396269242404;4013;4039.353703407455;4044.413560033793;4046.4941882264716;3739.607341229159;3946.3883098119836;3951.130751234724;4047.817848196838;4048.4939382577177;3435.879744208966;3441.5009823575692;3446.551948246737;3467;3469.9132521686906;4970.676906001135;5003.74981250936;5013.348264725599;5065.1895696688725;5080.898382032376;4256.680748943811;4547.727136371828;4552.8861778455475;4562.931556026662;4578.2903649934315;5374.462553744634;5377.1665391863935;5383.3890563076875;5387.467890091651;5421.132618780976;3767.585565587783;3781.1870447853566;3784.4701741756176;3788.6360910072353;3790.9620903790883;5405.7567409467065;5662.49037586615;5687.943120568782;5717.142428635696;5718;3827.8086095695103;3832.945939866559;3837.76973381598;3851.614838516182;3862.6909847212155;3902.239063382613;3904.7071469639322;3911.471951286597;3917.2557214129224;3927.5483319418063;4477.858146172705;4497.257952437811;4497.482789479252;4502.8649140525185;4540.205464043779;5214.947850521522;5386.8383948481605;5402.297701298806;5427.945720542823;5456.727163641882;1336.5990202939079;1339.4240476595157;1342.5837990223063;1345.6232254968625;1352.9797053044213;846.8221673448521;854.7649396415911;864.9524276164872;865.0916537635458;945.6595625574788;4626.629869610423;4658.673892827537;4730.746352216665;4738.50245724194;4745.098431298043;5497.835064948058;5530.364008139035;5547.278853749068;5552.666839989613;5563.5271001964475;4534.412955465561;4633.86098417048;4650.232711602548;4697.600703940203;4705.576498115118;2922.1233629910944;2929.5245517537646;2941.97058029417;2950.7196816302417;2951.5130003549175;5174.7153906535505;5188.325517682677;5191.740412979336;5217.147912491087;5232.110541208004;5463.562914966873;5592.664440133605;5605.691686957257;5630.493255607015;5638.887222255614;5190.53285204341;5195.92206116901;5233.764480598382;5268.2097685346735;5273.44628813969;5474.835754927359;5488.7530061148145;5506.256655351476;5564.749586268708;5568.749406276646;5144.6398752087;5521.641093328921;5533.335999680065;5540.252065971204;5561.277033985718;5340.252364668871;5361.785528578969;5363.5440987516495;5373.838784836461;5375.139977603565;3832.6742226911024;3907.843686252518;3931.4889064422587;3932.272529581922;3934.5835499219684;5617.915731264116;5645.237892884408;5698.401667824819;5701.315842098975;5706.942930570807;5492.670439773627;5494.587905906993;5496.31296087989;5517.172424136412;5528.612997090165;5379.946200538101;5457.481539253765;5477.67133971963;5485.780568777204;5503.834884953458;5393.43368946255;5404.459554044564;5408.215808707794;5415.2689386933835;5428.809991650273;5239.895202096013;5369;5473.412710313964;5526.198701188386;5565.1930470082425;5377.665847174777;5395.730213489388;5402.729863506887;5407.72918364192;5475.808346707846 04:33:04 INFO - PROCESS | 30167 | |5;yui.html;669.1835960128644;681.7034589953371;735.8234023834278;737.9815504612387;755.3088923634874;11272.210945233837;11858.584949526768;11865.644030679072;11940.7611847763;11946.880531194685;11526.596569120082;11898.345590992492;11930.224535405192;11939.880601193985;11943.223690460136;626.2328647406936;754.6717178027549;762.0702742653954;790.6046976511744;792.4571668407131;750.973715919943;754.4454825703103;756.667066490745;757.034780654667;760.9581473019009;794.1542257495748;799.9640016199285;800.4876878797575;802.2699343597328;803.337246771413;785.6817988714552;788.7239466186846;791.8574656561816;796.0924546017544;797.6889013284823;582.2081968522806;582.4437662032749;585.3648791061703;586.6099044135644;586.7330364684059;12187.085968552305;12208.32854193019;12238;12279.263244205287;12296.631101066982;12423.875761242361;12824.487020519167;12854.228746275254;12861.22832630036;13297.800532992012;9821.607135714563;9904.55429505674;9997.600095996151;10117.696469105938;10302.969703029712;3204.5834041574444;3211.1169428407143;3211.999920740274;3225.4033003894356;3257.7393808495262;58330.416695833344;61417.38582614206;61424.69287653533;61594;61674.38325616731;10057.899421005843;10177.745556361151;10214;10273.640422585324;10309.84535231972;16243.593910152103;16795.748063779054;16831.158442077845;18608;18639.627207456047;6653.800385988428;6815.659217039228;6844.4182244508775;6849.554778939353;6893.4140598048725;3457.22212502185;3548.8048157351077;3599.8200089995394;3624.7825130492256;3689.2990331836863;2903.7531809796405;2971.9257018574276;2991.1176203020163;2991.5064014437376;2996.550517422404;516.5299577384562;532.6457905492881;532.8135152696602;538.2437675066537;539.9784008639689;523.6543881038573;529.203548659273;557.2419017998222;568.5693659605221;580.4108829538022;7450.925490745131;7510.737124200736;7692.38460923136;7808.7657370278985;7949.205079492121;540.367769709441;576.1821453314799;589.0633892111563;617.7343742190901;621.9844503887349;3548.3967725486727;4084.65280451159;4250.596193361625;4322.092360604245;4530.501644819067;94885;104354.47822760837;104753;105753;109093.45453272683;52657;53016.20475692867;53424.198637020476;61912;87221;50113.498865011614;65183.34816651868;81338;81984.59007704923;82457.58771206105;8385.706500272461;8401.831963360577;8484.363672724694;8554.657813687383;8749.5187764671;46802.29796552986;47632.76183619198;47873;48243.5175648239;48571.27143092786;52689;54321;54835.72582137064;60795.392046078974;61569.692151538955;11267.56343808987;11738.70653233676;11893.870082342164;12020.939895300467;12177.634670959531;12440;12455.377231138225;12522.37388130608;12624.3687815607;12812.10315277959;10256.639719993214;10415.739606509595;11721.648350549498;11999.100067495147;12120.878791211975;10986.945065274622;11792.469338879942;11900.285982841056;12069.456874440846;12078.939605301917;11279.605213817476;11319.320840749582;11427.314361138358;11634.883651163718;11799.941000295286;9281.443113413217;9669.226461883172;9917.206623469961;10000.199984001409;10120.089191972758;8949.239314658327;9132.726018219464;9254.444733316022;9507.714768556954;9615.278854086111 04:33:04 INFO - PROCESS | 30167 | __end_tp_report 04:33:04 INFO - PROCESS | 30167 | __start_cc_report 04:33:04 INFO - PROCESS | 30167 | _x_x_mozilla_cycle_collect,400 04:33:04 INFO - PROCESS | 30167 | __end_cc_report 04:33:04 INFO - PROCESS | 30167 | __startTimestamp1467286384418__endTimestamp 04:33:04 INFO - PROCESS | 30167 | 04:33:04 INFO - PROCESS | 30167 | ------- Summary: start ------- 04:33:04 INFO - PROCESS | 30167 | Number of tests: 6 04:33:04 INFO - PROCESS | 30167 | 04:33:04 INFO - PROCESS | 30167 | [#0] dojo.html Cycles:165 Average:4891.35 Median:5063.59 stddev:625.45 (12.4%) stddev-sans-first:602.50 04:33:04 INFO - PROCESS | 30167 | Values: 2665.4 2713.4 2722.8 2738.6 2744.0 4841.7 4919.9 4962.3 4970.3 4983.5 4841.6 4903.7 4920.5 4962.7 4965.3 4510.6 4542.1 4574.3 4614.5 4648.5 4519.2 4549.5 4574.9 4605.9 4618.0 645.6 4582.1 4613.9 4662.3 4677.1 4551.7 4552.8 4591.7 4601.4 4609.3 4529.0 4538.3 4545.6 4581.2 4582.3 4820.6 4863.1 4928.1 4999.8 5007.6 5217.9 5266.5 5364.4 5446.5 5450.6 5405.5 5438.8 5440.0 5452.4 5454.3 5031.7 5038.6 5039.3 5048.7 5101.2 5388.2 5446.6 5461.3 5472.7 5511.8 5264.2 5286.9 5287.3 5288.7 5292.6 5201.9 5333.5 5405.3 5407.9 5452.6 5192.5 5218.7 5223.1 5227.6 5285.1 5230.3 5232.1 5239.0 5250.3 5308.9 4338.9 4402.0 4448.3 4452.8 4455.9 3866.9 3899.1 3911.3 3943.0 3945.7 4566.1 4621.4 4630.4 4634.4 4685.3 5218.4 5269.9 5303.2 5364.2 5389.8 4536.0 4578.0 4581.5 4592.5 4595.2 4743.2 4765.2 4779.0 4780.9 4815.7 4899.1 4920.5 5063.6 5073.6 5126.7 5251.3 5325.4 5328.3 5359.8 5394.6 4984.3 4998.5 5000.8 5033.6 5084.1 5181.9 5226.6 5244.6 5256.9 5269.0 5372.4 5383.5 5386.1 5399.3 5440.5 5185.7 5223.2 5232.1 5239.9 5288.4 5010.1 5100.0 5143.6 5162.5 5231.4 5069.5 5081.7 5085.2 5116.4 5175.4 5173.9 5178.1 5205.4 5223.2 5224.6 4984.0 5020.4 5113.8 5123.3 5159.5 04:33:04 INFO - PROCESS | 30167 | 04:33:04 INFO - PROCESS | 30167 | [#1] ext.html Cycles:180 Average:43545.58 Median:37340.60 stddev:78318.37 (209.7%) stddev-sans-first:78471.63 04:33:04 INFO - PROCESS | 30167 | Values: 576.6 582.1 590.4 591.6 630.1 36183.0 40574.6 40652.6 40656.6 40869.2 40192.6 40359.4 40430.0 40523.6 40581.4 7768.1 7896.3 7923.0 7937.4 7980.4 7809.2 7933.0 7934.4 7966.8 7968.7 7942.8 7991.0 7996.6 8003.0 8034.0 7885.5 7923.6 7940.2 7945.2 7951.4 7829.0 7854.0 7869.3 7925.3 7932.4 38140.8 38583.0 38818.4 38875.0 38924.0 2720.6 3027.6 3066.1 3194.3 3208.1 27189.2 28176.6 28239.6 28282.3 28548.6 3059.2 3060.0 3486.9 3602.5 3602.7 232992.0 233751.0 234290.0 234737.0 235586.0 31915.2 32308.7 32556.8 32687.0 32692.0 34458.8 34475.7 34607.8 34619.1 34814.8 13912.8 13960.4 14173.9 14207.7 14217.3 11491.0 11686.1 11690.6 11699.9 11728.2 8051.4 8071.2 8093.6 8138.3 8173.8 3133.2 3158.7 3163.8 3172.5 3215.5 805.4 912.9 920.7 944.3 973.2 28226.6 28770.7 29017.6 29697.4 29706.1 924.5 932.0 957.8 981.9 1005.7 14737.6 14925.2 15037.9 15144.9 15229.8 119317.0 399767.0 400656.9 403333.0 403920.0 50599.2 51177.0 51225.7 51245.7 51268.7 1162.2 1183.5 1194.4 1198.7 1198.8 25402.6 26788.7 27098.3 27216.9 27326.5 44196.1 44556.8 44560.3 44585.8 44625.6 274033.0 278427.0 279188.0 279240.0 279425.0 25812.7 26134.7 26150.5 26179.3 26188.9 42976.6 43711.1 43906.6 44598.1 44956.8 37833.2 38035.0 38212.6 38294.2 38511.6 37652.0 37904.0 38130.6 38154.0 38426.8 32208.5 36627.8 37289.1 37392.1 37696.1 30478.5 33287.3 34936.7 34959.0 35223.8 25985.9 26279.2 26360.7 26401.2 26767.5 04:33:04 INFO - PROCESS | 30167 | 04:33:04 INFO - PROCESS | 30167 | [#2] jquery.html Cycles:180 Average:24687.54 Median:5165.58 stddev:62613.50 (1212.1%) stddev-sans-first:62762.52 04:33:04 INFO - PROCESS | 30167 | Values: 368.3 370.8 374.3 380.8 381.9 16635.4 16870.0 17920.9 18019.5 18060.9 16956.3 17682.6 18072.2 18083.3 18203.5 5202.9 5372.5 5391.1 5402.1 5405.6 5128.3 5233.5 5302.4 5308.6 5324.8 5257.2 5260.0 5264.2 5297.7 5300.6 5022.6 5242.7 5275.4 5275.6 5303.1 4709.6 4716.6 4731.8 4743.0 4748.1 17797.3 20615.7 22068.2 22092.3 22169.7 1965.3 2040.9 2099.1 2157.2 2199.9 13619.3 14082.6 14177.2 14437.8 14467.2 1787.6 1789.1 1795.7 1803.3 1894.4 71821.6 71904.3 72109.3 72206.0 72400.6 9552.5 9895.8 10210.6 10436.2 10452.2 14100.5 14167.7 14191.4 14215.8 14217.7 7820.0 7820.5 7887.1 7942.9 8033.1 7439.4 7684.1 7711.8 7727.7 7778.4 6255.2 6437.4 6461.1 6494.8 6580.9 1725.7 1806.5 1807.3 1864.5 1901.9 821.5 901.8 909.4 939.3 956.8 17601.0 18175.2 18543.4 18618.3 18730.0 858.1 907.5 907.6 926.6 947.7 10368.0 10756.8 10762.4 10835.5 10838.8 306917.0 313583.0 414843.0 416178.0 416590.0 56870.0 65632.7 89016.1 92668.5 94257.0 930.4 940.9 959.6 967.2 969.9 16812.5 17078.9 17107.8 17208.5 17517.8 39037.8 39678.6 40367.0 41275.0 41879.4 55973.4 56603.7 57696.0 58035.0 58866.4 7744.6 7804.6 7990.3 8005.4 8130.0 11485.9 12176.1 12355.6 12404.4 12496.6 9394.0 9615.9 9847.9 9943.2 10049.1 10699.5 10868.0 10937.4 10970.9 11028.3 9100.0 9371.3 9458.2 9585.3 9824.2 7888.0 8062.3 8090.4 8197.6 8223.0 8580.1 9484.0 9777.1 9777.6 9900.2 04:33:04 INFO - PROCESS | 30167 | 04:33:04 INFO - PROCESS | 30167 | [#3] mootools.html Cycles:180 Average:5234.99 Median:4753.39 stddev:2996.10 (63.0%) stddev-sans-first:2990.34 04:33:04 INFO - PROCESS | 30167 | Values: 1357.2 1402.7 1501.7 1690.3 1731.5 7008.6 7729.1 7772.4 8269.8 8318.1 7814.7 7964.1 8023.7 8092.6 8127.1 2235.6 2263.3 2274.8 2275.3 2280.1 2185.5 2213.5 2250.6 2252.5 2256.2 2246.4 2254.0 2265.7 2268.0 2282.2 2188.1 2190.9 2192.4 2205.3 2206.0 2171.4 2180.9 2185.1 2185.6 2190.1 8033.9 8085.4 8094.0 8136.5 8173.0 4620.5 4672.6 4692.4 4717.5 4761.1 2939.1 3134.0 3177.3 3177.5 3183.5 938.6 972.3 992.3 994.9 1003.2 11033.9 11086.8 11089.9 11090.0 11104.8 3937.3 4068.1 4219.8 4231.9 4246.5 9393.5 9458.5 9473.0 9495.2 9517.9 4716.4 4725.9 4732.0 4736.5 4745.7 3775.9 4169.0 4301.1 4312.7 4324.1 3628.6 3702.4 3782.0 3799.1 3806.7 1170.0 1196.0 1209.2 1211.9 1213.8 815.8 817.2 835.9 844.1 844.8 5015.5 5092.3 5092.5 5118.1 5221.9 413.9 424.9 431.4 432.5 433.2 3430.2 3467.4 3475.1 3527.5 3530.9 9685.4 9863.9 9926.7 9986.6 10085.2 9643.0 9903.3 9914.0 9943.4 9965.9 7445.3 7457.0 7500.5 7511.8 7526.7 5031.7 5038.4 5095.7 5117.6 5158.8 9106.3 9137.0 9161.2 9214.4 9224.4 8957.7 9481.0 9504.5 9511.1 9527.7 6289.4 6700.0 6846.2 6915.8 7013.3 7629.7 7630.2 7641.6 7699.7 7704.9 6970.5 7169.4 7188.2 7219.6 7275.8 6758.8 6991.6 7063.3 7176.0 7200.9 5683.9 5957.1 5961.5 6009.2 6031.8 4485.1 4561.5 4607.0 4651.9 4735.9 4496.2 4556.6 4608.8 4625.8 4640.4 04:33:04 INFO - PROCESS | 30167 | 04:33:04 INFO - PROCESS | 30167 | [#4] prototype.html Cycles:180 Average:4478.20 Median:5167.68 stddev:1326.31 (25.7%) stddev-sans-first:1292.42 04:33:04 INFO - PROCESS | 30167 | Values: 300.1 300.6 305.0 305.6 307.4 5184.4 5188.7 5192.7 5209.1 5231.7 5105.2 5115.5 5127.4 5141.4 5160.6 3786.2 3913.2 4003.0 4004.3 4018.7 3992.7 4014.3 4017.2 4045.6 4055.6 4005.7 4013.0 4039.4 4044.4 4046.5 3739.6 3946.4 3951.1 4047.8 4048.5 3435.9 3441.5 3446.6 3467.0 3469.9 4970.7 5003.7 5013.3 5065.2 5080.9 4256.7 4547.7 4552.9 4562.9 4578.3 5374.5 5377.2 5383.4 5387.5 5421.1 3767.6 3781.2 3784.5 3788.6 3791.0 5405.8 5662.5 5687.9 5717.1 5718.0 3827.8 3832.9 3837.8 3851.6 3862.7 3902.2 3904.7 3911.5 3917.3 3927.5 4477.9 4497.3 4497.5 4502.9 4540.2 5214.9 5386.8 5402.3 5427.9 5456.7 1336.6 1339.4 1342.6 1345.6 1353.0 846.8 854.8 865.0 865.1 945.7 4626.6 4658.7 4730.7 4738.5 4745.1 5497.8 5530.4 5547.3 5552.7 5563.5 4534.4 4633.9 4650.2 4697.6 4705.6 2922.1 2929.5 2942.0 2950.7 2951.5 5174.7 5188.3 5191.7 5217.1 5232.1 5463.6 5592.7 5605.7 5630.5 5638.9 5190.5 5195.9 5233.8 5268.2 5273.4 5474.8 5488.8 5506.3 5564.7 5568.7 5144.6 5521.6 5533.3 5540.3 5561.3 5340.3 5361.8 5363.5 5373.8 5375.1 3832.7 3907.8 3931.5 3932.3 3934.6 5617.9 5645.2 5698.4 5701.3 5706.9 5492.7 5494.6 5496.3 5517.2 5528.6 5379.9 5457.5 5477.7 5485.8 5503.8 5393.4 5404.5 5408.2 5415.3 5428.8 5239.9 5369.0 5473.4 5526.2 5565.2 5377.7 5395.7 5402.7 5407.7 5475.8 04:33:04 INFO - PROCESS | 30167 | 04:33:04 INFO - PROCESS | 30167 | [#5] yui.html Cycles:180 Average:16961.19 Median:26590.33 stddev:24360.00 (91.6%) stddev-sans-first:24397.62 04:33:04 INFO - PROCESS | 30167 | Values: 669.2 681.7 735.8 738.0 755.3 11272.2 11858.6 11865.6 11940.8 11946.9 11526.6 11898.3 11930.2 11939.9 11943.2 626.2 754.7 762.1 790.6 792.5 751.0 754.4 756.7 757.0 761.0 794.2 800.0 800.5 802.3 803.3 785.7 788.7 791.9 796.1 797.7 582.2 582.4 585.4 586.6 586.7 12187.1 12208.3 12238.0 12279.3 12296.6 12423.9 12824.5 12854.2 12861.2 13297.8 9821.6 9904.6 9997.6 10117.7 10303.0 3204.6 3211.1 3212.0 3225.4 3257.7 58330.4 61417.4 61424.7 61594.0 61674.4 10057.9 10177.7 10214.0 10273.6 10309.8 16243.6 16795.7 16831.2 18608.0 18639.6 6653.8 6815.7 6844.4 6849.6 6893.4 3457.2 3548.8 3599.8 3624.8 3689.3 2903.8 2971.9 2991.1 2991.5 2996.6 516.5 532.6 532.8 538.2 540.0 523.7 529.2 557.2 568.6 580.4 7450.9 7510.7 7692.4 7808.8 7949.2 540.4 576.2 589.1 617.7 622.0 3548.4 4084.7 4250.6 4322.1 4530.5 94885.0 104354.5 104753.0 105753.0 109093.5 52657.0 53016.2 53424.2 61912.0 87221.0 50113.5 65183.3 81338.0 81984.6 82457.6 8385.7 8401.8 8484.4 8554.7 8749.5 46802.3 47632.8 47873.0 48243.5 48571.3 52689.0 54321.0 54835.7 60795.4 61569.7 11267.6 11738.7 11893.9 12020.9 12177.6 12440.0 12455.4 12522.4 12624.4 12812.1 10256.6 10415.7 11721.6 11999.1 12120.9 10986.9 11792.5 11900.3 12069.5 12078.9 11279.6 11319.3 11427.3 11634.9 11799.9 9281.4 9669.2 9917.2 10000.2 10120.1 8949.2 9132.7 9254.4 9507.7 9615.3 04:33:04 INFO - PROCESS | 30167 | -------- Summary: end -------- 04:33:04 INFO - PROCESS | 30167 | 04:33:05 INFO - TEST-INFO | 30167: exit 0 04:33:05 INFO - TEST-OK | dromaeo_css | took 1116832ms 04:33:05 INFO - TEST-START | kraken 04:33:05 INFO - operating with platform_type : linux_ 04:33:05 INFO - Initialising browser for kraken test... 04:33:05 INFO - TEST-INFO | started process 30405 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHrneHQ/profile http://localhost:56180/getInfo.html) 04:33:10 INFO - PROCESS | 30405 | __metrics Screen width/height:1600/1200 04:33:10 INFO - PROCESS | 30405 | colorDepth:24 04:33:10 INFO - PROCESS | 30405 | Browser inner width/height: 1024/697 04:33:10 INFO - PROCESS | 30405 | __metrics 04:33:10 ERROR - PROCESS | 30405 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 04:33:11 INFO - TEST-INFO | 30405: exit 0 04:33:11 INFO - Browser initialized. 04:33:11 INFO - Running cycle 1/1 for kraken test... 04:33:11 INFO - TEST-INFO | started process 30523 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHrneHQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:23 INFO - PROCESS | 30523 | RSS: Main: 170217472 04:33:23 INFO - PROCESS | 30523 | 04:33:26 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56180/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:27 INFO - PROCESS | 30523 | RSS: Main: 175173632 04:33:27 INFO - PROCESS | 30523 | 04:33:30 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56180/tests/kraken/driver.html?testName=audio-dft) 04:33:30 INFO - PROCESS | 30523 | RSS: Main: 175468544 04:33:30 INFO - PROCESS | 30523 | 04:33:33 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56180/tests/kraken/driver.html?testName=audio-fft) 04:33:34 INFO - PROCESS | 30523 | RSS: Main: 169869312 04:33:34 INFO - PROCESS | 30523 | 04:33:36 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56180/tests/kraken/driver.html?testName=audio-oscillator) 04:33:37 INFO - PROCESS | 30523 | RSS: Main: 170360832 04:33:37 INFO - PROCESS | 30523 | 04:33:39 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56180/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:39 INFO - PROCESS | 30523 | RSS: Main: 170655744 04:33:39 INFO - PROCESS | 30523 | 04:33:43 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56180/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:43 INFO - PROCESS | 30523 | RSS: Main: 170840064 04:33:43 INFO - PROCESS | 30523 | 04:33:47 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56180/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:47 INFO - PROCESS | 30523 | RSS: Main: 168198144 04:33:47 INFO - PROCESS | 30523 | 04:33:50 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56180/tests/kraken/driver.html?testName=json-parse-financial) 04:33:51 INFO - PROCESS | 30523 | RSS: Main: 169844736 04:33:51 INFO - PROCESS | 30523 | 04:33:53 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56180/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:53 INFO - PROCESS | 30523 | RSS: Main: 170061824 04:33:53 INFO - PROCESS | 30523 | 04:33:55 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:56 INFO - PROCESS | 30523 | RSS: Main: 170176512 04:33:56 INFO - PROCESS | 30523 | 04:33:58 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:33:59 INFO - PROCESS | 30523 | RSS: Main: 170745856 04:33:59 INFO - PROCESS | 30523 | 04:34:02 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:02 INFO - PROCESS | 30523 | RSS: Main: 170852352 04:34:02 INFO - PROCESS | 30523 | 04:34:05 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:06 INFO - PROCESS | 30523 | RSS: Main: 170188800 04:34:06 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | Cycle 1(1): loaded http://localhost:56180/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56180/tests/kraken/driver.html?testName=ai-astar) 04:34:08 INFO - PROCESS | 30523 | RSS: Main: 171425792 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | __start_tp_report 04:34:08 INFO - PROCESS | 30523 | _x_x_mozilla_page_load 04:34:08 INFO - PROCESS | 30523 | _x_x_mozilla_page_load_details 04:34:08 INFO - PROCESS | 30523 | |i|pagename|runs| 04:34:08 INFO - PROCESS | 30523 | |0;ai-astar;106;114;106;113;114;118;117;115;112;115 04:34:08 INFO - PROCESS | 30523 | |1;audio-beat-detection;153;123;147;179;125;150;154;126;180;123 04:34:08 INFO - PROCESS | 30523 | |2;audio-dft;164;165;162;163;172;163;163;164;162;163 04:34:08 INFO - PROCESS | 30523 | |3;audio-fft;75;75;75;150;77;76;75;76;162;79 04:34:08 INFO - PROCESS | 30523 | |4;audio-oscillator;86;86;146;86;87;86;135;85;85;138 04:34:08 INFO - PROCESS | 30523 | |5;imaging-gaussian-blur;118;118;118;117;117;118;118;118;118;117 04:34:08 INFO - PROCESS | 30523 | |6;imaging-darkroom;147;148;149;148;147;148;148;147;150;147 04:34:08 INFO - PROCESS | 30523 | |7;imaging-desaturate;95;96;95;95;100;95;96;95;94;94 04:34:08 INFO - PROCESS | 30523 | |8;json-parse-financial;67;66;67;65;65;65;67;65;64;64 04:34:08 INFO - PROCESS | 30523 | |9;json-stringify-tinderbox;64;66;64;65;65;66;65;65;65;65 04:34:08 INFO - PROCESS | 30523 | |10;stanford-crypto-aes;81;80;79;85;83;84;79;79;84;78 04:34:08 INFO - PROCESS | 30523 | |11;stanford-crypto-ccm;142;133;141;131;133;138;128;133;161;150 04:34:08 INFO - PROCESS | 30523 | |12;stanford-crypto-pbkdf2;163;173;175;165;164;168;168;174;170;174 04:34:08 INFO - PROCESS | 30523 | |13;stanford-crypto-sha256-iterative;67;67;69;70;69;67;68;75;66;71 04:34:08 INFO - PROCESS | 30523 | __end_tp_report 04:34:08 INFO - PROCESS | 30523 | __start_cc_report 04:34:08 INFO - PROCESS | 30523 | _x_x_mozilla_cycle_collect,984 04:34:08 INFO - PROCESS | 30523 | __end_cc_report 04:34:08 INFO - PROCESS | 30523 | __startTimestamp1467286448284__endTimestamp 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | ------- Summary: start ------- 04:34:08 INFO - PROCESS | 30523 | Number of tests: 14 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#0] ai-astar Cycles:10 Average:113.00 Median:114.50 stddev:4.08 (3.6%) stddev-sans-first:3.46 04:34:08 INFO - PROCESS | 30523 | Values: 106.0 114.0 106.0 113.0 114.0 118.0 117.0 115.0 112.0 115.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:151.50 stddev:21.79 (14.4%) stddev-sans-first:22.97 04:34:08 INFO - PROCESS | 30523 | Values: 153.0 123.0 147.0 179.0 125.0 150.0 154.0 126.0 180.0 123.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#2] audio-dft Cycles:10 Average:164.10 Median:163.50 stddev:2.92 (1.8%) stddev-sans-first:3.10 04:34:08 INFO - PROCESS | 30523 | Values: 164.0 165.0 162.0 163.0 172.0 163.0 163.0 164.0 162.0 163.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#3] audio-fft Cycles:10 Average:92.00 Median:75.50 stddev:33.87 (44.9%) stddev-sans-first:35.36 04:34:08 INFO - PROCESS | 30523 | Values: 75.0 75.0 75.0 150.0 77.0 76.0 75.0 76.0 162.0 79.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:86.00 stddev:26.14 (30.4%) stddev-sans-first:27.07 04:34:08 INFO - PROCESS | 30523 | Values: 86.0 86.0 146.0 86.0 87.0 86.0 135.0 85.0 85.0 138.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#5] imaging-gaussian-blur Cycles:10 Average:117.70 Median:118.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:34:08 INFO - PROCESS | 30523 | Values: 118.0 118.0 118.0 117.0 117.0 118.0 118.0 118.0 118.0 117.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#6] imaging-darkroom Cycles:10 Average:147.90 Median:148.00 stddev:0.99 (0.7%) stddev-sans-first:1.00 04:34:08 INFO - PROCESS | 30523 | Values: 147.0 148.0 149.0 148.0 147.0 148.0 148.0 147.0 150.0 147.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#7] imaging-desaturate Cycles:10 Average:95.50 Median:95.00 stddev:1.72 (1.8%) stddev-sans-first:1.81 04:34:08 INFO - PROCESS | 30523 | Values: 95.0 96.0 95.0 95.0 100.0 95.0 96.0 95.0 94.0 94.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#8] json-parse-financial Cycles:10 Average:65.50 Median:65.50 stddev:1.18 (1.8%) stddev-sans-first:1.12 04:34:08 INFO - PROCESS | 30523 | Values: 67.0 66.0 67.0 65.0 65.0 65.0 67.0 65.0 64.0 64.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.60 04:34:08 INFO - PROCESS | 30523 | Values: 64.0 66.0 64.0 65.0 65.0 66.0 65.0 65.0 65.0 65.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:82.00 stddev:2.57 (3.1%) stddev-sans-first:2.73 04:34:08 INFO - PROCESS | 30523 | Values: 81.0 80.0 79.0 85.0 83.0 84.0 79.0 79.0 84.0 78.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#11] stanford-crypto-ccm Cycles:10 Average:139.00 Median:139.50 stddev:10.07 (7.2%) stddev-sans-first:10.62 04:34:08 INFO - PROCESS | 30523 | Values: 142.0 133.0 141.0 131.0 133.0 138.0 128.0 133.0 161.0 150.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.40 Median:171.50 stddev:4.48 (2.6%) stddev-sans-first:4.11 04:34:08 INFO - PROCESS | 30523 | Values: 163.0 173.0 175.0 165.0 164.0 168.0 168.0 174.0 170.0 174.0 04:34:08 INFO - PROCESS | 30523 | 04:34:08 INFO - PROCESS | 30523 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:2.64 (3.8%) stddev-sans-first:2.71 04:34:08 INFO - PROCESS | 30523 | Values: 67.0 67.0 69.0 70.0 69.0 67.0 68.0 75.0 66.0 71.0 04:34:08 INFO - PROCESS | 30523 | -------- Summary: end -------- 04:34:08 INFO - PROCESS | 30523 | 04:34:09 INFO - TEST-INFO | 30523: exit 0 04:34:09 INFO - TEST-OK | kraken | took 64141ms 04:34:09 INFO - SUITE-END | took 1180s 04:34:09 INFO - Completed test suite (00:19:41) 04:34:09 INFO - javascript benchmark 04:34:09 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6471.94145550443, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2665.4402575459153, 2713.3623598454346, 2722.782177425807, 2738.6302849115364, 2743.9725602743965, 4841.709497430156, 4919.852404427868, 4962.305277261182, 4970.279309500121, 4983.451820299764, 4841.56425921667, 4903.730294833792, 4920.458749537548, 4962.702237865721, 4965.3048573199785, 4510.639148868091, 4542.136993971135, 4574.336721175428, 4614.515475875019, 4648.48866624671, 4519.2317306057885, 4549.476810166823, 4574.908501829961, 4605.907881842361, 4618.0, 645.5978469819304, 4582.083583283324, 4613.930791038137, 4662.300654901758, 4677.087967846272, 4551.658625603093, 4552.840650577214, 4591.724496530219, 4601.401817763669, 4609.308603709471, 4528.954710452919, 4538.273876179828, 4545.568171023748, 4581.2440947243995, 4582.312653102062, 4820.566149046603, 4863.076015557032, 4928.088303663833, 4999.775010124553, 5007.649464537484, 5217.895642087137, 5266.4733526647415, 5364.409914909357, 5446.537044351235, 5450.645708028966, 5405.486478784509, 5438.782448702047, 5440.047991601454, 5452.372977107644, 5454.290942177531, 5031.723255220962, 5038.5969122470115, 5039.269305950616, 5048.72232027242, 5101.20931255656, 5388.164834450667, 5446.564274858002, 5461.344638643388, 5472.699001554953, 5511.751971161308, 5264.184051472028, 5286.867828304246, 5287.339082614673, 5288.65623734456, 5292.576593872481, 5201.947980520222, 5333.519983201453, 5405.297311349499, 5407.945920540744, 5452.645578037414, 5192.506711862443, 5218.686878787209, 5223.138182199895, 5227.555657769132, 5285.127953887642, 5230.2677625131755, 5232.136697444955, 5238.973805131026, 5250.317458730341, 5308.893822123536, 4338.934915976263, 4401.977990110093, 4448.332750087513, 4452.844150454718, 4455.888602784957, 3866.903327416837, 3899.1032062625754, 3911.2568611963634, 3943.0339566806315, 3945.684345252373, 4566.109608626286, 4621.399218101626, 4630.351750754897, 4634.443866736014, 4685.320628508847, 5218.373795144607, 5269.947300527022, 5303.151495760737, 5364.22218778275, 5389.757460914268, 4536.0, 4578.03861189154, 4581.541845815392, 4592.517785632527, 4595.241785105487, 4743.217369134123, 4765.1660959331975, 4779.0, 4780.856574302777, 4815.711057336571, 4899.093667671492, 4920.532549407801, 5063.594912406998, 5073.644844860824, 5126.69239845603, 5251.317328747238, 5325.387580428301, 5328.254044433705, 5359.785608575613, 5394.649347792381, 4984.277279794482, 4998.525140111684, 5000.824971125993, 5033.597312214941, 5084.059449001798, 5181.870453238699, 5226.555742761756, 5244.580433565229, 5256.868578285421, 5269.0, 5372.355317361941, 5383.461653834585, 5386.138217885276, 5399.271098401666, 5440.455954404528, 5185.688858668341, 5223.242629818731, 5232.058229518723, 5239.921401179062, 5288.444713305202, 5010.09818232707, 5099.974500127476, 5143.6399452037995, 5162.457941916045, 5231.424543300158, 5069.543741063322, 5081.669691470042, 5085.160948443613, 5116.437191908813, 5175.378954525481, 5173.92239116406, 5178.119719647593, 5205.375354957429, 5223.216517522402, 5224.555912747459, 4983.950160498349, 5020.3724534433195, 5113.795448182031, 5123.282740416419, 5159.509846564571], "value": 4852.522047038043, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [576.6424816613699, 582.1297160744684, 590.3742033444549, 591.5947575910502, 630.1083966187845, 36183.0, 40574.59425405745, 40652.59347406525, 40656.59343406565, 40869.18261634773, 40192.59807401925, 40359.39460908089, 40430.0, 40523.59476405235, 40581.39127913084, 7768.06783186017, 7896.289333959942, 7923.049234091888, 7937.404694647896, 7980.3615710743, 7809.180036096213, 7933.048034235871, 7934.404919631022, 7966.800829979268, 7968.721094761684, 7942.761717148494, 7990.960045199766, 7996.64015119321, 8003.039635243779, 8033.959830200841, 7885.526868387887, 7923.643436045391, 7940.2456766607365, 7945.245201705829, 7951.443398962075, 7828.960855195744, 7853.960730196312, 7869.252421019994, 7925.28672419485, 7932.444728868982, 38140.809295953346, 38583.0, 38818.417723734165, 38875.0, 38924.0, 2720.5511090670016, 3027.6366835979825, 3066.064850220682, 3194.297254603983, 3208.1338038729414, 27189.162077202345, 28176.577351339747, 28239.57640635392, 28282.29294267639, 28548.571771423445, 3059.189314831571, 3059.9847000765076, 3486.877959271413, 3602.4596310553366, 3602.6757591816863, 232992.0, 233751.0, 234290.0, 234737.0, 235586.0, 31915.202119946724, 32308.676913231036, 32556.837215813768, 32687.0, 32692.0, 34458.82770586131, 34475.65524344725, 34607.82696086504, 34619.13452163665, 34814.82592587021, 13912.791308130387, 13960.441582336796, 14173.85826141746, 14207.71584568303, 14217.289135543182, 11491.0, 11686.123540734308, 11690.649280521598, 11699.941500292614, 11728.179027467995, 8051.355891528664, 8071.152528984489, 8093.595320233965, 8138.308243799225, 8173.79565510867, 3133.248020475115, 3158.7157155855625, 3163.8259895705955, 3172.5241213818113, 3215.469447541176, 805.3516918880357, 912.9497877616794, 920.6915683246053, 944.254039308952, 973.1922504321396, 28226.576601350996, 28770.712292877222, 29017.56473652897, 29697.406051879272, 29706.108816735534, 924.5100096948628, 931.9860202096974, 957.7701351675687, 981.8527220916919, 1005.7370915440259, 14737.631559210891, 14925.17911514877, 15037.924810375878, 15144.924275378553, 15229.771553426708, 119317.0, 399767.0, 400656.9474442038, 403333.0, 403920.0, 50599.24101138486, 51177.0, 51225.74387128041, 51245.743771280904, 51268.743656282226, 1162.2096974057554, 1183.4615250061202, 1194.4027986006997, 1198.6763573835017, 1198.7542553776454, 25402.618960715972, 26788.732112678623, 27098.32254193661, 27216.863915680296, 27326.45347093087, 44196.11607767762, 44556.77721611371, 44560.33159502675, 44585.77707111444, 44625.55374446344, 274033.0, 278427.0, 279188.0, 279240.0, 279425.0, 25812.741872581035, 26134.738652613232, 26150.476990460465, 26179.34551636148, 26188.8690556546, 42976.57023429726, 43711.12577748491, 43906.56093439153, 44598.10803783971, 44956.77521612371, 37833.243335133695, 38035.0, 38212.617873820906, 38294.2341153181, 38511.6148838508, 37652.0, 37904.0, 38130.61869381271, 38154.0, 38426.807865960494, 32208.516872246466, 36627.816860915525, 37289.067773305884, 37392.13039348076, 37696.05759855916, 30478.542821857245, 33287.33425331528, 34936.65063349334, 34959.0, 35223.82388088043, 25985.870070649526, 26279.21162365132, 26360.736392636594, 26401.207963761117, 26767.464650706486], "value": 16388.587174916447, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [368.3278017617847, 370.81088644791157, 374.34115955917576, 380.8457574682255, 381.89879681884304, 16635.41776037839, 16870.0, 17920.910395448038, 18019.459416217534, 18060.909695451523, 16956.3217471301, 17682.64634707308, 18072.18675159618, 18083.276668933227, 18203.453896383096, 5202.8699282518055, 5372.54333381663, 5391.056565101111, 5402.135658294654, 5405.648632838873, 5128.282040514331, 5233.450487698794, 5302.443243459439, 5308.566686994509, 5324.840254792362, 5257.211418287268, 5260.0, 5264.210368444745, 5297.682139071668, 5300.575953923696, 5022.6233032522705, 5242.685438873642, 5275.36695596529, 5275.630705850592, 5303.071962406563, 4709.599684026862, 4716.622670186412, 4731.787069581843, 4743.027679325764, 4748.07412554552, 17797.288108475645, 20615.69076463854, 22068.22761203366, 22092.33722988313, 22169.667454988186, 1965.3023176772326, 2040.8571400002006, 2099.1078791513546, 2157.169489746443, 2199.9010044548036, 13619.319034048358, 14082.647933801634, 14177.220252886087, 14437.783433248405, 14467.204303763288, 1787.642471505704, 1789.105447276362, 1795.7126859702516, 1803.2696757813108, 1894.4222012286248, 71821.64089179573, 71904.28095719028, 72109.27890721131, 72206.0, 72400.63799681021, 9552.474613896302, 9895.80208395828, 10210.64262750815, 10436.165106791439, 10452.16382689383, 14100.506482273071, 14167.71664566703, 14191.361388737325, 14215.786763198561, 14217.715645687029, 7819.960900195576, 7820.491668041559, 7887.132415434297, 7942.880856787153, 8033.076196237507, 7439.367653749492, 7684.077910650758, 7711.768646940601, 7727.690892364242, 7778.377729781604, 6255.249370075529, 6437.358473589298, 6461.127747753993, 6494.837629059217, 6580.901286480706, 1725.7066298729246, 1806.4851517317502, 1807.328221395204, 1864.4965859217934, 1901.91441385138, 821.5194111444753, 901.8376692195336, 909.3634455880909, 939.2673714502699, 956.7990721948469, 17601.03194324299, 18175.182116804775, 18543.35098271554, 18618.348357807412, 18730.0, 858.1461445861407, 907.5099446299057, 907.5552979040223, 926.5737760630051, 947.7488465556632, 10368.0, 10756.838647420294, 10762.3542587445, 10835.458227088615, 10838.78322433547, 306917.0, 313583.0, 414843.0, 416178.0, 416590.0, 56870.0, 65632.67183664051, 89016.10983890078, 92668.53665731628, 94257.0, 930.4091901642371, 940.8870935487786, 959.5681943125621, 967.1827305926481, 969.8690676758688, 16812.495625131265, 17078.914605426893, 17107.828921710625, 17208.483745487654, 17517.82482175213, 39037.804810975766, 39678.60321396864, 40366.9908252296, 41275.0, 41879.37180942227, 55973.44026559682, 56603.71698141483, 57696.0, 58035.0, 58866.41133588781, 7744.612769361622, 7804.609769511615, 7990.280874721303, 8005.439619226599, 8129.959350203211, 11485.885141148481, 12176.147669663038, 12355.567555135527, 12404.441800118835, 12496.625101246977, 9394.0, 9615.9038409615, 9847.852282215916, 9943.204543636348, 10049.095581397709, 10699.518521666389, 10868.0, 10937.398443085707, 10970.945145274223, 11028.338299702044, 9099.954500227457, 9371.344005919793, 9458.243340532603, 9585.329026968324, 9824.214062875095, 7887.979936705026, 8062.34721882001, 8090.433669643068, 8197.590120494071, 8223.0, 8580.14198580162, 9484.0, 9777.071178238057, 9777.560009799718, 9900.158486528439], "value": 8626.57153624438, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1357.2331632627565, 1402.7334806386787, 1501.6621260216446, 1690.256287233618, 1731.4632463936173, 7008.614526201057, 7729.11115221749, 7772.41706871984, 8269.751907442771, 8318.126596707349, 7814.687412503493, 7964.0841303250145, 8023.67905283788, 8092.635831387587, 8127.14664960178, 2235.6087684655163, 2263.309690544383, 2274.7725227477204, 2275.283285764987, 2280.144945645383, 2185.4645611825126, 2213.5351576169023, 2250.6173950428383, 2252.4819291562867, 2256.2103263857684, 2246.382244882654, 2253.9774602253933, 2265.728112626487, 2268.047420083569, 2282.2126366403645, 2188.124750099957, 2190.87950162741, 2192.375173075674, 2205.283282933053, 2205.9779402206013, 2171.3811563704426, 2180.90185941633, 2185.115028413479, 2185.5519618478334, 2190.145843121184, 8033.919660803375, 8085.4340196186295, 8093.959530202312, 8136.47112937663, 8173.019237691456, 4620.537946205386, 4672.556107169813, 4692.389989301369, 4717.457492388385, 4761.0715910397485, 2939.1476471823144, 3133.9686603133905, 3177.348643528071, 3177.539256807773, 3183.522471629274, 938.6198589571235, 972.2853702528636, 992.3103443107043, 994.9303548751591, 1003.2074661017787, 11033.889661103367, 11086.833697494543, 11089.944550277198, 11090.0, 11104.777904441866, 3937.27160475313, 4068.1253530491085, 4219.78901054946, 4231.915361692811, 4246.511651160156, 9393.5303234838, 9458.527073646428, 9472.95263523678, 9495.240380769523, 9517.857232141523, 4716.410448693913, 4725.881852953635, 4732.02993386355, 4736.502667219961, 4745.715257084517, 3775.9433608495897, 4169.0, 4301.139772045603, 4312.676549258756, 4324.113556720865, 3628.618995005539, 3702.3520883845217, 3782.0, 3799.145192331703, 3806.71449641278, 1169.9941500292443, 1195.9940200298943, 1209.1838009343658, 1211.9091068169923, 1213.7754515414676, 815.8368326334756, 817.1624085312602, 835.9122292159358, 844.1094645149426, 844.8225872566829, 5015.548600625962, 5092.337996060489, 5092.541671249532, 5118.104346698731, 5221.921671174935, 413.9089400331922, 424.87678573213424, 431.38958373901204, 432.5155825475488, 433.21587925853675, 3430.1596108953468, 3467.4452087665854, 3475.061733331986, 3527.5061491391225, 3530.947035794465, 9685.41887486739, 9863.852042219372, 9926.65256716026, 9986.550605222783, 10085.193184545218, 9642.951785241028, 9903.306768526134, 9914.0, 9943.353682010646, 9965.853926798365, 7445.329920307198, 7456.96271518639, 7500.549967001997, 7511.812204694927, 7526.661300241502, 5031.6729412588065, 5038.420581633159, 5095.694258344512, 5117.565006974449, 5158.839261166358, 9106.317026222927, 9137.0, 9161.175494205287, 9214.354995150543, 9224.354295199271, 8957.686480973134, 9480.952595237255, 9504.47725375111, 9511.096445837635, 9527.666531671359, 6289.371062893674, 6699.966500167663, 6846.246912839484, 6915.792526224222, 7013.333733295329, 7629.694812207672, 7630.1606823248285, 7641.579713115832, 7699.692012319444, 7704.884426733492, 6970.512064155663, 7169.426445884213, 7188.173360063451, 7219.639018048972, 7275.818104547428, 6758.831029224309, 6991.615461149686, 7063.293670633101, 7176.031235783103, 7200.927990720026, 5683.914741278802, 5957.136215248851, 5961.523078153824, 6009.248843894513, 6031.75872965094, 4485.05813779097, 4561.452625684939, 4606.976965115153, 4651.906961860812, 4735.905281894412, 4496.168208881368, 4556.567126123013, 4608.769561521977, 4625.838095666635, 4640.396748422683], "value": 4136.457122144346, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [300.1371058207653, 300.5791891352107, 304.99085027449155, 305.5874569331403, 307.36529067475664, 5184.429712731597, 5188.7146206958605, 5192.740362981855, 5209.114450543402, 5231.7122558259325, 5105.234214867763, 5115.462876397981, 5127.436281859071, 5141.434442211363, 5160.638755287131, 3786.242751449707, 3913.158670885759, 4003.0, 4004.299247631667, 4018.6985976051765, 3992.7440995837405, 4014.2974979378637, 4017.156397156586, 4045.5549889512276, 4055.634992850643, 4005.7396269242404, 4013.0, 4039.353703407455, 4044.413560033793, 4046.4941882264716, 3739.607341229159, 3946.3883098119836, 3951.130751234724, 4047.817848196838, 4048.4939382577177, 3435.879744208966, 3441.5009823575692, 3446.551948246737, 3467.0, 3469.9132521686906, 4970.676906001135, 5003.74981250936, 5013.348264725599, 5065.1895696688725, 5080.898382032376, 4256.680748943811, 4547.727136371828, 4552.8861778455475, 4562.931556026662, 4578.2903649934315, 5374.462553744634, 5377.1665391863935, 5383.3890563076875, 5387.467890091651, 5421.132618780976, 3767.585565587783, 3781.1870447853566, 3784.4701741756176, 3788.6360910072353, 3790.9620903790883, 5405.7567409467065, 5662.49037586615, 5687.943120568782, 5717.142428635696, 5718.0, 3827.8086095695103, 3832.945939866559, 3837.76973381598, 3851.614838516182, 3862.6909847212155, 3902.239063382613, 3904.7071469639322, 3911.471951286597, 3917.2557214129224, 3927.5483319418063, 4477.858146172705, 4497.257952437811, 4497.482789479252, 4502.8649140525185, 4540.205464043779, 5214.947850521522, 5386.8383948481605, 5402.297701298806, 5427.945720542823, 5456.727163641882, 1336.5990202939079, 1339.4240476595157, 1342.5837990223063, 1345.6232254968625, 1352.9797053044213, 846.8221673448521, 854.7649396415911, 864.9524276164872, 865.0916537635458, 945.6595625574788, 4626.629869610423, 4658.673892827537, 4730.746352216665, 4738.50245724194, 4745.098431298043, 5497.835064948058, 5530.364008139035, 5547.278853749068, 5552.666839989613, 5563.5271001964475, 4534.412955465561, 4633.86098417048, 4650.232711602548, 4697.600703940203, 4705.576498115118, 2922.1233629910944, 2929.5245517537646, 2941.97058029417, 2950.7196816302417, 2951.5130003549175, 5174.7153906535505, 5188.325517682677, 5191.740412979336, 5217.147912491087, 5232.110541208004, 5463.562914966873, 5592.664440133605, 5605.691686957257, 5630.493255607015, 5638.887222255614, 5190.53285204341, 5195.92206116901, 5233.764480598382, 5268.2097685346735, 5273.44628813969, 5474.835754927359, 5488.7530061148145, 5506.256655351476, 5564.749586268708, 5568.749406276646, 5144.6398752087, 5521.641093328921, 5533.335999680065, 5540.252065971204, 5561.277033985718, 5340.252364668871, 5361.785528578969, 5363.5440987516495, 5373.838784836461, 5375.139977603565, 3832.6742226911024, 3907.843686252518, 3931.4889064422587, 3932.272529581922, 3934.5835499219684, 5617.915731264116, 5645.237892884408, 5698.401667824819, 5701.315842098975, 5706.942930570807, 5492.670439773627, 5494.587905906993, 5496.31296087989, 5517.172424136412, 5528.612997090165, 5379.946200538101, 5457.481539253765, 5477.67133971963, 5485.780568777204, 5503.834884953458, 5393.43368946255, 5404.459554044564, 5408.215808707794, 5415.2689386933835, 5428.809991650273, 5239.895202096013, 5369.0, 5473.412710313964, 5526.198701188386, 5565.1930470082425, 5377.665847174777, 5395.730213489388, 5402.729863506887, 5407.72918364192, 5475.808346707846], "value": 4048.846094124928, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [669.1835960128644, 681.7034589953371, 735.8234023834278, 737.9815504612387, 755.3088923634874, 11272.210945233837, 11858.584949526768, 11865.644030679072, 11940.7611847763, 11946.880531194685, 11526.596569120082, 11898.345590992492, 11930.224535405192, 11939.880601193985, 11943.223690460136, 626.2328647406936, 754.6717178027549, 762.0702742653954, 790.6046976511744, 792.4571668407131, 750.973715919943, 754.4454825703103, 756.667066490745, 757.034780654667, 760.9581473019009, 794.1542257495748, 799.9640016199285, 800.4876878797575, 802.2699343597328, 803.337246771413, 785.6817988714552, 788.7239466186846, 791.8574656561816, 796.0924546017544, 797.6889013284823, 582.2081968522806, 582.4437662032749, 585.3648791061703, 586.6099044135644, 586.7330364684059, 12187.085968552305, 12208.32854193019, 12238.0, 12279.263244205287, 12296.631101066982, 12423.875761242361, 12824.487020519167, 12854.228746275254, 12861.22832630036, 13297.800532992012, 9821.607135714563, 9904.55429505674, 9997.600095996151, 10117.696469105938, 10302.969703029712, 3204.5834041574444, 3211.1169428407143, 3211.999920740274, 3225.4033003894356, 3257.7393808495262, 58330.416695833344, 61417.38582614206, 61424.69287653533, 61594.0, 61674.38325616731, 10057.899421005843, 10177.745556361151, 10214.0, 10273.640422585324, 10309.84535231972, 16243.593910152103, 16795.748063779054, 16831.158442077845, 18608.0, 18639.627207456047, 6653.800385988428, 6815.659217039228, 6844.4182244508775, 6849.554778939353, 6893.4140598048725, 3457.22212502185, 3548.8048157351077, 3599.8200089995394, 3624.7825130492256, 3689.2990331836863, 2903.7531809796405, 2971.9257018574276, 2991.1176203020163, 2991.5064014437376, 2996.550517422404, 516.5299577384562, 532.6457905492881, 532.8135152696602, 538.2437675066537, 539.9784008639689, 523.6543881038573, 529.203548659273, 557.2419017998222, 568.5693659605221, 580.4108829538022, 7450.925490745131, 7510.737124200736, 7692.38460923136, 7808.7657370278985, 7949.205079492121, 540.367769709441, 576.1821453314799, 589.0633892111563, 617.7343742190901, 621.9844503887349, 3548.3967725486727, 4084.65280451159, 4250.596193361625, 4322.092360604245, 4530.501644819067, 94885.0, 104354.47822760837, 104753.0, 105753.0, 109093.45453272683, 52657.0, 53016.20475692867, 53424.198637020476, 61912.0, 87221.0, 50113.498865011614, 65183.34816651868, 81338.0, 81984.59007704923, 82457.58771206105, 8385.706500272461, 8401.831963360577, 8484.363672724694, 8554.657813687383, 8749.5187764671, 46802.29796552986, 47632.76183619198, 47873.0, 48243.5175648239, 48571.27143092786, 52689.0, 54321.0, 54835.72582137064, 60795.392046078974, 61569.692151538955, 11267.56343808987, 11738.70653233676, 11893.870082342164, 12020.939895300467, 12177.634670959531, 12440.0, 12455.377231138225, 12522.37388130608, 12624.3687815607, 12812.10315277959, 10256.639719993214, 10415.739606509595, 11721.648350549498, 11999.100067495147, 12120.878791211975, 10986.945065274622, 11792.469338879942, 11900.285982841056, 12069.456874440846, 12078.939605301917, 11279.605213817476, 11319.320840749582, 11427.314361138358, 11634.883651163718, 11799.941000295286, 9281.443113413217, 9669.226461883172, 9917.206623469961, 10000.199984001409, 10120.089191972758, 8949.239314658327, 9132.726018219464, 9254.444733316022, 9507.714768556954, 9615.278854086111], "value": 6395.235698330665, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1567.2000000000003, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 114.0, 106.0, 113.0, 114.0, 118.0, 117.0, 115.0, 112.0, 115.0], "value": 113.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 123.0, 147.0, 179.0, 125.0, 150.0, 154.0, 126.0, 180.0, 123.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [164.0, 165.0, 162.0, 163.0, 172.0, 163.0, 163.0, 164.0, 162.0, 163.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 75.0, 150.0, 77.0, 76.0, 75.0, 76.0, 162.0, 79.0], "value": 92.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 146.0, 86.0, 87.0, 86.0, 135.0, 85.0, 85.0, 138.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 148.0, 149.0, 148.0, 147.0, 148.0, 148.0, 147.0, 150.0, 147.0], "value": 147.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 100.0, 95.0, 96.0, 95.0, 94.0, 94.0], "value": 95.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 65.0, 65.0, 65.0, 67.0, 65.0, 64.0, 64.0], "value": 65.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 66.0, 64.0, 65.0, 65.0, 66.0, 65.0, 65.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 80.0, 79.0, 85.0, 83.0, 84.0, 79.0, 79.0, 84.0, 78.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 133.0, 141.0, 131.0, 133.0, 138.0, 128.0, 133.0, 161.0, 150.0], "value": 139.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 173.0, 175.0, 165.0, 164.0, 168.0, 168.0, 174.0, 170.0, 174.0], "value": 169.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 69.0, 70.0, 69.0, 67.0, 68.0, 75.0, 66.0, 71.0], "value": 68.9, "unit": "score"}]}]} 04:34:09 INFO - Return code: 0 04:34:09 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:09 ERROR - # TBPL SUCCESS # 04:34:09 INFO - Running post-action listener: _resource_record_post_action 04:34:09 INFO - ##### 04:34:09 INFO - ##### Finished run-tests step (success) 04:34:09 INFO - ##### 04:34:09 INFO - Running post-run listener: _resource_record_post_run 04:34:09 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 4096; Write bytes: 551198720; Read time: 12; Write time: 510148 04:34:09 INFO - TinderboxPrint: CPU usage
13.3% 04:34:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 04:34:09 INFO - TinderboxPrint: I/O write bytes / time
551,198,720 / 510,148 04:34:09 INFO - TinderboxPrint: CPU idle
8,280.2 (86.7%) 04:34:09 INFO - TinderboxPrint: CPU user
1,218.6 (12.8%) 04:34:09 INFO - TinderboxPrint: Swap in / out
0 / 0 04:34:09 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 263172096; Read time: 0; Write time: 285880 04:34:09 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288026624; Read time: 0; Write time: 224268 04:34:10 INFO - Running post-run listener: _upload_blobber_files 04:34:10 INFO - Blob upload gear active. 04:34:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:10 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:34:10 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:34:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:34:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:11 INFO - (blobuploader) - INFO - Done attempting. 04:34:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:34:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:34:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:12 INFO - (blobuploader) - INFO - Done attempting. 04:34:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:34:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:34:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:15 INFO - (blobuploader) - INFO - Done attempting. 04:34:15 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:15 INFO - Return code: 0 04:34:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/578cd1e8cb705d4bb90c1b67759a018857edba62c4ab9d636e714ca5609f626aafda727f88a8d1a7fb83e1ac2ed79de78ca47c2d2d054cdd744bba19171cd652", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a3449edc2e91c9aef034aab747494b32259f53bb34f0a590a81065da4f30c6d908f99b340519312fbb74a12ec2c1db538922fea200832a649fd206252b9b0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6502632686cc4fd80ee47b19f1b315381670574f92c042681e73b9f137f139e127f90adb3eb535031cea09812373c8af2f73103ec40bb815a990c2dfe095ba16"} 04:34:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:15 INFO - Contents: 04:34:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/578cd1e8cb705d4bb90c1b67759a018857edba62c4ab9d636e714ca5609f626aafda727f88a8d1a7fb83e1ac2ed79de78ca47c2d2d054cdd744bba19171cd652", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a3449edc2e91c9aef034aab747494b32259f53bb34f0a590a81065da4f30c6d908f99b340519312fbb74a12ec2c1db538922fea200832a649fd206252b9b0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6502632686cc4fd80ee47b19f1b315381670574f92c042681e73b9f137f139e127f90adb3eb535031cea09812373c8af2f73103ec40bb815a990c2dfe095ba16"} 04:34:15 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:15 INFO - Copying logs to upload dir... 04:34:15 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1240.080233 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 40 secs) (at 2016-06-30 04:34:14.772527) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 04:34:14.776484) ========= 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=920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514 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/578cd1e8cb705d4bb90c1b67759a018857edba62c4ab9d636e714ca5609f626aafda727f88a8d1a7fb83e1ac2ed79de78ca47c2d2d054cdd744bba19171cd652", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a3449edc2e91c9aef034aab747494b32259f53bb34f0a590a81065da4f30c6d908f99b340519312fbb74a12ec2c1db538922fea200832a649fd206252b9b0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6502632686cc4fd80ee47b19f1b315381670574f92c042681e73b9f137f139e127f90adb3eb535031cea09812373c8af2f73103ec40bb815a990c2dfe095ba16"} build_url:https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011236 build_url: 'https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/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/578cd1e8cb705d4bb90c1b67759a018857edba62c4ab9d636e714ca5609f626aafda727f88a8d1a7fb83e1ac2ed79de78ca47c2d2d054cdd744bba19171cd652", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/d5a3449edc2e91c9aef034aab747494b32259f53bb34f0a590a81065da4f30c6d908f99b340519312fbb74a12ec2c1db538922fea200832a649fd206252b9b0d", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/6502632686cc4fd80ee47b19f1b315381670574f92c042681e73b9f137f139e127f90adb3eb535031cea09812373c8af2f73103ec40bb815a990c2dfe095ba16"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 04:34:14.801886) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:34:14.802252) ========= 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=920470bf432669ad7e3a5387000001ca-1467278865.465047-1608781514 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:34:14.888039) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 04:34:14.888359) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 04:34:14.888665) ========= ========= Total master_lag: 0.17 =========