builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-015 starttime: 1467285212.95 results: success (0) buildid: 20160630025327 builduid: 41050aa33e8a4acba96e2d6d61079be8 revision: 0edb9df3c97ff7d205a99f8af607f99a858f140b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:32.954821) ========= 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:32.955634) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:32.955900) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:32.994505) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:32.994806) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524 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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 77.1M=0s 2016-06-30 04:13:33 (77.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.155256) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.155635) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.023341 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.211168) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.211471) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 04:13:33,622 truncating revision to first 12 chars 2016-06-30 04:13:33,622 Setting DEBUG logging. 2016-06-30 04:13:33,622 attempt 1/10 2016-06-30 04:13:33,622 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:33,920 unpacking tar archive at: mozilla-central-0edb9df3c97f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.650928 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.877422) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.877698) ========= script_repo_revision: 0edb9df3c97ff7d205a99f8af607f99a858f140b ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.878086) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.878349) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 04:13:33.893973) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-30 04:13:33.894284) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:34 INFO - MultiFileLogger online at 20160630 04:13:34 in /builds/slave/test 04:13:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:13:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:34 INFO - {'append_to_log': False, 04:13:34 INFO - 'base_work_dir': '/builds/slave/test', 04:13:34 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:13:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:34 INFO - 'branch': 'Firefox-Non-PGO', 04:13:34 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:34 INFO - 'config_files': ('talos/linux_config.py',), 04:13:34 INFO - 'default_actions': ('clobber', 04:13:34 INFO - 'read-buildbot-config', 04:13:34 INFO - 'download-and-extract', 04:13:34 INFO - 'populate-webroot', 04:13:34 INFO - 'create-virtualenv', 04:13:34 INFO - 'install', 04:13:34 INFO - 'run-tests'), 04:13:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:34 INFO - 'download_minidump_stackwalk': True, 04:13:34 INFO - 'download_symbols': 'ondemand', 04:13:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:34 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:34 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:34 INFO - 'installer_path': 'installer.exe', 04:13:34 INFO - 'log_level': 'info', 04:13:34 INFO - 'log_name': 'talos', 04:13:34 INFO - 'log_to_console': True, 04:13:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:34 INFO - 'opt_config_files': (), 04:13:34 INFO - 'pip_index': False, 04:13:34 INFO - 'sps_profile': False, 04:13:34 INFO - 'sps_profile_interval': 0, 04:13:34 INFO - 'suite': 'dromaeojs', 04:13:34 INFO - 'system_bits': '32', 04:13:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:34 INFO - 'title': 'talos-linux64-ix-015', 04:13:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:34 INFO - 'use_talos_json': True, 04:13:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:34 INFO - 'work_dir': 'build'} 04:13:34 INFO - ##### 04:13:34 INFO - ##### Running clobber step. 04:13:34 INFO - ##### 04:13:34 INFO - Running pre-action listener: _resource_record_pre_action 04:13:34 INFO - Running main action method: clobber 04:13:34 INFO - rmtree: /builds/slave/test/build 04:13:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:34 INFO - Running post-action listener: _resource_record_post_action 04:13:34 INFO - ##### 04:13:34 INFO - ##### Finished clobber step (success) 04:13:34 INFO - ##### 04:13:34 INFO - ##### 04:13:34 INFO - ##### Running read-buildbot-config step. 04:13:34 INFO - ##### 04:13:34 INFO - Running pre-action listener: _resource_record_pre_action 04:13:34 INFO - Running main action method: read_buildbot_config 04:13:34 INFO - Using buildbot properties: 04:13:34 INFO - { 04:13:34 INFO - "project": "", 04:13:34 INFO - "product": "firefox", 04:13:34 INFO - "script_repo_revision": "production", 04:13:34 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:13:34 INFO - "repository": "", 04:13:34 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:13:34 INFO - "buildid": "20160630025327", 04:13:34 INFO - "pgo_build": "False", 04:13:34 INFO - "basedir": "/builds/slave/test", 04:13:34 INFO - "buildnumber": 627, 04:13:34 INFO - "slavename": "talos-linux64-ix-015", 04:13:34 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:13:34 INFO - "platform": "ubuntu64_hw", 04:13:34 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:13:34 INFO - "branch": "mozilla-central", 04:13:34 INFO - "repo_path": "mozilla-central", 04:13:34 INFO - "revision": "0edb9df3c97ff7d205a99f8af607f99a858f140b", 04:13:34 INFO - "stage_platform": "linux64", 04:13:34 INFO - "builduid": "41050aa33e8a4acba96e2d6d61079be8", 04:13:34 INFO - "slavebuilddir": "test" 04:13:34 INFO - } 04:13:34 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:34 INFO - Running post-action listener: _resource_record_post_action 04:13:34 INFO - ##### 04:13:34 INFO - ##### Finished read-buildbot-config step (success) 04:13:34 INFO - ##### 04:13:34 INFO - ##### 04:13:34 INFO - ##### Running download-and-extract step. 04:13:34 INFO - ##### 04:13:34 INFO - Running pre-action listener: _resource_record_pre_action 04:13:34 INFO - Running main action method: download_and_extract 04:13:34 INFO - mkdir: /builds/slave/test/build/tests 04:13:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:34 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:34 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:34 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:34 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:34 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:42 INFO - Downloaded 1361 bytes. 04:13:42 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:13:42 INFO - Using the following test package requirements: 04:13:42 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:42 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:42 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:13:42 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:42 INFO - u'jsshell-linux-x86_64.zip'], 04:13:42 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:42 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:42 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:42 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:42 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:42 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:42 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:42 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13:42 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:42 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:42 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:42 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:42 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:42 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:47 INFO - Downloaded 22701705 bytes. 04:13:47 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:47 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:48 INFO - Return code: 0 04:13:48 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:48 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:48 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:48 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:48 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:48 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:48 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:53 INFO - Downloaded 22701705 bytes. 04:13:53 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:53 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:55 INFO - Return code: 0 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 - 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:55 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:55 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:55 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:55 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:56 INFO - Downloaded 14405245 bytes. 04:13:56 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:56 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:56 INFO - Return code: 0 04:13:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:56 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:56 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:56 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:56 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:56 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:58 INFO - Downloaded 56476207 bytes. 04:13:58 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:58 INFO - mkdir: /builds/slave/test/properties 04:13:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:58 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:58 INFO - Contents: 04:13:58 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:59 INFO - Running post-action listener: _resource_record_post_action 04:13:59 INFO - Running post-action listener: set_extra_try_arguments 04:13:59 INFO - ##### 04:13:59 INFO - ##### Finished download-and-extract step (success) 04:13:59 INFO - ##### 04:13:59 INFO - ##### 04:13:59 INFO - ##### Running populate-webroot step. 04:13:59 INFO - ##### 04:13:59 INFO - Running pre-action listener: _resource_record_pre_action 04:13:59 INFO - Running main action method: populate_webroot 04:13:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:59 INFO - '--tppagecycles', 04:13:59 INFO - '7'], 04:13:59 INFO - 'tests': ['tsvgm']}}, 04:13:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:13:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:13:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:13:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:13:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:13:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:59 INFO - 'talos_options': ['--disable-e10s'], 04:13:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:59 INFO - 'talos_options': ['--disable-e10s'], 04:13:59 INFO - 'tests': ['damp', 'tps']}, 04:13:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:59 INFO - 'tests': ['damp', 'tps']}, 04:13:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:13:59 INFO - 'tests': ['dromaeo_dom']}, 04:13:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:13:59 INFO - 'tests': ['basic_compositor_video']}, 04:13:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:13:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:13:59 INFO - 'tests': ['a11yr', 04:13:59 INFO - 'ts_paint', 04:13:59 INFO - 'tpaint', 04:13:59 INFO - 'sessionrestore', 04:13:59 INFO - 'sessionrestore_no_auto_restore', 04:13:59 INFO - 'tabpaint']}, 04:13:59 INFO - 'other-e10s': {'tests': ['a11yr', 04:13:59 INFO - 'ts_paint', 04:13:59 INFO - 'tpaint', 04:13:59 INFO - 'sessionrestore', 04:13:59 INFO - 'sessionrestore_no_auto_restore', 04:13:59 INFO - 'tabpaint']}, 04:13:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:13:59 INFO - 'ts_paint', 04:13:59 INFO - 'tpaint', 04:13:59 INFO - 'sessionrestore', 04:13:59 INFO - 'sessionrestore_no_auto_restore', 04:13:59 INFO - 'tabpaint']}, 04:13:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:13:59 INFO - 'ts_paint', 04:13:59 INFO - 'tpaint', 04:13:59 INFO - 'sessionrestore', 04:13:59 INFO - 'sessionrestore_no_auto_restore', 04:13:59 INFO - 'tabpaint']}, 04:13:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:13:59 INFO - 'tests': ['a11yr', 04:13:59 INFO - 'ts_paint', 04:13:59 INFO - 'tpaint', 04:13:59 INFO - 'sessionrestore', 04:13:59 INFO - 'sessionrestore_no_auto_restore', 04:13:59 INFO - 'tabpaint']}, 04:13:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:13:59 INFO - 'tests': ['a11yr', 04:13:59 INFO - 'ts_paint', 04:13:59 INFO - 'tpaint', 04:13:59 INFO - 'sessionrestore', 04:13:59 INFO - 'sessionrestore_no_auto_restore', 04:13:59 INFO - 'tabpaint']}, 04:13:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:13:59 INFO - 'tests': ['tsvgx', 04:13:59 INFO - 'tsvgr_opacity', 04:13:59 INFO - 'tart', 04:13:59 INFO - 'tscrollx', 04:13:59 INFO - 'cart']}, 04:13:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:13:59 INFO - 'tsvgr_opacity', 04:13:59 INFO - 'tart', 04:13:59 INFO - 'tscrollx', 04:13:59 INFO - 'cart']}, 04:13:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:59 INFO - 'talos_options': ['--disable-e10s'], 04:13:59 INFO - 'tests': ['tp5o']}, 04:13:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:59 INFO - 'tests': ['tp5o']}, 04:13:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:59 INFO - 'talos_options': ['--disable-e10s', 04:13:59 INFO - '--xperf_path', 04:13:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:59 INFO - 'tests': ['tp5n']}, 04:13:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:59 INFO - 'talos_options': ['--xperf_path', 04:13:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:59 INFO - 'tests': ['tp5n']}}, 04:13:59 INFO - 'talos.zip': {'path': '', 04:13:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:59 INFO - Running post-action listener: _resource_record_post_action 04:13:59 INFO - ##### 04:13:59 INFO - ##### Finished populate-webroot step (success) 04:13:59 INFO - ##### 04:13:59 INFO - ##### 04:13:59 INFO - ##### Running create-virtualenv step. 04:13:59 INFO - ##### 04:13:59 INFO - Running pre-action listener: _resource_record_pre_action 04:13:59 INFO - Running main action method: create_virtualenv 04:13:59 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:59 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:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:59 INFO - Using real prefix '/usr' 04:13:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:59 INFO - Installing distribute.............................................................................................................................................................................................done. 04:14:01 INFO - Installing pip.................done. 04:14:01 INFO - Return code: 0 04:14:01 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:14:01 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:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:01 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:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:01 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 0x2742030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a03180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a013b0>, '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 0x2a022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02740>, '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': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', '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:01 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:14:01 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:14:01 INFO - Using env: {'DISPLAY': ':0', 04:14:01 INFO - 'HOME': '/home/cltbld', 04:14:01 INFO - 'LANG': 'en_US.UTF-8', 04:14:01 INFO - 'LANGUAGE': 'en_US:en', 04:14:01 INFO - 'LOGNAME': 'cltbld', 04:14:01 INFO - 'MAIL': '/var/mail/cltbld', 04:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:01 INFO - 'MOZ_NO_REMOTE': '1', 04:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:01 INFO - 'NO_EM_RESTART': '1', 04:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:01 INFO - 'PWD': '/builds/slave/test', 04:14:01 INFO - 'SHELL': '/bin/bash', 04:14:01 INFO - 'SHLVL': '1', 04:14:01 INFO - 'TERM': 'linux', 04:14:01 INFO - 'TMOUT': '86400', 04:14:01 INFO - 'USER': 'cltbld', 04:14:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', 04:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:01 INFO - '_': '/tools/buildbot/bin/python'} 04:14:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:01 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:14:01 INFO - Cleaning up... 04:14:01 INFO - Return code: 0 04:14:01 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:14:01 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:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:01 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:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:01 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 0x2742030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a03180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a013b0>, '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 0x2a022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02740>, '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': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', '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:01 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:14:01 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:14:01 INFO - Using env: {'DISPLAY': ':0', 04:14:01 INFO - 'HOME': '/home/cltbld', 04:14:01 INFO - 'LANG': 'en_US.UTF-8', 04:14:01 INFO - 'LANGUAGE': 'en_US:en', 04:14:01 INFO - 'LOGNAME': 'cltbld', 04:14:01 INFO - 'MAIL': '/var/mail/cltbld', 04:14:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:01 INFO - 'MOZ_NO_REMOTE': '1', 04:14:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:01 INFO - 'NO_EM_RESTART': '1', 04:14:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:01 INFO - 'PWD': '/builds/slave/test', 04:14:01 INFO - 'SHELL': '/bin/bash', 04:14:01 INFO - 'SHLVL': '1', 04:14:01 INFO - 'TERM': 'linux', 04:14:01 INFO - 'TMOUT': '86400', 04:14:01 INFO - 'USER': 'cltbld', 04:14:01 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', 04:14:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:01 INFO - '_': '/tools/buildbot/bin/python'} 04:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:02 INFO - Downloading/unpacking psutil>=3.1.1 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:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:14:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:04 INFO - Installing collected packages: psutil 04:14:04 INFO - Running setup.py install for psutil 04:14:04 INFO - building 'psutil._psutil_linux' extension 04:14:04 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:14:04 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:14:04 INFO - building 'psutil._psutil_posix' extension 04:14:04 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:14:04 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:14:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:04 INFO - Successfully installed psutil 04:14:04 INFO - Cleaning up... 04:14:04 INFO - Return code: 0 04:14:04 INFO - Installing mozsystemmonitor==0.3 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', '--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 0x2742030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a03180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a013b0>, '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 0x2a022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02740>, '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': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', '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', '--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:14:04 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: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': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', 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 - Downloading/unpacking mozsystemmonitor==0.3 04:14:04 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:04 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:04 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:04 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:04 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:04 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:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:14:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:14:07 INFO - Installing collected packages: mozsystemmonitor 04:14:07 INFO - Running setup.py install for mozsystemmonitor 04:14:07 INFO - Successfully installed mozsystemmonitor 04:14:07 INFO - Cleaning up... 04:14:08 INFO - Return code: 0 04:14:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:14:08 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:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:08 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:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:08 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 0x2742030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a03180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a013b0>, '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 0x2a022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02740>, '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': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', '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:08 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:14:08 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:14:08 INFO - Using env: {'DISPLAY': ':0', 04:14:08 INFO - 'HOME': '/home/cltbld', 04:14:08 INFO - 'LANG': 'en_US.UTF-8', 04:14:08 INFO - 'LANGUAGE': 'en_US:en', 04:14:08 INFO - 'LOGNAME': 'cltbld', 04:14:08 INFO - 'MAIL': '/var/mail/cltbld', 04:14:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:08 INFO - 'MOZ_NO_REMOTE': '1', 04:14:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:08 INFO - 'NO_EM_RESTART': '1', 04:14:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:08 INFO - 'PWD': '/builds/slave/test', 04:14:08 INFO - 'SHELL': '/bin/bash', 04:14:08 INFO - 'SHLVL': '1', 04:14:08 INFO - 'TERM': 'linux', 04:14:08 INFO - 'TMOUT': '86400', 04:14:08 INFO - 'USER': 'cltbld', 04:14:08 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', 04:14:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:08 INFO - '_': '/tools/buildbot/bin/python'} 04:14:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:08 INFO - Downloading/unpacking jsonschema==2.5.1 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 jsonschema-2.5.1-py2.py3-none-any.whl 04:14:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:14:10 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:10 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 - 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:10 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:10 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:10 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 functools32-3.2.3-2.tar.gz 04:14:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:10 INFO - warning: no files found matching '*.txt' 04:14:10 INFO - no previously-included directories found matching 'build' 04:14:10 INFO - no previously-included directories found matching 'dist' 04:14:10 INFO - no previously-included directories found matching '.git*' 04:14:10 INFO - Installing collected packages: jsonschema, functools32 04:14:10 INFO - Running setup.py install for functools32 04:14:10 INFO - warning: no files found matching '*.txt' 04:14:10 INFO - no previously-included directories found matching 'build' 04:14:10 INFO - no previously-included directories found matching 'dist' 04:14:10 INFO - no previously-included directories found matching '.git*' 04:14:10 INFO - Successfully installed jsonschema functools32 04:14:10 INFO - Cleaning up... 04:14:10 INFO - Return code: 0 04:14:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:10 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 0x2742030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a03180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a013b0>, '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 0x2a022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02740>, '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': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', '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:10 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:10 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:10 INFO - Using env: {'DISPLAY': ':0', 04:14:10 INFO - 'HOME': '/home/cltbld', 04:14:10 INFO - 'LANG': 'en_US.UTF-8', 04:14:10 INFO - 'LANGUAGE': 'en_US:en', 04:14:10 INFO - 'LOGNAME': 'cltbld', 04:14:10 INFO - 'MAIL': '/var/mail/cltbld', 04:14:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:10 INFO - 'MOZ_NO_REMOTE': '1', 04:14:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:10 INFO - 'NO_EM_RESTART': '1', 04:14:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:10 INFO - 'PWD': '/builds/slave/test', 04:14:10 INFO - 'SHELL': '/bin/bash', 04:14:10 INFO - 'SHLVL': '1', 04:14:10 INFO - 'TERM': 'linux', 04:14:10 INFO - 'TMOUT': '86400', 04:14:10 INFO - 'USER': 'cltbld', 04:14:10 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', 04:14:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:10 INFO - '_': '/tools/buildbot/bin/python'} 04:14:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:10 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:10 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:10 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 - 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:10 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:10 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:10 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:15 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:15 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:15 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:15 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:15 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:15 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:15 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:15 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:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:16 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:16 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:16 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:16 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:16 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:16 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:16 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:16 INFO - Downloading docopt-0.6.1.tar.gz 04:14:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:16 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:16 INFO - Running setup.py install for blobuploader 04:14:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:16 INFO - Running setup.py install for requests 04:14:16 INFO - Running setup.py install for docopt 04:14:17 INFO - Successfully installed blobuploader requests docopt 04:14:17 INFO - Cleaning up... 04:14:17 INFO - Return code: 0 04:14:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:17 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 0x2742030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a03180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a013b0>, '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 0x2a022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02740>, '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': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', '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:17 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:17 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:17 INFO - Using env: {'DISPLAY': ':0', 04:14:17 INFO - 'HOME': '/home/cltbld', 04:14:17 INFO - 'LANG': 'en_US.UTF-8', 04:14:17 INFO - 'LANGUAGE': 'en_US:en', 04:14:17 INFO - 'LOGNAME': 'cltbld', 04:14:17 INFO - 'MAIL': '/var/mail/cltbld', 04:14:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:17 INFO - 'MOZ_NO_REMOTE': '1', 04:14:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:17 INFO - 'NO_EM_RESTART': '1', 04:14:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:17 INFO - 'PWD': '/builds/slave/test', 04:14:17 INFO - 'SHELL': '/bin/bash', 04:14:17 INFO - 'SHLVL': '1', 04:14:17 INFO - 'TERM': 'linux', 04:14:17 INFO - 'TMOUT': '86400', 04:14:17 INFO - 'USER': 'cltbld', 04:14:17 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', 04:14:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:17 INFO - '_': '/tools/buildbot/bin/python'} 04:14:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:17 INFO - Running setup.py (path:/tmp/pip-pxZ1KZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:17 INFO - Running setup.py (path:/tmp/pip-7sACWA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:17 INFO - Running setup.py (path:/tmp/pip-GivEX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:17 INFO - Running setup.py (path:/tmp/pip-rGIAWB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:17 INFO - Running setup.py (path:/tmp/pip-RAVlPR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:17 INFO - Running setup.py (path:/tmp/pip-ufa6sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:17 INFO - Running setup.py (path:/tmp/pip-99P8Xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:17 INFO - Running setup.py (path:/tmp/pip-ehJESS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:17 INFO - Running setup.py (path:/tmp/pip-cr9eGh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:17 INFO - Running setup.py (path:/tmp/pip-MeL5yd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:18 INFO - Running setup.py (path:/tmp/pip-rwT2UN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:18 INFO - Running setup.py (path:/tmp/pip-zO9wlI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:18 INFO - Running setup.py (path:/tmp/pip-WUzPKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:18 INFO - Running setup.py (path:/tmp/pip-FaM1c0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:18 INFO - Running setup.py (path:/tmp/pip-1YcqQS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:18 INFO - Running setup.py (path:/tmp/pip-jgnfGP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:18 INFO - Running setup.py (path:/tmp/pip-BOTK20-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:18 INFO - Running setup.py install for manifestparser 04:14:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Running setup.py install for mozcrash 04:14:18 INFO - Running setup.py install for mozdebug 04:14:18 INFO - Running setup.py install for mozdevice 04:14:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:18 INFO - Running setup.py install for mozfile 04:14:19 INFO - Running setup.py install for mozhttpd 04:14:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Running setup.py install for mozinfo 04:14:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Running setup.py install for mozInstall 04:14:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Running setup.py install for mozleak 04:14:19 INFO - Running setup.py install for mozlog 04:14:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Running setup.py install for moznetwork 04:14:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Running setup.py install for mozprocess 04:14:19 INFO - Running setup.py install for mozprofile 04:14:19 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:19 INFO - Running setup.py install for mozrunner 04:14:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:20 INFO - Running setup.py install for mozscreenshot 04:14:20 INFO - Running setup.py install for moztest 04:14:20 INFO - Running setup.py install for mozversion 04:14:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:20 INFO - Cleaning up... 04:14:20 INFO - Return code: 0 04:14:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:20 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 0x2742030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a03180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a013b0>, '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 0x2a022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02740>, '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': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', '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:20 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:20 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:20 INFO - Using env: {'DISPLAY': ':0', 04:14:20 INFO - 'HOME': '/home/cltbld', 04:14:20 INFO - 'LANG': 'en_US.UTF-8', 04:14:20 INFO - 'LANGUAGE': 'en_US:en', 04:14:20 INFO - 'LOGNAME': 'cltbld', 04:14:20 INFO - 'MAIL': '/var/mail/cltbld', 04:14:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:20 INFO - 'MOZ_NO_REMOTE': '1', 04:14:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:20 INFO - 'NO_EM_RESTART': '1', 04:14:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:20 INFO - 'PWD': '/builds/slave/test', 04:14:20 INFO - 'SHELL': '/bin/bash', 04:14:20 INFO - 'SHLVL': '1', 04:14:20 INFO - 'TERM': 'linux', 04:14:20 INFO - 'TMOUT': '86400', 04:14:20 INFO - 'USER': 'cltbld', 04:14:20 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', 04:14:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:20 INFO - '_': '/tools/buildbot/bin/python'} 04:14:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:20 INFO - Running setup.py (path:/tmp/pip-d8jmUZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:20 INFO - Running setup.py (path:/tmp/pip-0zWY9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:20 INFO - Running setup.py (path:/tmp/pip-PGbOas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:20 INFO - Running setup.py (path:/tmp/pip-7v6Q_c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:20 INFO - Running setup.py (path:/tmp/pip-6pM9J6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:20 INFO - Running setup.py (path:/tmp/pip-kUYPZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:20 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:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:20 INFO - Running setup.py (path:/tmp/pip-kVxske-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:21 INFO - Running setup.py (path:/tmp/pip-tCsbP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:21 INFO - Running setup.py (path:/tmp/pip-PbJ_MX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:21 INFO - Running setup.py (path:/tmp/pip-iFOWHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:21 INFO - Running setup.py (path:/tmp/pip-pGwNiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:21 INFO - Running setup.py (path:/tmp/pip-cbMlQB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:21 INFO - Running setup.py (path:/tmp/pip-FZHXUm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:21 INFO - Running setup.py (path:/tmp/pip-6u6huw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:21 INFO - Running setup.py (path:/tmp/pip-K711Va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:21 INFO - Running setup.py (path:/tmp/pip-0kpXvm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:21 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:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:21 INFO - Running setup.py (path:/tmp/pip-4jXGb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:21 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:21 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:21 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:21 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:21 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:21 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:21 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:23 INFO - Downloading blessings-1.6.tar.gz 04:14:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:23 INFO - Installing collected packages: blessings 04:14:23 INFO - Running setup.py install for blessings 04:14:23 INFO - Successfully installed blessings 04:14:23 INFO - Cleaning up... 04:14:23 INFO - Return code: 0 04:14:23 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:24 INFO - Reading from file tmpfile_stdout 04:14:24 INFO - Current package versions: 04:14:24 INFO - argparse == 1.2.1 04:14:24 INFO - blessings == 1.6 04:14:24 INFO - blobuploader == 1.2.4 04:14:24 INFO - docopt == 0.6.1 04:14:24 INFO - functools32 == 3.2.3-2 04:14:24 INFO - jsonschema == 2.5.1 04:14:24 INFO - manifestparser == 1.1 04:14:24 INFO - mozInstall == 1.12 04:14:24 INFO - mozcrash == 0.17 04:14:24 INFO - mozdebug == 0.1 04:14:24 INFO - mozdevice == 0.48 04:14:24 INFO - mozfile == 1.2 04:14:24 INFO - mozhttpd == 0.7 04:14:24 INFO - mozinfo == 0.9 04:14:24 INFO - mozleak == 0.1 04:14:24 INFO - mozlog == 3.2 04:14:24 INFO - moznetwork == 0.27 04:14:24 INFO - mozprocess == 0.22 04:14:24 INFO - mozprofile == 0.28 04:14:24 INFO - mozrunner == 6.11 04:14:24 INFO - mozscreenshot == 0.1 04:14:24 INFO - mozsystemmonitor == 0.3 04:14:24 INFO - moztest == 0.7 04:14:24 INFO - mozversion == 1.4 04:14:24 INFO - psutil == 3.1.1 04:14:24 INFO - requests == 1.2.3 04:14:24 INFO - wsgiref == 0.1.2 04:14:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:24 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 0x2742030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a03180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a013b0>, '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 0x2a022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02740>, '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': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', '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:24 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:24 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:24 INFO - Using env: {'DISPLAY': ':0', 04:14:24 INFO - 'HOME': '/home/cltbld', 04:14:24 INFO - 'LANG': 'en_US.UTF-8', 04:14:24 INFO - 'LANGUAGE': 'en_US:en', 04:14:24 INFO - 'LOGNAME': 'cltbld', 04:14:24 INFO - 'MAIL': '/var/mail/cltbld', 04:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:24 INFO - 'MOZ_NO_REMOTE': '1', 04:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:24 INFO - 'NO_EM_RESTART': '1', 04:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:24 INFO - 'PWD': '/builds/slave/test', 04:14:24 INFO - 'SHELL': '/bin/bash', 04:14:24 INFO - 'SHLVL': '1', 04:14:24 INFO - 'TERM': 'linux', 04:14:24 INFO - 'TMOUT': '86400', 04:14:24 INFO - 'USER': 'cltbld', 04:14:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', 04:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:24 INFO - '_': '/tools/buildbot/bin/python'} 04:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:24 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:24 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:24 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:24 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:24 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:24 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:24 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:24 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:24 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:24 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:24 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:24 INFO - Cleaning up... 04:14:24 INFO - Return code: 0 04:14:24 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:24 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2742030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a03180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a013b0>, '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 0x2a022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02740>, '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': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', '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:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:14:24 INFO - Using env: {'DISPLAY': ':0', 04:14:24 INFO - 'HOME': '/home/cltbld', 04:14:24 INFO - 'LANG': 'en_US.UTF-8', 04:14:24 INFO - 'LANGUAGE': 'en_US:en', 04:14:24 INFO - 'LOGNAME': 'cltbld', 04:14:24 INFO - 'MAIL': '/var/mail/cltbld', 04:14:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:24 INFO - 'MOZ_NO_REMOTE': '1', 04:14:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:24 INFO - 'NO_EM_RESTART': '1', 04:14:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:24 INFO - 'PWD': '/builds/slave/test', 04:14:24 INFO - 'SHELL': '/bin/bash', 04:14:24 INFO - 'SHLVL': '1', 04:14:24 INFO - 'TERM': 'linux', 04:14:24 INFO - 'TMOUT': '86400', 04:14:24 INFO - 'USER': 'cltbld', 04:14:24 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', 04:14:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:24 INFO - '_': '/tools/buildbot/bin/python'} 04:14:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:24 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:14:24 INFO - Cleaning up... 04:14:24 INFO - Return code: 0 04:14:24 INFO - Running post-action listener: _resource_record_post_action 04:14:24 INFO - Running post-action listener: _start_resource_monitoring 04:14:24 INFO - Starting resource monitoring. 04:14:24 INFO - ##### 04:14:24 INFO - ##### Finished create-virtualenv step (success) 04:14:24 INFO - ##### 04:14:24 INFO - ##### 04:14:24 INFO - ##### Running install step. 04:14:24 INFO - ##### 04:14:24 INFO - Running pre-action listener: _resource_record_pre_action 04:14:24 INFO - Running main action method: install 04:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:24 INFO - Reading from file tmpfile_stdout 04:14:24 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:24 INFO - Reading from file tmpfile_stdout 04:14:24 INFO - Output received: 04:14:24 INFO - Usage: mozinstall [options] installer 04:14:24 INFO - Options: 04:14:24 INFO - -h, --help show this help message and exit 04:14:24 INFO - -d DEST, --destination=DEST 04:14:24 INFO - Directory to install application into. [default: 04:14:24 INFO - "/builds/slave/test"] 04:14:24 INFO - --app=APP Application being installed. [default: firefox] 04:14:24 INFO - mkdir: /builds/slave/test/build/application 04:14:24 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:24 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:41 INFO - Reading from file tmpfile_stdout 04:14:41 INFO - Output received: 04:14:41 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:41 INFO - Running post-action listener: _resource_record_post_action 04:14:41 INFO - ##### 04:14:41 INFO - ##### Finished install step (success) 04:14:41 INFO - ##### 04:14:41 INFO - ##### 04:14:41 INFO - ##### Running run-tests step. 04:14:41 INFO - ##### 04:14:41 INFO - Running pre-action listener: _resource_record_pre_action 04:14:41 INFO - Running main action method: run_tests 04:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:41 INFO - Python 2.7.3 04:14:41 INFO - Return code: 0 04:14:41 INFO - grabbing minidump binary from tooltool 04:14: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:14:41 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 0x2a013b0>, '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 0x2a022b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2a02740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:41 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:41 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:41 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:41 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:41 INFO - Return code: 0 04:14:41 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:14:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:14:41 INFO - Using env: {'DISPLAY': ':0', 04:14:41 INFO - 'HOME': '/home/cltbld', 04:14:41 INFO - 'LANG': 'en_US.UTF-8', 04:14:41 INFO - 'LANGUAGE': 'en_US:en', 04:14:41 INFO - 'LOGNAME': 'cltbld', 04:14:41 INFO - 'MAIL': '/var/mail/cltbld', 04:14:41 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:41 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:41 INFO - 'MOZ_NO_REMOTE': '1', 04:14:41 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:41 INFO - 'NO_EM_RESTART': '1', 04:14:41 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:41 INFO - 'PWD': '/builds/slave/test', 04:14:41 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:41 INFO - 'SHELL': '/bin/bash', 04:14:41 INFO - 'SHLVL': '1', 04:14:41 INFO - 'TERM': 'linux', 04:14:41 INFO - 'TMOUT': '86400', 04:14:41 INFO - 'USER': 'cltbld', 04:14:41 INFO - 'XDG_SESSION_COOKIE': '20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524', 04:14:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:41 INFO - '_': '/tools/buildbot/bin/python'} 04:14:41 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bH_Xbq3KQ2SYyQosqenaAw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:14:41 INFO - mozversion application_buildid: 20160630025327 04:14:41 INFO - mozversion application_changeset: 0edb9df3c97ff7d205a99f8af607f99a858f140b 04:14:41 INFO - mozversion application_display_name: Nightly 04:14:41 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:41 INFO - mozversion application_name: Firefox 04:14:41 INFO - mozversion application_remotingname: firefox 04:14:41 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:14:41 INFO - mozversion application_vendor: Mozilla 04:14:41 INFO - mozversion application_version: 50.0a1 04:14:41 INFO - mozversion platform_buildid: 20160630025327 04:14:41 INFO - mozversion platform_changeset: 0edb9df3c97ff7d205a99f8af607f99a858f140b 04:14:41 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:14:41 INFO - mozversion platform_version: 50.0a1 04:14:41 INFO - using testdate: 1467285281 04:14:41 INFO - actual date: 1467285281 04:14:41 INFO - starting webserver on 'localhost:37175' 04:14:41 INFO - SUITE-START | Running 2 tests 04:14:41 INFO - TEST-START | dromaeo_css 04:14:41 INFO - operating with platform_type : linux_ 04:14:41 INFO - Initialising browser for dromaeo_css test... 04:14:41 INFO - TEST-INFO | started process 28789 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp94KmHF/profile http://localhost:37175/getInfo.html) 04:14:45 INFO - PROCESS | 28789 | __metrics Screen width/height:1600/1200 04:14:45 INFO - PROCESS | 28789 | colorDepth:24 04:14:45 INFO - PROCESS | 28789 | Browser inner width/height: 1024/697 04:14:45 INFO - PROCESS | 28789 | __metrics 04:14:46 INFO - PROCESS | 28789 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:14:47 INFO - TEST-INFO | 28789: exit 0 04:14:47 INFO - Browser initialized. 04:14:47 INFO - Running cycle 1/1 for dromaeo_css test... 04:14:47 INFO - TEST-INFO | started process 28871 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp94KmHF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:14:59 INFO - PROCESS | 28871 | RSS: Main: 159240192 04:14:59 INFO - PROCESS | 28871 | 04:15:51 INFO - PROCESS | 28871 | 1467285351383 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:18:03 INFO - PROCESS | 28871 | Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-dojo.html (next: http://localhost:37175/tests/dromaeo/cssquery-ext.html) 04:18:04 INFO - PROCESS | 28871 | RSS: Main: 263766016 04:18:04 INFO - PROCESS | 28871 | 04:21:07 INFO - PROCESS | 28871 | Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-ext.html (next: http://localhost:37175/tests/dromaeo/cssquery-jquery.html) 04:21:07 INFO - PROCESS | 28871 | RSS: Main: 242106368 04:21:07 INFO - PROCESS | 28871 | 04:24:10 INFO - PROCESS | 28871 | Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-jquery.html (next: http://localhost:37175/tests/dromaeo/cssquery-mootools.html) 04:24:10 INFO - PROCESS | 28871 | RSS: Main: 240132096 04:24:10 INFO - PROCESS | 28871 | 04:27:12 INFO - PROCESS | 28871 | Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-mootools.html (next: http://localhost:37175/tests/dromaeo/cssquery-prototype.html) 04:27:13 INFO - PROCESS | 28871 | RSS: Main: 240050176 04:27:13 INFO - PROCESS | 28871 | 04:30:16 INFO - PROCESS | 28871 | Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-prototype.html (next: http://localhost:37175/tests/dromaeo/cssquery-yui.html) 04:30:17 INFO - PROCESS | 28871 | RSS: Main: 220491776 04:30:17 INFO - PROCESS | 28871 | 04:33:20 INFO - PROCESS | 28871 | Cycle 1(1): loaded http://localhost:37175/tests/dromaeo/cssquery-yui.html (next: http://localhost:37175/tests/dromaeo/cssquery-dojo.html) 04:33:20 INFO - PROCESS | 28871 | RSS: Main: 274214912 04:33:20 INFO - PROCESS | 28871 | 04:33:20 INFO - PROCESS | 28871 | __start_tp_report 04:33:20 INFO - PROCESS | 28871 | _x_x_mozilla_page_load 04:33:20 INFO - PROCESS | 28871 | _x_x_mozilla_page_load_details 04:33:20 INFO - PROCESS | 28871 | |i|pagename|runs| 04:33:20 INFO - PROCESS | 28871 | |0;dojo.html;2649.523085844548;2668.2262143978246;2676.384431580736;2706.4181201041774;2715.1854443666894;4706.29405589161;4749.7387643679585;4794.904101917959;4879.1705410080285;4941.036497882914;4746.359241502396;4814.422269327677;4872.025594881029;4881.975590122053;4898.216285394337;4377.693561450707;4403.713758605696;4434.68957172998;4491.505934347219;4572.8399506017295;4498.752568608726;4526.4794548627;4540.205464043779;4551.704139230956;4567.383403240553;4328.43730315057;4370.519242883281;4370.541093185233;4430.468343798765;4456.353828694837;4412.713173643703;4435.556444355571;4439.911201775946;4466.53101424349;4491.483479399878;4415.139047885664;4462.062966776981;4467.374567560544;4479.910401791978;4505.5719706627815;4715.575598196145;4874.46380898101;4926.187179115442;4971.1549036663855;4978.228374601942;5195.0389178001815;5238.81664141757;5248.3701955765555;5316.255724198615;5321.654092484015;5317.760700768436;5330.706811125387;5338.199270109476;5346.117890548055;5364.91952620711;4761.6904901181315;4856.2958371036;4964.429090654621;4968.428630707443;4968.8757781055765;5375;5439.619226654097;5465.562754979672;5466.5900057495055;5466.9179962300595;5182.429932707475;5184.844454666366;5187.740612969336;5236;5240.0567897778;5022.723750193702;5296.682199068068;5346.4386239445075;5349.438308977501;5357.008953343644;5138.6659867109265;5190.636655434083;5199.272101905736;5219.895602087937;5229.450907654717;5173.094708426011;5192.19520974242;5196.090684130262;5210.270562121306;5251.36983561975;4267.637250833652;4295.2053870033515;4419.40338054365;4430.534793846599;4472.932906006413;3792.715546334036;3794.0894185395305;3832.693384529231;3840.9615903840604;3852.3836186210074;4454.910901782011;4472.776361181928;4499.505054444008;4500.437445319335;4505.797239124247;5081.28861959326;5247.370315562081;5248.3701955765555;5249.658772179796;5311.946880531223;4382.298832186835;4386.956130438719;4396.49440314368;4398.274284742982;4409.338599210144;4617.3074038893765;4621.69958952667;4623.653226007996;4623.791929363187;4663.556962088596;4849.612031037438;4868.726575999001;4878.341423907727;4886.438059623189;4902.558769710815;5160.638755287244;5190.870228244324;5197.740112994259;5212.218167274939;5226.033183860998;4927.531884470969;4927.704337739747;4928.6057115431395;4933.6299777516115;4982.427020892499;5039.521245481674;5095.363079615048;5132.743362831919;5132.97433512845;5136.2552429898205;5209.869753256199;5223.033738758342;5230.293910322058;5237.135872581134;5288.9735551322;5034.043531728959;5062.645614807076;5065;5082.034413461431;5118.104331742004;4911.656184067224;5046.914913293659;5053.065182941167;5061.519155680205;5084.288199651977;5062.316587260672;5076.923846142237;5104.923426148685;5110.923336149886;5131.743412829418;5143.665661731976;5156.226566015128;5156.4327923927585;5156.458571849902;5163.715995620277;4859.222524396079;4926.162552366178;4963.230699241623;5003.624728145331;5105.744712764273 04:33:20 INFO - PROCESS | 28871 | |1;ext.html;544.1517661638233;585.6515373352855;593.9020061689819;594.539232095126;597.8385835824326;27861.442771144564;40524.79737601311;41910.16179676405;41935.99999999996;41967;41982;42450.57549424505;42461.57538424615;42474.36288455676;42562.7871860641;7634.083909930816;7910.090339610946;8059.758207253792;8063.193680631948;8068.636911339004;7622.885656715153;7846.215378462137;7885.172056934025;10190.694279171637;10428.947855260712;10523.052925236727;10581.312214706059;10586.311889727182;10597.205209609272;10602.522886470128;10340.844887326659;10395.376277423378;10402.011808878144;10416.218783591223;10430.530626121843;7592.316691497792;10110.747231319203;10492.213084018653;10497.685069447853;10509.211809114271;37325.06687332811;37720;37745.43381849247;40393.59606403957;40561.59438405637;3202.727768139711;3290.572225610655;3295.505674148873;3405.642407547197;3461.6538346165435;29367;29885.402291954255;29994.85002574995;29999.100026999226;30053.549196762066;3510.3330367230146;3538.752287339887;3562.2163124112913;3596.3166998270244;3597.6042635310355;264748;265292;266199;266421;266466;58801.11798323029;59222;59316;59341;59454.108188377206;34085.65914340825;35090.64909350925;35364.29271414557;37227.4415883762;62269.688651556455;14323;14491.130532168103;14497.927510362591;14501.274936253356;14510.782338264935;9672;11612.245204061708;11745.530178792753;11773.17587768848;11793.823092653616;19198.80801191998;19568.072304196998;20455.18179272842;20507.17971281162;20531.794682053285;7361.190269070398;7431.69617418602;7451.329380355685;7517.661705223278;7763.456558040996;769.6151924037981;823.6046697585073;843.4391129898548;902.4900930973979;923.2106548900728;28215.858920705265;28653.570196447068;29159.85420072886;29324.266893327836;29429;954.8615450759601;994.855745916838;1003.8343673293971;1008.002077942846;1012.7265638277771;14778.852211477963;15389.769153462707;15401.614959626098;15475.922620387051;15634.3746250151;409341;414828;415728;418609;418783;49916.75041624768;50294.748526257135;50319.49680503221;50618.24072638914;50791.492085079415;1097.155190503308;1160.2922217447351;1217.5799349224503;1234.9938250308692;1242.6023672424737;28636.713632864237;29742.405151896408;29863.701362986092;30320.241993950327;30400.239994000327;42272.5772742281;42628.36057459203;42657;42706.572934271506;42750;314312;317447;317902;318297;319413;25844;27014.459710806066;27022.864885675444;27038.459230815668;27044.32389190286;41699.7915010423;41914.16171676489;42309.788451057546;43120.56879431291;43254.56745432506;34210.828945856105;34644.653553464144;35015.47476787901;35096;35297;35896.28207435784;36065;36271.27457450889;36630.8168459156;36811.44782828313;35185.824070879484;36093.63906361008;36263.27473450464;36270.8186459066;36645.816770915975;31499.842500788265;32759.508607370433;33024;34426;34469;25144.11995580146;25884.870575647;25895.798857097358;26395.60406593941;26525.469490610467 04:33:20 INFO - PROCESS | 28871 | |2;jquery.html;346.65161512679754;363.1520399866312;364.8066524741886;366.55646667532284;378.26702077490137;13663.863361366384;13896.58310250693;15588.454404095859;18203.453896383096;18232.908835455837;17239;17384.56538586536;17389.652206955852;17393.478195654152;17610.11949402531;4529.818807247714;4825.420949486067;4830.106430310386;4892.730899800509;4906.264060390934;3533.9646603533893;5342.091844386444;5565.109582466806;5581.49766521013;5676.829695109153;5492.670439773627;5663.093904975205;5668.631538949955;5668.886622267552;5677.630953987978;5711.857203569903;5715.0855863062125;5734.627249228808;5736.684482353469;5746.138079288098;5410.702411367373;5546.77812887484;5552.3892371839065;5558.499735023867;5678.290213723285;12950.158239714388;13002.86997130026;13165.802512962313;13181.86818131816;16835.579110522336;1925.7881633020497;1977.13006277239;2066.5143691232547;2086.885221312827;2365.5623709613606;9444.291678124167;9495.38280011797;9696.563654635558;9794.314397992144;9969;1839.1907560673394;1856.4894653970132;1881.5954569767566;1887.9056047197723;1951.0732402109027;68774.3122568773;74407;74623;75353;76560;10199.796004079877;10324.225683073799;10390.844137337946;10528.789424211473;10636.946815266028;14236;14274.429022839178;14303.64240893986;14306.57080287593;14307;6878.27778083304;7111.928880711127;7148.213696493382;7179.96410017957;7245.492815502864;6542.149520562297;6666.200055993215;6733.057371967929;6888.758893438706;6903.482238832108;4338.154059958341;4435.423394958635;4450.777461126931;4554.40595791477;4557.680962332671;1825.8721889467874;1839.4757494114112;1841.3944268859682;1847.2057015483203;1871.4385684294657;762.5882023707136;789.2502122983188;840.0926998841237;870.9695160669346;888.1251966812684;16872.57818554546;17460.738088928676;17672.646547068987;17706.91146544259;18370.08149592515;750.2353826150652;790.9841803163904;848.6181218451721;854.9401541892132;874.4141425245101;9488.430694158373;9818.65634702782;9938.751531211778;10050.798984020279;10205.38767673927;409512;410043;412526;417636;424904;60121;83486.58256708799;84916;85349;85359.57320213359;906.6101576322113;910.39003867409;921.5023887101024;932.4172392254841;937.4000639590668;15523.45667901618;15859.38320177204;15878.206089695701;16164.757528637316;16197.67604647924;38716.61283387243;39408;41211.587884120774;41238.1752364957;43489;54815.72592137014;54964.72517637386;55250;56309;56420.71789641026;7412.629368531444;7611.238876112566;7733.806654833674;7809.882851757115;8010.919890801018;8790.956045219733;9815.165710914653;10904.454777260946;11268.83096753533;11528.59649912249;9399.248060155307;9445.811083778424;9724.659636912675;9906.702798916043;10003.476533399553;5010.473900240422;7166.426685865223;8942.329325300758;9453.716388508356;9597.088276613711;9201.71176035369;9453.858192127262;9904;9993.00069992995;10092.848607271044;7508.174100849012;7509.51188172767;7554.131274903457;7644.464887457824;7775.261350171724;9092.454452732858;9175.54122293896;9345.48599827016;9430.10414010668;9587.952060239653 04:33:20 INFO - PROCESS | 28871 | |3;mootools.html;1255.2907607201923;1382.5575815738964;1422.6230049037003;1514.515355086373;1741.0859298868093;6876.312368763128;7661.348785353245;7901.960490197541;7905.604719764003;7923.168067352932;7654.923450765491;7658.770236892902;7825.843483130348;8084.959575202116;8097.716579919704;1946.5620235446981;2172.3048624440185;2194;2244.708187935574;2250.561140577588;2205.933821985343;2226.443389152712;2226.4545186429345;2231.230225572183;2231.7768223177713;2191.3206905859156;2198.1866709317574;2201.3175915466177;2243.618584840581;2248.955020899581;1863.4223390748912;2123.3417640531484;2157.6332023556033;2159.1039718516877;2191;2225.6550234713645;2249.6175650139517;2251.4033781048033;2252.31304452142;2252.5494901019697;7895.171007044235;7944.443888927777;7948.5628290444;7954.443188976774;7961.601919904039;4560.452745670507;4669.4630117536235;4700.647451441121;4701.764911754432;4705.905881882343;2832.929176770597;3027.909162725122;3031.5452682097643;3036.9848150759326;3044.071558174756;952.6998995316453;997.7455748784087;998.2762497189552;1009.7929924365487;1015.4770293298957;11022.944885275523;11122.277051991676;11159.218854680257;11210.103191744642;11265.831012534818;3985.70107241958;4194.454720886265;4286.207051695384;4315.978420107879;4330.696851220448;9553.426794392359;9596.848378194662;9601.423914565148;9640;9650.758731031781;4807.855764327076;4817.156997525419;4823.3729615150505;4824.469308376076;4829.879253018703;3774.75464094833;4200.894977625584;4349.195398851222;4353.73877567347;4390.495093064274;3699.3341198583976;3744.1949980753725;3758.361078616642;3850.5186851643543;3859.150986782903;1184.9348285844362;1193.5106606291552;1208.1542919956066;1210.0319744204778;1219.8048312269993;631.192074145095;700.3906601256838;779.9883001754978;800.087899794235;819.8975128108987;5106;5243.868903277448;5250.369955605275;5312.335958005249;5348.732563371816;853.6926706385697;853.9615717292612;860.1183786618641;870.0733718589681;880.0539420123393;3358.529805827186;3535.9469607955903;3548.6273941236313;3592.928141437209;3641.7814931104217;9449.858252126223;9800.65697700577;9973.750656233507;10067.69796906094;10202;9906;10026.398416095057;10107.69676909694;10108.545115469822;10110.090091891765;7472.14070381913;7697.730579429693;7706.768796935989;7707.190744971697;7709;4867.70793752376;5107.157319042316;5204.245384419314;5207.1668533034535;5225.1378522543355;8990.100989900957;9282.628694852401;9320.440773553608;9499.097585729345;9506.239500839778;9249.861252081359;9562.56968436436;9710.077542633438;9721.70834874955;9736.513174341397;6723.966380168264;6982.197047339621;7003;7137.250588688113;7141.678624461808;7344.669489872862;7489.176190619137;7489.850202996018;7503.212162722835;7516.812079698051;5405.621606487665;6758.222804377559;6843.110395648534;7008.929910700827;7231.2768723127265;6874.346937040973;6884.105066341343;7024.1571011478945;7156;7175.425965922818;6037.275526936795;6038.124471951454;6049.153118563493;6090.604110732788;6100.633961962297;4377.774223217504;4393.890152746207;4459.197344478025;4514.61625761814;4703.3415321855655;4536.7051141677;4635.281531362644;4639.791209395653;4656.3713898623255;4705.223638099676 04:33:20 INFO - PROCESS | 28871 | |4;prototype.html;297.7647658349902;301.2423754258041;308.2986206380484;309.72743985292936;311.5622550316806;4937.358143441352;4965.230389289657;4974.41330508136;4987.700737955721;4989.2017277235645;4648.53514648535;4757.666963312561;4780.784864681089;4794.928076078853;4914.655974081816;3757.380032294668;3789.9052523686923;3822.847086116552;3842.5004749382542;3866.845326186963;3804.127883447993;3840;3841.673457756094;3842.51968503937;3847.403652433863;3629.2922880038404;3826.4834247376525;3826.7703937763686;3843;3863.0728625130046;3813.3326667833016;3813.733038687293;3814.19901820618;3828.349180639298;3829.138443850139;3347.6317605063423;3353.295807880348;3353.9329213415594;3359.227377703142;3362.663733626642;4827.9034419311765;4853.466118726938;4858.562729354339;4861.392325959255;4882.3408839806525;4119.032027473541;4326.632236259922;4335.674824388184;4341.7829108544765;4392.582704643054;5005.399352077774;5039.546440820343;5075.796968121308;5086.542211200973;5091.338126043591;3624.9456258156147;3627.4014787560022;3635.000374896898;3641.1261297288725;3643.344198044351;5041.495850414965;5294.602904782157;5304.628675992643;5317.601179911522;5345.812896548602;3692.51997240357;3698.1863989922176;3699.408094704834;3717.2937141942944;3731.7760934343482;3750.268697603941;3784.545854497423;3786.8260839139953;3786.8295926683363;3792.1657235408165;4287.6355509782015;4296.871093867189;4299.9570004300185;4304.139172165579;4307.612314891675;4847.2729090635985;5039.974800125976;5045.747712614355;5071.46749591295;5073.289739436482;1236.6166488388449;1276.7957126859844;1300.4473098933104;1301.0892375337303;1307.300594182127;835.9582020898931;847.809242920338;852.2925971443686;858.6093327536081;867.8524650809378;4438.201123797748;4455.108978204372;4463.330500424962;4468.486124095771;4472.457002334189;5156.561692256125;5164.690118592896;5165.612579056586;5180.7566184116295;5181.611379146504;4384;4453.242948698664;4457.799399027052;4589.426321709786;4595.540445955377;2820.8871645134377;2826.2792987788393;2842.971570284312;2844.431113777253;2849.5868099125923;5057.544820966131;5062.6709263898465;5067.3412456381175;5101.668391554537;5106.361704786902;5148.716820574904;5431.2396264522995;5437.728113594384;5461.726913654302;5479.698616576126;4997.5002499749735;5006.89986200274;5009.7495125243595;5038.571721403721;5046.571041461517;5150.667476332221;5288.444713305202;5299.814506492255;5318.388385335581;5334.51989320963;5052.9747351263;5135.460776618401;5158.97420512895;5160.354955630546;5178.171492561172;4990.7523119220195;4996.375453068366;5013.323201367769;5026.497350265091;5073.492650735045;3683.263347330491;3701.3892707702926;3749.906252343604;3750.981245093757;3757.6618104370737;5129.435762066095;5304.151335786256;5315.681059136464;5323.787048518016;5355.196720491957;5142.228665700175;5150.9227361588855;5157.561607263425;5159.936025589795;5224.7648855802345;4987.600991920565;5159.922601160911;5161.509656582619;5168.483151684802;5223.738813059408;4798.368554691422;4923.335349727741;5027.522385373383;5054.570361519165;5058.570021548209;5166.819161329336;5177.602047447092;5177.896442071062;5189.377274726906;5210.687358758487;5042.546170844642;5047.772850221822;5051.217061355495;5058.317127187783;5100.26046223303 04:33:20 INFO - PROCESS | 28871 | |5;yui.html;646.4505170604983;659.5317324699463;683.9384455399014;728.4536597551833;790.5019837502373;11608.12939029573;12066.939665301661;12137.029037676975;12213.145079844404;12423.627291181256;12252.632421027383;12470.127091103626;12473.189242699218;12476.750464990717;12482.18865773724;636.1920361141348;762.7521055656906;766.8964689766893;791.0902462168524;791.8851766493855;797.9800504987393;798.9920100798976;799.1289494451047;804.7545498622918;805.6857825448051;842.2756429470651;846.5259454705354;846.7671390367636;847.474565769224;847.6100993542977;658.9571677840974;803.1727320859466;828.9792755181109;840.0255703384075;841.0958219913617;608.2579253310954;609.9207103076571;610.575649923299;610.8808782287456;611.0376157551874;12563.874361256361;12580.245185288912;12594;12626.936865315614;12637.49450021998;10545.578176872916;10612.363258204456;10829;10984.505697243643;11381.886181138249;10826.458677066115;10873.673789786319;10988.560457581687;11013.339199648046;11164.665060048212;3546.804925729084;3601.404697267809;3654.835532401048;3681.0245284999496;3719.925601487955;59698.70150649219;60064;60630.393696062914;60637.69681151566;60670.696646516924;9866.358686685342;10101.090901818872;10261.794764104676;10285.588576456857;10295.176385889112;18319.725204121947;18456.35402760924;18481.630367392576;18506.167222475022;18526.907365463085;6495.447886929569;6590.868182636321;6630.834229144213;6709.7651582194385;6835.282295359015;3142.3872344892984;3632.2372301816386;3669.321175582526;3690.1697118148204;3755.117547376364;2762.7237276272213;3206.4228438881223;3354.580677415323;3359.8320083995704;3393.5079413484905;533.88788354446;539.134688824439;545.6262460214765;556.791203298763;559.2226804741413;524.5462674786282;549.9007809183423;550.6940627058322;595.214317101422;597.4981015946626;7679.539227646359;7704.191059938737;7798.142204357516;7884.72403465876;7898.565578893216;590.2297501760244;590.2916500199777;600.7626987339976;603.9516838652897;611.8806832667588;3633.8183090845882;3882.1847412043785;3924.843006279717;3948.7433316834313;3969.92060158801;59267;76065.61967190128;104802;106161.46919265355;106644.46677766561;96087.51956240174;96643.51678241564;96984.51507742416;97042;97278;47559.762201189464;70870.2912970874;80243.59878200572;81103;82506;6999.160100787938;7088.113985751781;7187.101612298463;7245.2030276670575;7263;46873.53126468828;46892.29661555011;46936;48507.27239091346;49084.75457622689;63555.36444635494;69522;72080;73543.63228183825;74736.62631686807;10454.947725261325;10484.161267098767;10913.126949844152;10992.120630349393;11034.944825275823;12706.87293127057;12924.870751292743;13060.869391305965;13143.079984401382;13491.527796527074;11579.536818527165;11755.88244117548;11929.582464613697;12146.331951742386;12433.75132497327;11210.775784484427;11367.886321137014;11889.524419023142;11899.524019039141;11936.403179841147;10778.514966826355;11052.889471105185;11217.49521271561;11369.772604548029;11635.825462617899;9553.665621703207;9571.425714457155;9731.12419882214;9962.501874906371;10101.848472273068;9123.954380228057;9354;9407.576659050223;9724.9027509724;9832 04:33:20 INFO - PROCESS | 28871 | __end_tp_report 04:33:20 INFO - PROCESS | 28871 | __start_cc_report 04:33:20 INFO - PROCESS | 28871 | _x_x_mozilla_cycle_collect,1072 04:33:20 INFO - PROCESS | 28871 | __end_cc_report 04:33:20 INFO - PROCESS | 28871 | __startTimestamp1467286400507__endTimestamp 04:33:20 INFO - PROCESS | 28871 | 04:33:20 INFO - PROCESS | 28871 | ------- Summary: start ------- 04:33:20 INFO - PROCESS | 28871 | Number of tests: 6 04:33:20 INFO - PROCESS | 28871 | 04:33:20 INFO - PROCESS | 28871 | [#0] dojo.html Cycles:165 Average:4817.89 Median:4963.23 stddev:531.02 (10.7%) stddev-sans-first:504.67 04:33:20 INFO - PROCESS | 28871 | Values: 2649.5 2668.2 2676.4 2706.4 2715.2 4706.3 4749.7 4794.9 4879.2 4941.0 4746.4 4814.4 4872.0 4882.0 4898.2 4377.7 4403.7 4434.7 4491.5 4572.8 4498.8 4526.5 4540.2 4551.7 4567.4 4328.4 4370.5 4370.5 4430.5 4456.4 4412.7 4435.6 4439.9 4466.5 4491.5 4415.1 4462.1 4467.4 4479.9 4505.6 4715.6 4874.5 4926.2 4971.2 4978.2 5195.0 5238.8 5248.4 5316.3 5321.7 5317.8 5330.7 5338.2 5346.1 5364.9 4761.7 4856.3 4964.4 4968.4 4968.9 5375.0 5439.6 5465.6 5466.6 5466.9 5182.4 5184.8 5187.7 5236.0 5240.1 5022.7 5296.7 5346.4 5349.4 5357.0 5138.7 5190.6 5199.3 5219.9 5229.5 5173.1 5192.2 5196.1 5210.3 5251.4 4267.6 4295.2 4419.4 4430.5 4472.9 3792.7 3794.1 3832.7 3841.0 3852.4 4454.9 4472.8 4499.5 4500.4 4505.8 5081.3 5247.4 5248.4 5249.7 5311.9 4382.3 4387.0 4396.5 4398.3 4409.3 4617.3 4621.7 4623.7 4623.8 4663.6 4849.6 4868.7 4878.3 4886.4 4902.6 5160.6 5190.9 5197.7 5212.2 5226.0 4927.5 4927.7 4928.6 4933.6 4982.4 5039.5 5095.4 5132.7 5133.0 5136.3 5209.9 5223.0 5230.3 5237.1 5289.0 5034.0 5062.6 5065.0 5082.0 5118.1 4911.7 5046.9 5053.1 5061.5 5084.3 5062.3 5076.9 5104.9 5110.9 5131.7 5143.7 5156.2 5156.4 5156.5 5163.7 4859.2 4926.2 4963.2 5003.6 5105.7 04:33:20 INFO - PROCESS | 28871 | 04:33:20 INFO - PROCESS | 28871 | [#1] ext.html Cycles:180 Average:48968.12 Median:19053.15 stddev:89147.10 (467.9%) stddev-sans-first:89323.04 04:33:20 INFO - PROCESS | 28871 | Values: 544.2 585.7 593.9 594.5 597.8 27861.4 40524.8 41910.2 41936.0 41967.0 41982.0 42450.6 42461.6 42474.4 42562.8 7634.1 7910.1 8059.8 8063.2 8068.6 7622.9 7846.2 7885.2 10190.7 10428.9 10523.1 10581.3 10586.3 10597.2 10602.5 10340.8 10395.4 10402.0 10416.2 10430.5 7592.3 10110.7 10492.2 10497.7 10509.2 37325.1 37720.0 37745.4 40393.6 40561.6 3202.7 3290.6 3295.5 3405.6 3461.7 29367.0 29885.4 29994.9 29999.1 30053.5 3510.3 3538.8 3562.2 3596.3 3597.6 264748.0 265292.0 266199.0 266421.0 266466.0 58801.1 59222.0 59316.0 59341.0 59454.1 34085.7 35090.6 35364.3 37227.4 62269.7 14323.0 14491.1 14497.9 14501.3 14510.8 9672.0 11612.2 11745.5 11773.2 11793.8 19198.8 19568.1 20455.2 20507.2 20531.8 7361.2 7431.7 7451.3 7517.7 7763.5 769.6 823.6 843.4 902.5 923.2 28215.9 28653.6 29159.9 29324.3 29429.0 954.9 994.9 1003.8 1008.0 1012.7 14778.9 15389.8 15401.6 15475.9 15634.4 409341.0 414828.0 415728.0 418609.0 418783.0 49916.8 50294.7 50319.5 50618.2 50791.5 1097.2 1160.3 1217.6 1235.0 1242.6 28636.7 29742.4 29863.7 30320.2 30400.2 42272.6 42628.4 42657.0 42706.6 42750.0 314312.0 317447.0 317902.0 318297.0 319413.0 25844.0 27014.5 27022.9 27038.5 27044.3 41699.8 41914.2 42309.8 43120.6 43254.6 34210.8 34644.7 35015.5 35096.0 35297.0 35896.3 36065.0 36271.3 36630.8 36811.4 35185.8 36093.6 36263.3 36270.8 36645.8 31499.8 32759.5 33024.0 34426.0 34469.0 25144.1 25884.9 25895.8 26395.6 26525.5 04:33:20 INFO - PROCESS | 28871 | 04:33:20 INFO - PROCESS | 28871 | [#2] jquery.html Cycles:180 Average:25181.64 Median:5549.58 stddev:68654.05 (1237.1%) stddev-sans-first:68821.32 04:33:20 INFO - PROCESS | 28871 | Values: 346.7 363.2 364.8 366.6 378.3 13663.9 13896.6 15588.5 18203.5 18232.9 17239.0 17384.6 17389.7 17393.5 17610.1 4529.8 4825.4 4830.1 4892.7 4906.3 3534.0 5342.1 5565.1 5581.5 5676.8 5492.7 5663.1 5668.6 5668.9 5677.6 5711.9 5715.1 5734.6 5736.7 5746.1 5410.7 5546.8 5552.4 5558.5 5678.3 12950.2 13002.9 13165.8 13181.9 16835.6 1925.8 1977.1 2066.5 2086.9 2365.6 9444.3 9495.4 9696.6 9794.3 9969.0 1839.2 1856.5 1881.6 1887.9 1951.1 68774.3 74407.0 74623.0 75353.0 76560.0 10199.8 10324.2 10390.8 10528.8 10636.9 14236.0 14274.4 14303.6 14306.6 14307.0 6878.3 7111.9 7148.2 7180.0 7245.5 6542.1 6666.2 6733.1 6888.8 6903.5 4338.2 4435.4 4450.8 4554.4 4557.7 1825.9 1839.5 1841.4 1847.2 1871.4 762.6 789.3 840.1 871.0 888.1 16872.6 17460.7 17672.6 17706.9 18370.1 750.2 791.0 848.6 854.9 874.4 9488.4 9818.7 9938.8 10050.8 10205.4 409512.0 410043.0 412526.0 417636.0 424904.0 60121.0 83486.6 84916.0 85349.0 85359.6 906.6 910.4 921.5 932.4 937.4 15523.5 15859.4 15878.2 16164.8 16197.7 38716.6 39408.0 41211.6 41238.2 43489.0 54815.7 54964.7 55250.0 56309.0 56420.7 7412.6 7611.2 7733.8 7809.9 8010.9 8791.0 9815.2 10904.5 11268.8 11528.6 9399.2 9445.8 9724.7 9906.7 10003.5 5010.5 7166.4 8942.3 9453.7 9597.1 9201.7 9453.9 9904.0 9993.0 10092.8 7508.2 7509.5 7554.1 7644.5 7775.3 9092.5 9175.5 9345.5 9430.1 9588.0 04:33:20 INFO - PROCESS | 28871 | 04:33:20 INFO - PROCESS | 28871 | [#3] mootools.html Cycles:180 Average:5247.37 Median:4823.92 stddev:3005.57 (62.3%) stddev-sans-first:2999.03 04:33:20 INFO - PROCESS | 28871 | Values: 1255.3 1382.6 1422.6 1514.5 1741.1 6876.3 7661.3 7902.0 7905.6 7923.2 7654.9 7658.8 7825.8 8085.0 8097.7 1946.6 2172.3 2194.0 2244.7 2250.6 2205.9 2226.4 2226.5 2231.2 2231.8 2191.3 2198.2 2201.3 2243.6 2249.0 1863.4 2123.3 2157.6 2159.1 2191.0 2225.7 2249.6 2251.4 2252.3 2252.5 7895.2 7944.4 7948.6 7954.4 7961.6 4560.5 4669.5 4700.6 4701.8 4705.9 2832.9 3027.9 3031.5 3037.0 3044.1 952.7 997.7 998.3 1009.8 1015.5 11022.9 11122.3 11159.2 11210.1 11265.8 3985.7 4194.5 4286.2 4316.0 4330.7 9553.4 9596.8 9601.4 9640.0 9650.8 4807.9 4817.2 4823.4 4824.5 4829.9 3774.8 4200.9 4349.2 4353.7 4390.5 3699.3 3744.2 3758.4 3850.5 3859.2 1184.9 1193.5 1208.2 1210.0 1219.8 631.2 700.4 780.0 800.1 819.9 5106.0 5243.9 5250.4 5312.3 5348.7 853.7 854.0 860.1 870.1 880.1 3358.5 3535.9 3548.6 3592.9 3641.8 9449.9 9800.7 9973.8 10067.7 10202.0 9906.0 10026.4 10107.7 10108.5 10110.1 7472.1 7697.7 7706.8 7707.2 7709.0 4867.7 5107.2 5204.2 5207.2 5225.1 8990.1 9282.6 9320.4 9499.1 9506.2 9249.9 9562.6 9710.1 9721.7 9736.5 6724.0 6982.2 7003.0 7137.3 7141.7 7344.7 7489.2 7489.9 7503.2 7516.8 5405.6 6758.2 6843.1 7008.9 7231.3 6874.3 6884.1 7024.2 7156.0 7175.4 6037.3 6038.1 6049.2 6090.6 6100.6 4377.8 4393.9 4459.2 4514.6 4703.3 4536.7 4635.3 4639.8 4656.4 4705.2 04:33:20 INFO - PROCESS | 28871 | 04:33:20 INFO - PROCESS | 28871 | [#4] prototype.html Cycles:180 Average:4254.48 Median:4898.50 stddev:1238.09 (25.3%) stddev-sans-first:1205.42 04:33:20 INFO - PROCESS | 28871 | Values: 297.8 301.2 308.3 309.7 311.6 4937.4 4965.2 4974.4 4987.7 4989.2 4648.5 4757.7 4780.8 4794.9 4914.7 3757.4 3789.9 3822.8 3842.5 3866.8 3804.1 3840.0 3841.7 3842.5 3847.4 3629.3 3826.5 3826.8 3843.0 3863.1 3813.3 3813.7 3814.2 3828.3 3829.1 3347.6 3353.3 3353.9 3359.2 3362.7 4827.9 4853.5 4858.6 4861.4 4882.3 4119.0 4326.6 4335.7 4341.8 4392.6 5005.4 5039.5 5075.8 5086.5 5091.3 3624.9 3627.4 3635.0 3641.1 3643.3 5041.5 5294.6 5304.6 5317.6 5345.8 3692.5 3698.2 3699.4 3717.3 3731.8 3750.3 3784.5 3786.8 3786.8 3792.2 4287.6 4296.9 4300.0 4304.1 4307.6 4847.3 5040.0 5045.7 5071.5 5073.3 1236.6 1276.8 1300.4 1301.1 1307.3 836.0 847.8 852.3 858.6 867.9 4438.2 4455.1 4463.3 4468.5 4472.5 5156.6 5164.7 5165.6 5180.8 5181.6 4384.0 4453.2 4457.8 4589.4 4595.5 2820.9 2826.3 2843.0 2844.4 2849.6 5057.5 5062.7 5067.3 5101.7 5106.4 5148.7 5431.2 5437.7 5461.7 5479.7 4997.5 5006.9 5009.7 5038.6 5046.6 5150.7 5288.4 5299.8 5318.4 5334.5 5053.0 5135.5 5159.0 5160.4 5178.2 4990.8 4996.4 5013.3 5026.5 5073.5 3683.3 3701.4 3749.9 3751.0 3757.7 5129.4 5304.2 5315.7 5323.8 5355.2 5142.2 5150.9 5157.6 5159.9 5224.8 4987.6 5159.9 5161.5 5168.5 5223.7 4798.4 4923.3 5027.5 5054.6 5058.6 5166.8 5177.6 5177.9 5189.4 5210.7 5042.5 5047.8 5051.2 5058.3 5100.3 04:33:20 INFO - PROCESS | 28871 | 04:33:20 INFO - PROCESS | 28871 | [#5] yui.html Cycles:180 Average:17950.00 Median:536.51 stddev:26392.76 (4919.3%) stddev-sans-first:26434.82 04:33:20 INFO - PROCESS | 28871 | Values: 646.5 659.5 683.9 728.5 790.5 11608.1 12066.9 12137.0 12213.1 12423.6 12252.6 12470.1 12473.2 12476.8 12482.2 636.2 762.8 766.9 791.1 791.9 798.0 799.0 799.1 804.8 805.7 842.3 846.5 846.8 847.5 847.6 659.0 803.2 829.0 840.0 841.1 608.3 609.9 610.6 610.9 611.0 12563.9 12580.2 12594.0 12626.9 12637.5 10545.6 10612.4 10829.0 10984.5 11381.9 10826.5 10873.7 10988.6 11013.3 11164.7 3546.8 3601.4 3654.8 3681.0 3719.9 59698.7 60064.0 60630.4 60637.7 60670.7 9866.4 10101.1 10261.8 10285.6 10295.2 18319.7 18456.4 18481.6 18506.2 18526.9 6495.4 6590.9 6630.8 6709.8 6835.3 3142.4 3632.2 3669.3 3690.2 3755.1 2762.7 3206.4 3354.6 3359.8 3393.5 533.9 539.1 545.6 556.8 559.2 524.5 549.9 550.7 595.2 597.5 7679.5 7704.2 7798.1 7884.7 7898.6 590.2 590.3 600.8 604.0 611.9 3633.8 3882.2 3924.8 3948.7 3969.9 59267.0 76065.6 104802.0 106161.5 106644.5 96087.5 96643.5 96984.5 97042.0 97278.0 47559.8 70870.3 80243.6 81103.0 82506.0 6999.2 7088.1 7187.1 7245.2 7263.0 46873.5 46892.3 46936.0 48507.3 49084.8 63555.4 69522.0 72080.0 73543.6 74736.6 10454.9 10484.2 10913.1 10992.1 11034.9 12706.9 12924.9 13060.9 13143.1 13491.5 11579.5 11755.9 11929.6 12146.3 12433.8 11210.8 11367.9 11889.5 11899.5 11936.4 10778.5 11052.9 11217.5 11369.8 11635.8 9553.7 9571.4 9731.1 9962.5 10101.8 9124.0 9354.0 9407.6 9724.9 9832.0 04:33:20 INFO - PROCESS | 28871 | -------- Summary: end -------- 04:33:20 INFO - PROCESS | 28871 | 04:33:21 INFO - TEST-INFO | 28871: exit 0 04:33:21 INFO - TEST-OK | dromaeo_css | took 1119859ms 04:33:21 INFO - TEST-START | kraken 04:33:21 INFO - operating with platform_type : linux_ 04:33:21 INFO - Initialising browser for kraken test... 04:33:21 INFO - TEST-INFO | started process 29062 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnb2TCL/profile http://localhost:37175/getInfo.html) 04:33:25 INFO - PROCESS | 29062 | __metrics Screen width/height:1600/1200 04:33:25 INFO - PROCESS | 29062 | colorDepth:24 04:33:25 INFO - PROCESS | 29062 | Browser inner width/height: 1024/697 04:33:25 INFO - PROCESS | 29062 | __metrics 04:33:26 INFO - PROCESS | 29062 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:27 INFO - TEST-INFO | 29062: exit 0 04:33:27 INFO - Browser initialized. 04:33:27 INFO - Running cycle 1/1 for kraken test... 04:33:27 INFO - TEST-INFO | started process 29143 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnb2TCL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:39 INFO - PROCESS | 29143 | RSS: Main: 159182848 04:33:39 INFO - PROCESS | 29143 | 04:33:41 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:37175/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:42 INFO - PROCESS | 29143 | RSS: Main: 217391104 04:33:42 INFO - PROCESS | 29143 | 04:33:45 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:37175/tests/kraken/driver.html?testName=audio-dft) 04:33:46 INFO - PROCESS | 29143 | RSS: Main: 205828096 04:33:46 INFO - PROCESS | 29143 | 04:33:49 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:37175/tests/kraken/driver.html?testName=audio-fft) 04:33:50 INFO - PROCESS | 29143 | RSS: Main: 271429632 04:33:50 INFO - PROCESS | 29143 | 04:33:52 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:37175/tests/kraken/driver.html?testName=audio-oscillator) 04:33:52 INFO - PROCESS | 29143 | RSS: Main: 181452800 04:33:52 INFO - PROCESS | 29143 | 04:33:55 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:37175/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:55 INFO - PROCESS | 29143 | RSS: Main: 185761792 04:33:55 INFO - PROCESS | 29143 | 04:33:58 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:37175/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:59 INFO - PROCESS | 29143 | RSS: Main: 221986816 04:33:59 INFO - PROCESS | 29143 | 04:34:02 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:37175/tests/kraken/driver.html?testName=imaging-desaturate) 04:34:03 INFO - PROCESS | 29143 | RSS: Main: 217399296 04:34:03 INFO - PROCESS | 29143 | 04:34:06 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:37175/tests/kraken/driver.html?testName=json-parse-financial) 04:34:07 INFO - PROCESS | 29143 | RSS: Main: 220364800 04:34:07 INFO - PROCESS | 29143 | 04:34:08 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:37175/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:34:09 INFO - PROCESS | 29143 | RSS: Main: 207613952 04:34:09 INFO - PROCESS | 29143 | 04:34:11 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:34:11 INFO - PROCESS | 29143 | RSS: Main: 211271680 04:34:11 INFO - PROCESS | 29143 | 04:34:14 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:14 INFO - PROCESS | 29143 | RSS: Main: 216727552 04:34:14 INFO - PROCESS | 29143 | 04:34:17 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:18 INFO - PROCESS | 29143 | RSS: Main: 226033664 04:34:18 INFO - PROCESS | 29143 | 04:34:21 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:21 INFO - PROCESS | 29143 | RSS: Main: 226435072 04:34:21 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | Cycle 1(1): loaded http://localhost:37175/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:37175/tests/kraken/driver.html?testName=ai-astar) 04:34:23 INFO - PROCESS | 29143 | RSS: Main: 268869632 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | __start_tp_report 04:34:23 INFO - PROCESS | 29143 | _x_x_mozilla_page_load 04:34:23 INFO - PROCESS | 29143 | _x_x_mozilla_page_load_details 04:34:23 INFO - PROCESS | 29143 | |i|pagename|runs| 04:34:23 INFO - PROCESS | 29143 | |0;ai-astar;109;117;115;113;117;115;113;114;114;114 04:34:23 INFO - PROCESS | 29143 | |1;audio-beat-detection;156;125;128;186;124;124;149;123;165;131 04:34:23 INFO - PROCESS | 29143 | |2;audio-dft;162;161;162;160;163;160;161;162;163;161 04:34:23 INFO - PROCESS | 29143 | |3;audio-fft;77;76;84;130;77;76;76;76;107;76 04:34:23 INFO - PROCESS | 29143 | |4;audio-oscillator;85;85;119;85;85;85;115;85;86;125 04:34:23 INFO - PROCESS | 29143 | |5;imaging-gaussian-blur;117;118;117;117;116;117;116;116;117;117 04:34:23 INFO - PROCESS | 29143 | |6;imaging-darkroom;147;147;146;146;146;147;147;148;146;147 04:34:23 INFO - PROCESS | 29143 | |7;imaging-desaturate;94;95;95;94;95;95;95;95;95;96 04:34:23 INFO - PROCESS | 29143 | |8;json-parse-financial;63;63;64;63;64;64;64;63;64;64 04:34:23 INFO - PROCESS | 29143 | |9;json-stringify-tinderbox;64;64;64;64;64;65;64;65;64;64 04:34:23 INFO - PROCESS | 29143 | |10;stanford-crypto-aes;79;87;78;79;88;78;82;83;88;81 04:34:23 INFO - PROCESS | 29143 | |11;stanford-crypto-ccm;137;130;141;133;124;128;129;130;165;129 04:34:23 INFO - PROCESS | 29143 | |12;stanford-crypto-pbkdf2;173;167;172;165;171;171;165;171;172;168 04:34:23 INFO - PROCESS | 29143 | |13;stanford-crypto-sha256-iterative;66;67;69;67;67;67;69;67;66;67 04:34:23 INFO - PROCESS | 29143 | __end_tp_report 04:34:23 INFO - PROCESS | 29143 | __start_cc_report 04:34:23 INFO - PROCESS | 29143 | _x_x_mozilla_cycle_collect,1954 04:34:23 INFO - PROCESS | 29143 | __end_cc_report 04:34:23 INFO - PROCESS | 29143 | __startTimestamp1467286463712__endTimestamp 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | ------- Summary: start ------- 04:34:23 INFO - PROCESS | 29143 | Number of tests: 14 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#0] ai-astar Cycles:10 Average:114.10 Median:114.50 stddev:2.28 (2.0%) stddev-sans-first:1.50 04:34:23 INFO - PROCESS | 29143 | Values: 109.0 117.0 115.0 113.0 117.0 115.0 113.0 114.0 114.0 114.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#1] audio-beat-detection Cycles:10 Average:141.10 Median:140.00 stddev:21.90 (15.6%) stddev-sans-first:22.56 04:34:23 INFO - PROCESS | 29143 | Values: 156.0 125.0 128.0 186.0 124.0 124.0 149.0 123.0 165.0 131.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#2] audio-dft Cycles:10 Average:161.50 Median:162.00 stddev:1.08 (0.7%) stddev-sans-first:1.13 04:34:23 INFO - PROCESS | 29143 | Values: 162.0 161.0 162.0 160.0 163.0 160.0 161.0 162.0 163.0 161.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#3] audio-fft Cycles:10 Average:85.50 Median:76.00 stddev:18.38 (24.2%) stddev-sans-first:19.24 04:34:23 INFO - PROCESS | 29143 | Values: 77.0 76.0 84.0 130.0 77.0 76.0 76.0 76.0 107.0 76.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#4] audio-oscillator Cycles:10 Average:95.50 Median:85.00 stddev:16.85 (19.8%) stddev-sans-first:17.44 04:34:23 INFO - PROCESS | 29143 | Values: 85.0 85.0 119.0 85.0 85.0 85.0 115.0 85.0 86.0 125.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 04:34:23 INFO - PROCESS | 29143 | Values: 117.0 118.0 117.0 117.0 116.0 117.0 116.0 116.0 117.0 117.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.71 04:34:23 INFO - PROCESS | 29143 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 147.0 148.0 146.0 147.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.50 04:34:23 INFO - PROCESS | 29143 | Values: 94.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 96.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:0.52 (0.8%) stddev-sans-first:0.50 04:34:23 INFO - PROCESS | 29143 | Values: 63.0 63.0 64.0 63.0 64.0 64.0 64.0 63.0 64.0 64.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#9] json-stringify-tinderbox Cycles:10 Average:64.20 Median:64.00 stddev:0.42 (0.7%) stddev-sans-first:0.44 04:34:23 INFO - PROCESS | 29143 | Values: 64.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 64.0 64.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#10] stanford-crypto-aes Cycles:10 Average:82.30 Median:82.50 stddev:4.06 (4.9%) stddev-sans-first:4.12 04:34:23 INFO - PROCESS | 29143 | Values: 79.0 87.0 78.0 79.0 88.0 78.0 82.0 83.0 88.0 81.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#11] stanford-crypto-ccm Cycles:10 Average:134.60 Median:131.50 stddev:11.71 (8.9%) stddev-sans-first:12.39 04:34:23 INFO - PROCESS | 29143 | Values: 137.0 130.0 141.0 133.0 124.0 128.0 129.0 130.0 165.0 129.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.50 Median:171.00 stddev:2.99 (1.7%) stddev-sans-first:2.89 04:34:23 INFO - PROCESS | 29143 | Values: 173.0 167.0 172.0 165.0 171.0 171.0 165.0 171.0 172.0 168.0 04:34:23 INFO - PROCESS | 29143 | 04:34:23 INFO - PROCESS | 29143 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.20 Median:67.00 stddev:1.03 (1.5%) stddev-sans-first:1.00 04:34:23 INFO - PROCESS | 29143 | Values: 66.0 67.0 69.0 67.0 67.0 67.0 69.0 67.0 66.0 67.0 04:34:23 INFO - PROCESS | 29143 | -------- Summary: end -------- 04:34:23 INFO - PROCESS | 29143 | 04:34:24 INFO - TEST-INFO | 29143: exit 0 04:34:24 INFO - TEST-OK | kraken | took 63502ms 04:34:24 INFO - SUITE-END | took 1183s 04:34:24 INFO - Completed test suite (00:19:43) 04:34:24 INFO - javascript benchmark 04:34:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2649.523085844548, 2668.2262143978246, 2676.384431580736, 2706.4181201041774, 2715.1854443666894, 4706.29405589161, 4749.7387643679585, 4794.904101917959, 4879.1705410080285, 4941.036497882914, 4746.359241502396, 4814.422269327677, 4872.025594881029, 4881.975590122053, 4898.216285394337, 4377.693561450707, 4403.713758605696, 4434.68957172998, 4491.505934347219, 4572.8399506017295, 4498.752568608726, 4526.4794548627, 4540.205464043779, 4551.704139230956, 4567.383403240553, 4328.43730315057, 4370.519242883281, 4370.541093185233, 4430.468343798765, 4456.353828694837, 4412.713173643703, 4435.556444355571, 4439.911201775946, 4466.53101424349, 4491.483479399878, 4415.139047885664, 4462.062966776981, 4467.374567560544, 4479.910401791978, 4505.5719706627815, 4715.575598196145, 4874.46380898101, 4926.187179115442, 4971.1549036663855, 4978.228374601942, 5195.0389178001815, 5238.81664141757, 5248.3701955765555, 5316.255724198615, 5321.654092484015, 5317.760700768436, 5330.706811125387, 5338.199270109476, 5346.117890548055, 5364.91952620711, 4761.6904901181315, 4856.2958371036, 4964.429090654621, 4968.428630707443, 4968.8757781055765, 5375.0, 5439.619226654097, 5465.562754979672, 5466.5900057495055, 5466.9179962300595, 5182.429932707475, 5184.844454666366, 5187.740612969336, 5236.0, 5240.0567897778, 5022.723750193702, 5296.682199068068, 5346.4386239445075, 5349.438308977501, 5357.008953343644, 5138.6659867109265, 5190.636655434083, 5199.272101905736, 5219.895602087937, 5229.450907654717, 5173.094708426011, 5192.19520974242, 5196.090684130262, 5210.270562121306, 5251.36983561975, 4267.637250833652, 4295.2053870033515, 4419.40338054365, 4430.534793846599, 4472.932906006413, 3792.715546334036, 3794.0894185395305, 3832.693384529231, 3840.9615903840604, 3852.3836186210074, 4454.910901782011, 4472.776361181928, 4499.505054444008, 4500.437445319335, 4505.797239124247, 5081.28861959326, 5247.370315562081, 5248.3701955765555, 5249.658772179796, 5311.946880531223, 4382.298832186835, 4386.956130438719, 4396.49440314368, 4398.274284742982, 4409.338599210144, 4617.3074038893765, 4621.69958952667, 4623.653226007996, 4623.791929363187, 4663.556962088596, 4849.612031037438, 4868.726575999001, 4878.341423907727, 4886.438059623189, 4902.558769710815, 5160.638755287244, 5190.870228244324, 5197.740112994259, 5212.218167274939, 5226.033183860998, 4927.531884470969, 4927.704337739747, 4928.6057115431395, 4933.6299777516115, 4982.427020892499, 5039.521245481674, 5095.363079615048, 5132.743362831919, 5132.97433512845, 5136.2552429898205, 5209.869753256199, 5223.033738758342, 5230.293910322058, 5237.135872581134, 5288.9735551322, 5034.043531728959, 5062.645614807076, 5065.0, 5082.034413461431, 5118.104331742004, 4911.656184067224, 5046.914913293659, 5053.065182941167, 5061.519155680205, 5084.288199651977, 5062.316587260672, 5076.923846142237, 5104.923426148685, 5110.923336149886, 5131.743412829418, 5143.665661731976, 5156.226566015128, 5156.4327923927585, 5156.458571849902, 5163.715995620277, 4859.222524396079, 4926.162552366178, 4963.230699241623, 5003.624728145331, 5105.744712764273], "value": 4782.49877262813, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [544.1517661638233, 585.6515373352855, 593.9020061689819, 594.539232095126, 597.8385835824326, 27861.442771144564, 40524.79737601311, 41910.16179676405, 41935.99999999996, 41967.0, 41982.0, 42450.57549424505, 42461.57538424615, 42474.36288455676, 42562.7871860641, 7634.083909930816, 7910.090339610946, 8059.758207253792, 8063.193680631948, 8068.636911339004, 7622.885656715153, 7846.215378462137, 7885.172056934025, 10190.694279171637, 10428.947855260712, 10523.052925236727, 10581.312214706059, 10586.311889727182, 10597.205209609272, 10602.522886470128, 10340.844887326659, 10395.376277423378, 10402.011808878144, 10416.218783591223, 10430.530626121843, 7592.316691497792, 10110.747231319203, 10492.213084018653, 10497.685069447853, 10509.211809114271, 37325.06687332811, 37720.0, 37745.43381849247, 40393.59606403957, 40561.59438405637, 3202.727768139711, 3290.572225610655, 3295.505674148873, 3405.642407547197, 3461.6538346165435, 29367.0, 29885.402291954255, 29994.85002574995, 29999.100026999226, 30053.549196762066, 3510.3330367230146, 3538.752287339887, 3562.2163124112913, 3596.3166998270244, 3597.6042635310355, 264748.0, 265292.0, 266199.0, 266421.0, 266466.0, 58801.11798323029, 59222.0, 59316.0, 59341.0, 59454.108188377206, 34085.65914340825, 35090.64909350925, 35364.29271414557, 37227.4415883762, 62269.688651556455, 14323.0, 14491.130532168103, 14497.927510362591, 14501.274936253356, 14510.782338264935, 9672.0, 11612.245204061708, 11745.530178792753, 11773.17587768848, 11793.823092653616, 19198.80801191998, 19568.072304196998, 20455.18179272842, 20507.17971281162, 20531.794682053285, 7361.190269070398, 7431.69617418602, 7451.329380355685, 7517.661705223278, 7763.456558040996, 769.6151924037981, 823.6046697585073, 843.4391129898548, 902.4900930973979, 923.2106548900728, 28215.858920705265, 28653.570196447068, 29159.85420072886, 29324.266893327836, 29429.0, 954.8615450759601, 994.855745916838, 1003.8343673293971, 1008.002077942846, 1012.7265638277771, 14778.852211477963, 15389.769153462707, 15401.614959626098, 15475.922620387051, 15634.3746250151, 409341.0, 414828.0, 415728.0, 418609.0, 418783.0, 49916.75041624768, 50294.748526257135, 50319.49680503221, 50618.24072638914, 50791.492085079415, 1097.155190503308, 1160.2922217447351, 1217.5799349224503, 1234.9938250308692, 1242.6023672424737, 28636.713632864237, 29742.405151896408, 29863.701362986092, 30320.241993950327, 30400.239994000327, 42272.5772742281, 42628.36057459203, 42657.0, 42706.572934271506, 42750.0, 314312.0, 317447.0, 317902.0, 318297.0, 319413.0, 25844.0, 27014.459710806066, 27022.864885675444, 27038.459230815668, 27044.32389190286, 41699.7915010423, 41914.16171676489, 42309.788451057546, 43120.56879431291, 43254.56745432506, 34210.828945856105, 34644.653553464144, 35015.47476787901, 35096.0, 35297.0, 35896.28207435784, 36065.0, 36271.27457450889, 36630.8168459156, 36811.44782828313, 35185.824070879484, 36093.63906361008, 36263.27473450464, 36270.8186459066, 36645.816770915975, 31499.842500788265, 32759.508607370433, 33024.0, 34426.0, 34469.0, 25144.11995580146, 25884.870575647, 25895.798857097358, 26395.60406593941, 26525.469490610467], "value": 18278.650989000937, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.65161512679754, 363.1520399866312, 364.8066524741886, 366.55646667532284, 378.26702077490137, 13663.863361366384, 13896.58310250693, 15588.454404095859, 18203.453896383096, 18232.908835455837, 17239.0, 17384.56538586536, 17389.652206955852, 17393.478195654152, 17610.11949402531, 4529.818807247714, 4825.420949486067, 4830.106430310386, 4892.730899800509, 4906.264060390934, 3533.9646603533893, 5342.091844386444, 5565.109582466806, 5581.49766521013, 5676.829695109153, 5492.670439773627, 5663.093904975205, 5668.631538949955, 5668.886622267552, 5677.630953987978, 5711.857203569903, 5715.0855863062125, 5734.627249228808, 5736.684482353469, 5746.138079288098, 5410.702411367373, 5546.77812887484, 5552.3892371839065, 5558.499735023867, 5678.290213723285, 12950.158239714388, 13002.86997130026, 13165.802512962313, 13181.86818131816, 16835.579110522336, 1925.7881633020497, 1977.13006277239, 2066.5143691232547, 2086.885221312827, 2365.5623709613606, 9444.291678124167, 9495.38280011797, 9696.563654635558, 9794.314397992144, 9969.0, 1839.1907560673394, 1856.4894653970132, 1881.5954569767566, 1887.9056047197723, 1951.0732402109027, 68774.3122568773, 74407.0, 74623.0, 75353.0, 76560.0, 10199.796004079877, 10324.225683073799, 10390.844137337946, 10528.789424211473, 10636.946815266028, 14236.0, 14274.429022839178, 14303.64240893986, 14306.57080287593, 14307.0, 6878.27778083304, 7111.928880711127, 7148.213696493382, 7179.96410017957, 7245.492815502864, 6542.149520562297, 6666.200055993215, 6733.057371967929, 6888.758893438706, 6903.482238832108, 4338.154059958341, 4435.423394958635, 4450.777461126931, 4554.40595791477, 4557.680962332671, 1825.8721889467874, 1839.4757494114112, 1841.3944268859682, 1847.2057015483203, 1871.4385684294657, 762.5882023707136, 789.2502122983188, 840.0926998841237, 870.9695160669346, 888.1251966812684, 16872.57818554546, 17460.738088928676, 17672.646547068987, 17706.91146544259, 18370.08149592515, 750.2353826150652, 790.9841803163904, 848.6181218451721, 854.9401541892132, 874.4141425245101, 9488.430694158373, 9818.65634702782, 9938.751531211778, 10050.798984020279, 10205.38767673927, 409512.0, 410043.0, 412526.0, 417636.0, 424904.0, 60121.0, 83486.58256708799, 84916.0, 85349.0, 85359.57320213359, 906.6101576322113, 910.39003867409, 921.5023887101024, 932.4172392254841, 937.4000639590668, 15523.45667901618, 15859.38320177204, 15878.206089695701, 16164.757528637316, 16197.67604647924, 38716.61283387243, 39408.0, 41211.587884120774, 41238.1752364957, 43489.0, 54815.72592137014, 54964.72517637386, 55250.0, 56309.0, 56420.71789641026, 7412.629368531444, 7611.238876112566, 7733.806654833674, 7809.882851757115, 8010.919890801018, 8790.956045219733, 9815.165710914653, 10904.454777260946, 11268.83096753533, 11528.59649912249, 9399.248060155307, 9445.811083778424, 9724.659636912675, 9906.702798916043, 10003.476533399553, 5010.473900240422, 7166.426685865223, 8942.329325300758, 9453.716388508356, 9597.088276613711, 9201.71176035369, 9453.858192127262, 9904.0, 9993.00069992995, 10092.848607271044, 7508.174100849012, 7509.51188172767, 7554.131274903457, 7644.464887457824, 7775.261350171724, 9092.454452732858, 9175.54122293896, 9345.48599827016, 9430.10414010668, 9587.952060239653], "value": 8131.646897320226, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1255.2907607201923, 1382.5575815738964, 1422.6230049037003, 1514.515355086373, 1741.0859298868093, 6876.312368763128, 7661.348785353245, 7901.960490197541, 7905.604719764003, 7923.168067352932, 7654.923450765491, 7658.770236892902, 7825.843483130348, 8084.959575202116, 8097.716579919704, 1946.5620235446981, 2172.3048624440185, 2194.0, 2244.708187935574, 2250.561140577588, 2205.933821985343, 2226.443389152712, 2226.4545186429345, 2231.230225572183, 2231.7768223177713, 2191.3206905859156, 2198.1866709317574, 2201.3175915466177, 2243.618584840581, 2248.955020899581, 1863.4223390748912, 2123.3417640531484, 2157.6332023556033, 2159.1039718516877, 2191.0, 2225.6550234713645, 2249.6175650139517, 2251.4033781048033, 2252.31304452142, 2252.5494901019697, 7895.171007044235, 7944.443888927777, 7948.5628290444, 7954.443188976774, 7961.601919904039, 4560.452745670507, 4669.4630117536235, 4700.647451441121, 4701.764911754432, 4705.905881882343, 2832.929176770597, 3027.909162725122, 3031.5452682097643, 3036.9848150759326, 3044.071558174756, 952.6998995316453, 997.7455748784087, 998.2762497189552, 1009.7929924365487, 1015.4770293298957, 11022.944885275523, 11122.277051991676, 11159.218854680257, 11210.103191744642, 11265.831012534818, 3985.70107241958, 4194.454720886265, 4286.207051695384, 4315.978420107879, 4330.696851220448, 9553.426794392359, 9596.848378194662, 9601.423914565148, 9640.0, 9650.758731031781, 4807.855764327076, 4817.156997525419, 4823.3729615150505, 4824.469308376076, 4829.879253018703, 3774.75464094833, 4200.894977625584, 4349.195398851222, 4353.73877567347, 4390.495093064274, 3699.3341198583976, 3744.1949980753725, 3758.361078616642, 3850.5186851643543, 3859.150986782903, 1184.9348285844362, 1193.5106606291552, 1208.1542919956066, 1210.0319744204778, 1219.8048312269993, 631.192074145095, 700.3906601256838, 779.9883001754978, 800.087899794235, 819.8975128108987, 5106.0, 5243.868903277448, 5250.369955605275, 5312.335958005249, 5348.732563371816, 853.6926706385697, 853.9615717292612, 860.1183786618641, 870.0733718589681, 880.0539420123393, 3358.529805827186, 3535.9469607955903, 3548.6273941236313, 3592.928141437209, 3641.7814931104217, 9449.858252126223, 9800.65697700577, 9973.750656233507, 10067.69796906094, 10202.0, 9906.0, 10026.398416095057, 10107.69676909694, 10108.545115469822, 10110.090091891765, 7472.14070381913, 7697.730579429693, 7706.768796935989, 7707.190744971697, 7709.0, 4867.70793752376, 5107.157319042316, 5204.245384419314, 5207.1668533034535, 5225.1378522543355, 8990.100989900957, 9282.628694852401, 9320.440773553608, 9499.097585729345, 9506.239500839778, 9249.861252081359, 9562.56968436436, 9710.077542633438, 9721.70834874955, 9736.513174341397, 6723.966380168264, 6982.197047339621, 7003.0, 7137.250588688113, 7141.678624461808, 7344.669489872862, 7489.176190619137, 7489.850202996018, 7503.212162722835, 7516.812079698051, 5405.621606487665, 6758.222804377559, 6843.110395648534, 7008.929910700827, 7231.2768723127265, 6874.346937040973, 6884.105066341343, 7024.1571011478945, 7156.0, 7175.425965922818, 6037.275526936795, 6038.124471951454, 6049.153118563493, 6090.604110732788, 6100.633961962297, 4377.774223217504, 4393.890152746207, 4459.197344478025, 4514.61625761814, 4703.3415321855655, 4536.7051141677, 4635.281531362644, 4639.791209395653, 4656.3713898623255, 4705.223638099676], "value": 4195.836992229302, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.7647658349902, 301.2423754258041, 308.2986206380484, 309.72743985292936, 311.5622550316806, 4937.358143441352, 4965.230389289657, 4974.41330508136, 4987.700737955721, 4989.2017277235645, 4648.53514648535, 4757.666963312561, 4780.784864681089, 4794.928076078853, 4914.655974081816, 3757.380032294668, 3789.9052523686923, 3822.847086116552, 3842.5004749382542, 3866.845326186963, 3804.127883447993, 3840.0, 3841.673457756094, 3842.51968503937, 3847.403652433863, 3629.2922880038404, 3826.4834247376525, 3826.7703937763686, 3843.0, 3863.0728625130046, 3813.3326667833016, 3813.733038687293, 3814.19901820618, 3828.349180639298, 3829.138443850139, 3347.6317605063423, 3353.295807880348, 3353.9329213415594, 3359.227377703142, 3362.663733626642, 4827.9034419311765, 4853.466118726938, 4858.562729354339, 4861.392325959255, 4882.3408839806525, 4119.032027473541, 4326.632236259922, 4335.674824388184, 4341.7829108544765, 4392.582704643054, 5005.399352077774, 5039.546440820343, 5075.796968121308, 5086.542211200973, 5091.338126043591, 3624.9456258156147, 3627.4014787560022, 3635.000374896898, 3641.1261297288725, 3643.344198044351, 5041.495850414965, 5294.602904782157, 5304.628675992643, 5317.601179911522, 5345.812896548602, 3692.51997240357, 3698.1863989922176, 3699.408094704834, 3717.2937141942944, 3731.7760934343482, 3750.268697603941, 3784.545854497423, 3786.8260839139953, 3786.8295926683363, 3792.1657235408165, 4287.6355509782015, 4296.871093867189, 4299.9570004300185, 4304.139172165579, 4307.612314891675, 4847.2729090635985, 5039.974800125976, 5045.747712614355, 5071.46749591295, 5073.289739436482, 1236.6166488388449, 1276.7957126859844, 1300.4473098933104, 1301.0892375337303, 1307.300594182127, 835.9582020898931, 847.809242920338, 852.2925971443686, 858.6093327536081, 867.8524650809378, 4438.201123797748, 4455.108978204372, 4463.330500424962, 4468.486124095771, 4472.457002334189, 5156.561692256125, 5164.690118592896, 5165.612579056586, 5180.7566184116295, 5181.611379146504, 4384.0, 4453.242948698664, 4457.799399027052, 4589.426321709786, 4595.540445955377, 2820.8871645134377, 2826.2792987788393, 2842.971570284312, 2844.431113777253, 2849.5868099125923, 5057.544820966131, 5062.6709263898465, 5067.3412456381175, 5101.668391554537, 5106.361704786902, 5148.716820574904, 5431.2396264522995, 5437.728113594384, 5461.726913654302, 5479.698616576126, 4997.5002499749735, 5006.89986200274, 5009.7495125243595, 5038.571721403721, 5046.571041461517, 5150.667476332221, 5288.444713305202, 5299.814506492255, 5318.388385335581, 5334.51989320963, 5052.9747351263, 5135.460776618401, 5158.97420512895, 5160.354955630546, 5178.171492561172, 4990.7523119220195, 4996.375453068366, 5013.323201367769, 5026.497350265091, 5073.492650735045, 3683.263347330491, 3701.3892707702926, 3749.906252343604, 3750.981245093757, 3757.6618104370737, 5129.435762066095, 5304.151335786256, 5315.681059136464, 5323.787048518016, 5355.196720491957, 5142.228665700175, 5150.9227361588855, 5157.561607263425, 5159.936025589795, 5224.7648855802345, 4987.600991920565, 5159.922601160911, 5161.509656582619, 5168.483151684802, 5223.738813059408, 4798.368554691422, 4923.335349727741, 5027.522385373383, 5054.570361519165, 5058.570021548209, 5166.819161329336, 5177.602047447092, 5177.896442071062, 5189.377274726906, 5210.687358758487, 5042.546170844642, 5047.772850221822, 5051.217061355495, 5058.317127187783, 5100.26046223303], "value": 3859.619038008039, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [646.4505170604983, 659.5317324699463, 683.9384455399014, 728.4536597551833, 790.5019837502373, 11608.12939029573, 12066.939665301661, 12137.029037676975, 12213.145079844404, 12423.627291181256, 12252.632421027383, 12470.127091103626, 12473.189242699218, 12476.750464990717, 12482.18865773724, 636.1920361141348, 762.7521055656906, 766.8964689766893, 791.0902462168524, 791.8851766493855, 797.9800504987393, 798.9920100798976, 799.1289494451047, 804.7545498622918, 805.6857825448051, 842.2756429470651, 846.5259454705354, 846.7671390367636, 847.474565769224, 847.6100993542977, 658.9571677840974, 803.1727320859466, 828.9792755181109, 840.0255703384075, 841.0958219913617, 608.2579253310954, 609.9207103076571, 610.575649923299, 610.8808782287456, 611.0376157551874, 12563.874361256361, 12580.245185288912, 12594.0, 12626.936865315614, 12637.49450021998, 10545.578176872916, 10612.363258204456, 10829.0, 10984.505697243643, 11381.886181138249, 10826.458677066115, 10873.673789786319, 10988.560457581687, 11013.339199648046, 11164.665060048212, 3546.804925729084, 3601.404697267809, 3654.835532401048, 3681.0245284999496, 3719.925601487955, 59698.70150649219, 60064.0, 60630.393696062914, 60637.69681151566, 60670.696646516924, 9866.358686685342, 10101.090901818872, 10261.794764104676, 10285.588576456857, 10295.176385889112, 18319.725204121947, 18456.35402760924, 18481.630367392576, 18506.167222475022, 18526.907365463085, 6495.447886929569, 6590.868182636321, 6630.834229144213, 6709.7651582194385, 6835.282295359015, 3142.3872344892984, 3632.2372301816386, 3669.321175582526, 3690.1697118148204, 3755.117547376364, 2762.7237276272213, 3206.4228438881223, 3354.580677415323, 3359.8320083995704, 3393.5079413484905, 533.88788354446, 539.134688824439, 545.6262460214765, 556.791203298763, 559.2226804741413, 524.5462674786282, 549.9007809183423, 550.6940627058322, 595.214317101422, 597.4981015946626, 7679.539227646359, 7704.191059938737, 7798.142204357516, 7884.72403465876, 7898.565578893216, 590.2297501760244, 590.2916500199777, 600.7626987339976, 603.9516838652897, 611.8806832667588, 3633.8183090845882, 3882.1847412043785, 3924.843006279717, 3948.7433316834313, 3969.92060158801, 59267.0, 76065.61967190128, 104802.0, 106161.46919265355, 106644.46677766561, 96087.51956240174, 96643.51678241564, 96984.51507742416, 97042.0, 97278.0, 47559.762201189464, 70870.2912970874, 80243.59878200572, 81103.0, 82506.0, 6999.160100787938, 7088.113985751781, 7187.101612298463, 7245.2030276670575, 7263.0, 46873.53126468828, 46892.29661555011, 46936.0, 48507.27239091346, 49084.75457622689, 63555.36444635494, 69522.0, 72080.0, 73543.63228183825, 74736.62631686807, 10454.947725261325, 10484.161267098767, 10913.126949844152, 10992.120630349393, 11034.944825275823, 12706.87293127057, 12924.870751292743, 13060.869391305965, 13143.079984401382, 13491.527796527074, 11579.536818527165, 11755.88244117548, 11929.582464613697, 12146.331951742386, 12433.75132497327, 11210.775784484427, 11367.886321137014, 11889.524419023142, 11899.524019039141, 11936.403179841147, 10778.514966826355, 11052.889471105185, 11217.49521271561, 11369.772604548029, 11635.825462617899, 9553.665621703207, 9571.425714457155, 9731.12419882214, 9962.501874906371, 10101.848472273068, 9123.954380228057, 9354.0, 9407.576659050223, 9724.9027509724, 9832.0], "value": 6530.226406736547, "unit": "score"}], "name": "dromaeo_css", "value": 6496.603586484114, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 117.0, 115.0, 113.0, 117.0, 115.0, 113.0, 114.0, 114.0, 114.0], "value": 114.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 125.0, 128.0, 186.0, 124.0, 124.0, 149.0, 123.0, 165.0, 131.0], "value": 141.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 162.0, 160.0, 163.0, 160.0, 161.0, 162.0, 163.0, 161.0], "value": 161.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 84.0, 130.0, 77.0, 76.0, 76.0, 76.0, 107.0, 76.0], "value": 85.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 119.0, 85.0, 85.0, 85.0, 115.0, 85.0, 86.0, 125.0], "value": 95.5, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 117.0, 116.0, 117.0, 116.0, 116.0, 117.0, 117.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 148.0, 146.0, 147.0], "value": 146.7, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 64.0, 63.0, 64.0, 64.0, 64.0, 63.0, 64.0, 64.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 64.0, 64.0], "value": 64.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 78.0, 79.0, 88.0, 78.0, 82.0, 83.0, 88.0, 81.0], "value": 82.3, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 130.0, 141.0, 133.0, 124.0, 128.0, 129.0, 130.0, 165.0, 129.0], "value": 134.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [173.0, 167.0, 172.0, 165.0, 171.0, 171.0, 165.0, 171.0, 172.0, 168.0], "value": 169.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 69.0, 67.0, 67.0, 67.0, 69.0, 67.0, 66.0, 67.0], "value": 67.2, "unit": "score"}], "name": "kraken", "value": 1537.5, "alertThreshold": 2.0}]} 04:34:24 INFO - Return code: 0 04:34:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:34:24 INFO - # TBPL SUCCESS # 04:34:24 INFO - Running post-action listener: _resource_record_post_action 04:34:24 INFO - ##### 04:34:24 INFO - ##### Finished run-tests step (success) 04:34:24 INFO - ##### 04:34:24 INFO - Running post-run listener: _resource_record_post_run 04:34:25 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534347776; Read time: 20; Write time: 439544 04:34:25 INFO - TinderboxPrint: CPU usage
13.0% 04:34:25 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 20 04:34:25 INFO - TinderboxPrint: I/O write bytes / time
534,347,776 / 439,544 04:34:25 INFO - TinderboxPrint: CPU idle
8,336.2 (87.0%) 04:34:25 INFO - TinderboxPrint: CPU user
1,200.5 (12.5%) 04:34:25 INFO - TinderboxPrint: Swap in / out
0 / 0 04:34:25 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246272000; Read time: 0; Write time: 249640 04:34:25 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288075776; Read time: 0; Write time: 189904 04:34:25 INFO - Running post-run listener: _upload_blobber_files 04:34:25 INFO - Blob upload gear active. 04:34:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:34:25 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:25 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:25 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:26 INFO - (blobuploader) - INFO - Open directory for files ... 04:34:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:34:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:34:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:29 INFO - (blobuploader) - INFO - Done attempting. 04:34:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:34:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:34:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:30 INFO - (blobuploader) - INFO - Done attempting. 04:34:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:34:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:34:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:34:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:34:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:34:31 INFO - (blobuploader) - INFO - Done attempting. 04:34:31 INFO - (blobuploader) - INFO - Iteration through files over. 04:34:31 INFO - Return code: 0 04:34:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:34:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:34:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0015781b09c0a886c732b8f9fa24626b0bdff6f742df4c24316dd52f4a70778f3aa9fe69112fab99699ecddf888bd2c0157cb4d38122233575894a3f8d0a8faf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/429013fb81a942fa42726b66ae510add2ff645c8747e0c1f0786ecb900a1f952a89914c309a45926946aee7d86907ad4bf016d8154a7f30d66f2a4a1ea6d041f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971398f452c10db624730cc74f697b8ef3bc0dbbc0a2de90020da76ec14684ee323e2328c9ca85d5c019939f63ea62c3ecb75240fcdad881279658833cf47b5d"} 04:34:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:34:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:34:31 INFO - Contents: 04:34:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0015781b09c0a886c732b8f9fa24626b0bdff6f742df4c24316dd52f4a70778f3aa9fe69112fab99699ecddf888bd2c0157cb4d38122233575894a3f8d0a8faf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/429013fb81a942fa42726b66ae510add2ff645c8747e0c1f0786ecb900a1f952a89914c309a45926946aee7d86907ad4bf016d8154a7f30d66f2a4a1ea6d041f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971398f452c10db624730cc74f697b8ef3bc0dbbc0a2de90020da76ec14684ee323e2328c9ca85d5c019939f63ea62c3ecb75240fcdad881279658833cf47b5d"} 04:34:31 INFO - Running post-run listener: copy_logs_to_upload_dir 04:34:31 INFO - Copying logs to upload dir... 04:34:31 INFO - mkdir: /builds/slave/test/build/upload/logs 04:34:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1256.964305 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 56 secs) (at 2016-06-30 04:34:30.876876) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 04:34:30.880526) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0015781b09c0a886c732b8f9fa24626b0bdff6f742df4c24316dd52f4a70778f3aa9fe69112fab99699ecddf888bd2c0157cb4d38122233575894a3f8d0a8faf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/429013fb81a942fa42726b66ae510add2ff645c8747e0c1f0786ecb900a1f952a89914c309a45926946aee7d86907ad4bf016d8154a7f30d66f2a4a1ea6d041f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971398f452c10db624730cc74f697b8ef3bc0dbbc0a2de90020da76ec14684ee323e2328c9ca85d5c019939f63ea62c3ecb75240fcdad881279658833cf47b5d"} 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.011353 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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/0015781b09c0a886c732b8f9fa24626b0bdff6f742df4c24316dd52f4a70778f3aa9fe69112fab99699ecddf888bd2c0157cb4d38122233575894a3f8d0a8faf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/429013fb81a942fa42726b66ae510add2ff645c8747e0c1f0786ecb900a1f952a89914c309a45926946aee7d86907ad4bf016d8154a7f30d66f2a4a1ea6d041f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox-Non-PGO/sha512/971398f452c10db624730cc74f697b8ef3bc0dbbc0a2de90020da76ec14684ee323e2328c9ca85d5c019939f63ea62c3ecb75240fcdad881279658833cf47b5d"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 04:34:30.906707) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:34:30.907056) ========= 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=20e666a3d4cfbb71505a330e000001b4-1467278111.608493-1675333524 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004519 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 04:34:30.990934) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 04:34:30.991259) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 04:34:30.991657) ========= ========= Total master_lag: 0.18 =========