builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-022 starttime: 1469014041.34 results: success (0) buildid: 20160720013036 builduid: 92b3603a998244b5af413bbdef96adbf revision: 59d21113b4619c117c178b86ec8c7fd5d7fb5807 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:21.342464) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:21.342934) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:21.343221) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:21.357928) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:21.358217) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-20 04:27:21-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 9.84M=0.001s 2016-07-20 04:27:21 (9.84 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127837 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:21.500962) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:21.501523) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022056 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:21.554175) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:21.554773) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 59d21113b4619c117c178b86ec8c7fd5d7fb5807 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 59d21113b4619c117c178b86ec8c7fd5d7fb5807 --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=9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-20 04:27:21,592 truncating revision to first 12 chars 2016-07-20 04:27:21,592 Setting DEBUG logging. 2016-07-20 04:27:21,592 attempt 1/10 2016-07-20 04:27:21,592 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/59d21113b461?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-20 04:27:21,902 unpacking tar archive at: mozilla-inbound-59d21113b461/testing/mozharness/ program finished with exit code 0 elapsedTime=0.697024 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:22.266439) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:22.266812) ========= script_repo_revision: 59d21113b4619c117c178b86ec8c7fd5d7fb5807 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:22.267252) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:22.267548) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-20 04:27:22.278596) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-20 04:27:22.278871) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 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', 'Mozilla-Inbound', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound'] 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=9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:27:22 INFO - MultiFileLogger online at 20160720 04:27:22 in /builds/slave/test 04:27:22 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound 04:27:22 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:27:22 INFO - {'append_to_log': False, 04:27:22 INFO - 'base_work_dir': '/builds/slave/test', 04:27:22 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 04:27:22 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:27:22 INFO - 'branch': 'Mozilla-Inbound', 04:27:22 INFO - 'buildbot_json_path': 'buildprops.json', 04:27:22 INFO - 'config_files': ('talos/linux_config.py',), 04:27:22 INFO - 'default_actions': ('clobber', 04:27:22 INFO - 'read-buildbot-config', 04:27:22 INFO - 'download-and-extract', 04:27:22 INFO - 'populate-webroot', 04:27:22 INFO - 'create-virtualenv', 04:27:22 INFO - 'install', 04:27:22 INFO - 'run-tests'), 04:27:22 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:27:22 INFO - 'download_minidump_stackwalk': True, 04:27:22 INFO - 'download_symbols': 'ondemand', 04:27:22 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:27:22 INFO - 'tooltool.py': '/tools/tooltool.py', 04:27:22 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:27:22 INFO - '/tools/misc-python/virtualenv.py')}, 04:27:22 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:27:22 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:27:22 INFO - 'installer_path': 'installer.exe', 04:27:22 INFO - 'log_level': 'info', 04:27:22 INFO - 'log_name': 'talos', 04:27:22 INFO - 'log_to_console': True, 04:27:22 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:27:22 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:27:22 INFO - 'opt_config_files': (), 04:27:22 INFO - 'pip_index': False, 04:27:22 INFO - 'sps_profile': False, 04:27:22 INFO - 'sps_profile_interval': 0, 04:27:22 INFO - 'suite': 'dromaeojs', 04:27:22 INFO - 'system_bits': '32', 04:27:22 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:27:22 INFO - 'title': 'talos-linux64-ix-022', 04:27:22 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:27:22 INFO - 'use_talos_json': True, 04:27:22 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:27:22 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:27:22 INFO - 'work_dir': 'build'} 04:27:22 INFO - ##### 04:27:22 INFO - ##### Running clobber step. 04:27:22 INFO - ##### 04:27:22 INFO - Running pre-action listener: _resource_record_pre_action 04:27:22 INFO - Running main action method: clobber 04:27:22 INFO - rmtree: /builds/slave/test/build 04:27:22 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:27:22 INFO - Running post-action listener: _resource_record_post_action 04:27:22 INFO - ##### 04:27:22 INFO - ##### Finished clobber step (success) 04:27:22 INFO - ##### 04:27:22 INFO - ##### 04:27:22 INFO - ##### Running read-buildbot-config step. 04:27:22 INFO - ##### 04:27:22 INFO - Running pre-action listener: _resource_record_pre_action 04:27:22 INFO - Running main action method: read_buildbot_config 04:27:22 INFO - Using buildbot properties: 04:27:22 INFO - { 04:27:22 INFO - "project": "", 04:27:22 INFO - "product": "firefox", 04:27:22 INFO - "script_repo_revision": "production", 04:27:22 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 04:27:22 INFO - "repository": "", 04:27:22 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 04:27:22 INFO - "buildid": "20160720013036", 04:27:22 INFO - "pgo_build": "True", 04:27:22 INFO - "basedir": "/builds/slave/test", 04:27:22 INFO - "buildnumber": 2094, 04:27:22 INFO - "slavename": "talos-linux64-ix-022", 04:27:22 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 04:27:22 INFO - "platform": "ubuntu64_hw", 04:27:22 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 04:27:22 INFO - "branch": "mozilla-inbound", 04:27:22 INFO - "repo_path": "integration/mozilla-inbound", 04:27:22 INFO - "revision": "59d21113b4619c117c178b86ec8c7fd5d7fb5807", 04:27:22 INFO - "stage_platform": "linux64-pgo", 04:27:22 INFO - "builduid": "92b3603a998244b5af413bbdef96adbf", 04:27:22 INFO - "slavebuilddir": "test" 04:27:22 INFO - } 04:27:22 INFO - Found installer url https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 04:27:22 INFO - Running post-action listener: _resource_record_post_action 04:27:22 INFO - ##### 04:27:22 INFO - ##### Finished read-buildbot-config step (success) 04:27:22 INFO - ##### 04:27:22 INFO - ##### 04:27:22 INFO - ##### Running download-and-extract step. 04:27:22 INFO - ##### 04:27:22 INFO - Running pre-action listener: _resource_record_pre_action 04:27:22 INFO - Running main action method: download_and_extract 04:27:22 INFO - mkdir: /builds/slave/test/build/tests 04:27:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:22 INFO - https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 04:27:22 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:27:22 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:27:22 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:27:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:27:23 INFO - Downloaded 1361 bytes. 04:27:23 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 04:27:23 INFO - Using the following test package requirements: 04:27:23 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:27:23 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:27:23 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 04:27:23 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:23 INFO - u'jsshell-linux-x86_64.zip'], 04:27:23 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:27:23 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 04:27:23 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:27:23 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:27:23 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:27:23 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 04:27:23 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:27:23 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:27:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:23 INFO - https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:27:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:27:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:27:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:27:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:27:24 INFO - Downloaded 24339941 bytes. 04:27:24 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:27:24 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:27:25 INFO - Return code: 0 04:27:25 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:27:25 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:27:25 INFO - https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:27:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:27:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 04:27:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:27:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:27:27 INFO - Downloaded 24339941 bytes. 04:27:27 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:27:27 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:27:28 INFO - Return code: 0 04:27:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:28 INFO - https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:27:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:27:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 04:27:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:27:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:27:29 INFO - Downloaded 14403317 bytes. 04:27:29 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:27:29 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:27:29 INFO - Return code: 0 04:27:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:29 INFO - https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:27:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:27:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:27:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:27:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Z6kATvWsTRafEg1etWTXwQ/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:27:31 INFO - Downloaded 60870793 bytes. 04:27:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:27:31 INFO - mkdir: /builds/slave/test/properties 04:27:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:27:31 INFO - Writing to file /builds/slave/test/properties/build_url 04:27:31 INFO - Contents: 04:27:31 INFO - build_url:https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 04:27:31 INFO - Running post-action listener: _resource_record_post_action 04:27:31 INFO - Running post-action listener: set_extra_try_arguments 04:27:31 INFO - ##### 04:27:31 INFO - ##### Finished download-and-extract step (success) 04:27:31 INFO - ##### 04:27:31 INFO - ##### 04:27:31 INFO - ##### Running populate-webroot step. 04:27:31 INFO - ##### 04:27:31 INFO - Running pre-action listener: _resource_record_pre_action 04:27:31 INFO - Running main action method: populate_webroot 04:27:31 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:27:31 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:27:31 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:27:31 INFO - '--tppagecycles', 04:27:31 INFO - '7'], 04:27:31 INFO - 'tests': ['tsvgm']}}, 04:27:31 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:27:31 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:27:31 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:27:31 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:27:31 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:27:31 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:27:31 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:31 INFO - 'talos_options': ['--disable-e10s'], 04:27:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:31 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:31 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:27:31 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:31 INFO - 'talos_options': ['--disable-e10s'], 04:27:31 INFO - 'tests': ['damp', 'tps']}, 04:27:31 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:31 INFO - 'tests': ['damp', 'tps']}, 04:27:31 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:27:31 INFO - 'tests': ['dromaeo_dom']}, 04:27:31 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:27:31 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:27:31 INFO - 'tests': ['basic_compositor_video']}, 04:27:31 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:27:31 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:27:31 INFO - 'tests': ['a11yr', 04:27:31 INFO - 'ts_paint', 04:27:31 INFO - 'tpaint', 04:27:31 INFO - 'sessionrestore', 04:27:31 INFO - 'sessionrestore_no_auto_restore', 04:27:31 INFO - 'tabpaint']}, 04:27:31 INFO - 'other-e10s': {'tests': ['a11yr', 04:27:31 INFO - 'ts_paint', 04:27:31 INFO - 'tpaint', 04:27:31 INFO - 'sessionrestore', 04:27:31 INFO - 'sessionrestore_no_auto_restore', 04:27:31 INFO - 'tabpaint']}, 04:27:31 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:27:31 INFO - 'ts_paint', 04:27:31 INFO - 'tpaint', 04:27:31 INFO - 'sessionrestore', 04:27:31 INFO - 'sessionrestore_no_auto_restore', 04:27:31 INFO - 'tabpaint']}, 04:27:31 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:27:31 INFO - 'ts_paint', 04:27:31 INFO - 'tpaint', 04:27:31 INFO - 'sessionrestore', 04:27:31 INFO - 'sessionrestore_no_auto_restore', 04:27:31 INFO - 'tabpaint']}, 04:27:31 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:27:31 INFO - 'tests': ['a11yr', 04:27:31 INFO - 'ts_paint', 04:27:31 INFO - 'tpaint', 04:27:31 INFO - 'sessionrestore', 04:27:31 INFO - 'sessionrestore_no_auto_restore', 04:27:31 INFO - 'tabpaint']}, 04:27:31 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:27:31 INFO - 'tests': ['a11yr', 04:27:31 INFO - 'ts_paint', 04:27:31 INFO - 'tpaint', 04:27:31 INFO - 'sessionrestore', 04:27:31 INFO - 'sessionrestore_no_auto_restore', 04:27:31 INFO - 'tabpaint']}, 04:27:31 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:27:31 INFO - 'tests': ['tsvgx', 04:27:31 INFO - 'tsvgr_opacity', 04:27:31 INFO - 'tart', 04:27:31 INFO - 'tscrollx', 04:27:31 INFO - 'cart']}, 04:27:31 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:27:31 INFO - 'tsvgr_opacity', 04:27:31 INFO - 'tart', 04:27:31 INFO - 'tscrollx', 04:27:31 INFO - 'cart']}, 04:27:31 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:31 INFO - 'talos_options': ['--disable-e10s'], 04:27:31 INFO - 'tests': ['tp5o']}, 04:27:31 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:31 INFO - 'tests': ['tp5o']}, 04:27:31 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:31 INFO - 'talos_options': ['--disable-e10s', 04:27:31 INFO - '--xperf_path', 04:27:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:31 INFO - 'tests': ['tp5n']}, 04:27:31 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:27:31 INFO - 'talos_options': ['--xperf_path', 04:27:31 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:27:31 INFO - 'tests': ['tp5n']}}, 04:27:31 INFO - 'talos.zip': {'path': '', 04:27:31 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:27:31 INFO - Running post-action listener: _resource_record_post_action 04:27:31 INFO - ##### 04:27:31 INFO - ##### Finished populate-webroot step (success) 04:27:31 INFO - ##### 04:27:31 INFO - ##### 04:27:31 INFO - ##### Running create-virtualenv step. 04:27:31 INFO - ##### 04:27:31 INFO - Running pre-action listener: _resource_record_pre_action 04:27:31 INFO - Running main action method: create_virtualenv 04:27:31 INFO - Creating virtualenv /builds/slave/test/build/venv 04:27:31 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:27:31 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:27:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:27:32 INFO - Using real prefix '/usr' 04:27:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:27:32 INFO - Installing distribute.............................................................................................................................................................................................done. 04:27:34 INFO - Installing pip.................done. 04:27:34 INFO - Return code: 0 04:27:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:27: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:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27683b0>, '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 0x27692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2769740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', '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:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:27:34 INFO - Using env: {'DISPLAY': ':0', 04:27:34 INFO - 'HOME': '/home/cltbld', 04:27:34 INFO - 'LANG': 'en_US.UTF-8', 04:27:34 INFO - 'LANGUAGE': 'en_US:en', 04:27:34 INFO - 'LOGNAME': 'cltbld', 04:27:34 INFO - 'MAIL': '/var/mail/cltbld', 04:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:34 INFO - 'MOZ_NO_REMOTE': '1', 04:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:34 INFO - 'NO_EM_RESTART': '1', 04:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:34 INFO - 'PWD': '/builds/slave/test', 04:27:34 INFO - 'SHELL': '/bin/bash', 04:27:34 INFO - 'SHLVL': '1', 04:27:34 INFO - 'TERM': 'linux', 04:27:34 INFO - 'TMOUT': '86400', 04:27:34 INFO - 'USER': 'cltbld', 04:27:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', 04:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:34 INFO - '_': '/tools/buildbot/bin/python'} 04:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:34 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:27:34 INFO - Cleaning up... 04:27:34 INFO - Return code: 0 04:27:34 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:27: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:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27: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:27:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:34 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27683b0>, '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 0x27692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2769740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', '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:27:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:27:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:27:34 INFO - Using env: {'DISPLAY': ':0', 04:27:34 INFO - 'HOME': '/home/cltbld', 04:27:34 INFO - 'LANG': 'en_US.UTF-8', 04:27:34 INFO - 'LANGUAGE': 'en_US:en', 04:27:34 INFO - 'LOGNAME': 'cltbld', 04:27:34 INFO - 'MAIL': '/var/mail/cltbld', 04:27:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:34 INFO - 'MOZ_NO_REMOTE': '1', 04:27:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:34 INFO - 'NO_EM_RESTART': '1', 04:27:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:34 INFO - 'PWD': '/builds/slave/test', 04:27:34 INFO - 'SHELL': '/bin/bash', 04:27:34 INFO - 'SHLVL': '1', 04:27:34 INFO - 'TERM': 'linux', 04:27:34 INFO - 'TMOUT': '86400', 04:27:34 INFO - 'USER': 'cltbld', 04:27:34 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', 04:27:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:34 INFO - '_': '/tools/buildbot/bin/python'} 04:27:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:34 INFO - Downloading/unpacking psutil>=3.1.1 04:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:27:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:37 INFO - Installing collected packages: psutil 04:27:37 INFO - Running setup.py install for psutil 04:27:37 INFO - building 'psutil._psutil_linux' extension 04:27:37 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:27:37 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:27:37 INFO - building 'psutil._psutil_posix' extension 04:27:37 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:27:38 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:27:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:27:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:27:38 INFO - Successfully installed psutil 04:27:38 INFO - Cleaning up... 04:27:38 INFO - Return code: 0 04:27:38 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:27:38 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:27:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:38 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:27:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:38 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 0x24a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27683b0>, '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 0x27692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2769740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', '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:27:38 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:27:38 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:27:38 INFO - Using env: {'DISPLAY': ':0', 04:27:38 INFO - 'HOME': '/home/cltbld', 04:27:38 INFO - 'LANG': 'en_US.UTF-8', 04:27:38 INFO - 'LANGUAGE': 'en_US:en', 04:27:38 INFO - 'LOGNAME': 'cltbld', 04:27:38 INFO - 'MAIL': '/var/mail/cltbld', 04:27:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:38 INFO - 'MOZ_NO_REMOTE': '1', 04:27:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:38 INFO - 'NO_EM_RESTART': '1', 04:27:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:38 INFO - 'PWD': '/builds/slave/test', 04:27:38 INFO - 'SHELL': '/bin/bash', 04:27:38 INFO - 'SHLVL': '1', 04:27:38 INFO - 'TERM': 'linux', 04:27:38 INFO - 'TMOUT': '86400', 04:27:38 INFO - 'USER': 'cltbld', 04:27:38 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', 04:27:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:38 INFO - '_': '/tools/buildbot/bin/python'} 04:27:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:38 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:27:38 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:27:38 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:27:38 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:27:38 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:27:38 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:27:38 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:27:40 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:27:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:27:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:27:40 INFO - Installing collected packages: mozsystemmonitor 04:27:40 INFO - Running setup.py install for mozsystemmonitor 04:27:40 INFO - Successfully installed mozsystemmonitor 04:27:40 INFO - Cleaning up... 04:27:40 INFO - Return code: 0 04:27:40 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x24a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27683b0>, '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 0x27692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2769740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', '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:27:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:27:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:27:40 INFO - Using env: {'DISPLAY': ':0', 04:27:40 INFO - 'HOME': '/home/cltbld', 04:27:40 INFO - 'LANG': 'en_US.UTF-8', 04:27:40 INFO - 'LANGUAGE': 'en_US:en', 04:27:40 INFO - 'LOGNAME': 'cltbld', 04:27:40 INFO - 'MAIL': '/var/mail/cltbld', 04:27:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:40 INFO - 'MOZ_NO_REMOTE': '1', 04:27:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:40 INFO - 'NO_EM_RESTART': '1', 04:27:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:40 INFO - 'PWD': '/builds/slave/test', 04:27:40 INFO - 'SHELL': '/bin/bash', 04:27:40 INFO - 'SHLVL': '1', 04:27:40 INFO - 'TERM': 'linux', 04:27:40 INFO - 'TMOUT': '86400', 04:27:40 INFO - 'USER': 'cltbld', 04:27:40 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', 04:27:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:40 INFO - '_': '/tools/buildbot/bin/python'} 04:27:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:40 INFO - Downloading/unpacking jsonschema==2.5.1 04:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:42 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:27:42 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:27:42 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:27:42 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:27:42 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:27:42 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:27:42 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:27:42 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:27:42 INFO - Downloading functools32-3.2.3-2.tar.gz 04:27:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:27:42 INFO - warning: no files found matching '*.txt' 04:27:42 INFO - no previously-included directories found matching 'build' 04:27:42 INFO - no previously-included directories found matching 'dist' 04:27:42 INFO - no previously-included directories found matching '.git*' 04:27:42 INFO - Installing collected packages: jsonschema, functools32 04:27:43 INFO - Running setup.py install for functools32 04:27:43 INFO - warning: no files found matching '*.txt' 04:27:43 INFO - no previously-included directories found matching 'build' 04:27:43 INFO - no previously-included directories found matching 'dist' 04:27:43 INFO - no previously-included directories found matching '.git*' 04:27:43 INFO - Successfully installed jsonschema functools32 04:27:43 INFO - Cleaning up... 04:27:43 INFO - Return code: 0 04:27:43 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:43 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x24a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27683b0>, '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 0x27692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2769740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', '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:27:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:27:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:27:43 INFO - Using env: {'DISPLAY': ':0', 04:27:43 INFO - 'HOME': '/home/cltbld', 04:27:43 INFO - 'LANG': 'en_US.UTF-8', 04:27:43 INFO - 'LANGUAGE': 'en_US:en', 04:27:43 INFO - 'LOGNAME': 'cltbld', 04:27:43 INFO - 'MAIL': '/var/mail/cltbld', 04:27:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:43 INFO - 'MOZ_NO_REMOTE': '1', 04:27:43 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:43 INFO - 'NO_EM_RESTART': '1', 04:27:43 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:43 INFO - 'PWD': '/builds/slave/test', 04:27:43 INFO - 'SHELL': '/bin/bash', 04:27:43 INFO - 'SHLVL': '1', 04:27:43 INFO - 'TERM': 'linux', 04:27:43 INFO - 'TMOUT': '86400', 04:27:43 INFO - 'USER': 'cltbld', 04:27:43 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', 04:27:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:43 INFO - '_': '/tools/buildbot/bin/python'} 04:27:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:43 INFO - Downloading/unpacking blobuploader==1.2.4 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:45 INFO - Downloading blobuploader-1.2.4.tar.gz 04:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:27:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:27:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:27:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:27:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:27:46 INFO - Downloading docopt-0.6.1.tar.gz 04:27:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:27:46 INFO - Installing collected packages: blobuploader, requests, docopt 04:27:46 INFO - Running setup.py install for blobuploader 04:27:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:27:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:27:46 INFO - Running setup.py install for requests 04:27:46 INFO - Running setup.py install for docopt 04:27:46 INFO - Successfully installed blobuploader requests docopt 04:27:46 INFO - Cleaning up... 04:27:46 INFO - Return code: 0 04:27:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:46 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 0x24a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27683b0>, '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 0x27692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2769740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', '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:27:46 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:27:46 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:27:46 INFO - Using env: {'DISPLAY': ':0', 04:27:46 INFO - 'HOME': '/home/cltbld', 04:27:46 INFO - 'LANG': 'en_US.UTF-8', 04:27:46 INFO - 'LANGUAGE': 'en_US:en', 04:27:46 INFO - 'LOGNAME': 'cltbld', 04:27:46 INFO - 'MAIL': '/var/mail/cltbld', 04:27:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:46 INFO - 'MOZ_NO_REMOTE': '1', 04:27:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:46 INFO - 'NO_EM_RESTART': '1', 04:27:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:46 INFO - 'PWD': '/builds/slave/test', 04:27:46 INFO - 'SHELL': '/bin/bash', 04:27:46 INFO - 'SHLVL': '1', 04:27:46 INFO - 'TERM': 'linux', 04:27:46 INFO - 'TMOUT': '86400', 04:27:46 INFO - 'USER': 'cltbld', 04:27:46 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', 04:27:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:46 INFO - '_': '/tools/buildbot/bin/python'} 04:27:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:46 INFO - Running setup.py (path:/tmp/pip-v1H3N5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:46 INFO - Running setup.py (path:/tmp/pip-VQBzg6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:47 INFO - Running setup.py (path:/tmp/pip-lIR8EO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:47 INFO - Running setup.py (path:/tmp/pip-qDapet-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:47 INFO - Running setup.py (path:/tmp/pip-_70Z4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:47 INFO - Running setup.py (path:/tmp/pip-kflUgF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:47 INFO - Running setup.py (path:/tmp/pip-OsTFEF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:47 INFO - Running setup.py (path:/tmp/pip-Nttt8A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:47 INFO - Running setup.py (path:/tmp/pip-EAhJeu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:47 INFO - Running setup.py (path:/tmp/pip-UL1R4k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:47 INFO - Running setup.py (path:/tmp/pip-8q1wwn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:47 INFO - Running setup.py (path:/tmp/pip-AtxUFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:47 INFO - Running setup.py (path:/tmp/pip-kRIBfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:47 INFO - Running setup.py (path:/tmp/pip-R0_9hX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:47 INFO - Running setup.py (path:/tmp/pip-t3h0Mv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:47 INFO - Running setup.py (path:/tmp/pip-zD85a1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:48 INFO - Running setup.py (path:/tmp/pip-O6o3aC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:27:48 INFO - Running setup.py install for manifestparser 04:27:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Running setup.py install for mozcrash 04:27:48 INFO - Running setup.py install for mozdebug 04:27:48 INFO - Running setup.py install for mozdevice 04:27:48 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Running setup.py install for mozfile 04:27:48 INFO - Running setup.py install for mozhttpd 04:27:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Running setup.py install for mozinfo 04:27:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Running setup.py install for mozInstall 04:27:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:27:48 INFO - Running setup.py install for mozleak 04:27:49 INFO - Running setup.py install for mozlog 04:27:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Running setup.py install for moznetwork 04:27:49 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Running setup.py install for mozprocess 04:27:49 INFO - Running setup.py install for mozprofile 04:27:49 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Running setup.py install for mozrunner 04:27:49 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Running setup.py install for mozscreenshot 04:27:49 INFO - Running setup.py install for moztest 04:27:49 INFO - Running setup.py install for mozversion 04:27:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:27:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:27:49 INFO - Cleaning up... 04:27:49 INFO - Return code: 0 04:27:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:27:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:49 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 0x24a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27683b0>, '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 0x27692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2769740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', '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:27:49 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:27:49 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:27:49 INFO - Using env: {'DISPLAY': ':0', 04:27:49 INFO - 'HOME': '/home/cltbld', 04:27:49 INFO - 'LANG': 'en_US.UTF-8', 04:27:49 INFO - 'LANGUAGE': 'en_US:en', 04:27:49 INFO - 'LOGNAME': 'cltbld', 04:27:49 INFO - 'MAIL': '/var/mail/cltbld', 04:27:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:49 INFO - 'MOZ_NO_REMOTE': '1', 04:27:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:49 INFO - 'NO_EM_RESTART': '1', 04:27:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:49 INFO - 'PWD': '/builds/slave/test', 04:27:49 INFO - 'SHELL': '/bin/bash', 04:27:49 INFO - 'SHLVL': '1', 04:27:49 INFO - 'TERM': 'linux', 04:27:49 INFO - 'TMOUT': '86400', 04:27:49 INFO - 'USER': 'cltbld', 04:27:49 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', 04:27:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:49 INFO - '_': '/tools/buildbot/bin/python'} 04:27:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:27:50 INFO - Running setup.py (path:/tmp/pip-t2uq_p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:27:50 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:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:27:50 INFO - Running setup.py (path:/tmp/pip-4XCdIl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:27:50 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:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:27:50 INFO - Running setup.py (path:/tmp/pip-CZwDJ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:27:50 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:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:27:50 INFO - Running setup.py (path:/tmp/pip-Ylq7Uh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:27:50 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:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:27:50 INFO - Running setup.py (path:/tmp/pip-aGuLfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:27:50 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:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:27:50 INFO - Running setup.py (path:/tmp/pip-ZFUhnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:27:50 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:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:27:50 INFO - Running setup.py (path:/tmp/pip-zeUWh_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:27:50 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:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:27:50 INFO - Running setup.py (path:/tmp/pip-0Jc7N1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:27:50 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:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:27:50 INFO - Running setup.py (path:/tmp/pip-uUbp62-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:27:50 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:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:27:50 INFO - Running setup.py (path:/tmp/pip-LyRZLW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:27:50 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:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:27:50 INFO - Running setup.py (path:/tmp/pip-H0q_Px-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:27:50 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:27:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:27:50 INFO - Running setup.py (path:/tmp/pip-vzfYn9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:27:51 INFO - Running setup.py (path:/tmp/pip-SG365K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:27:51 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:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:27:51 INFO - Running setup.py (path:/tmp/pip-V3s1tB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:27:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:51 INFO - Running setup.py (path:/tmp/pip-nlddmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:27:51 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:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:27:51 INFO - Running setup.py (path:/tmp/pip-DLqbcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:27:51 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:27:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:27:51 INFO - Running setup.py (path:/tmp/pip-o0y8N7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:27:51 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:27:51 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:27:51 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:27:51 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:27:51 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:27:51 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:27:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:27:51 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:27:51 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:27:51 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:27:51 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:27:51 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:27:51 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:27:53 INFO - Downloading blessings-1.6.tar.gz 04:27:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:27:53 INFO - Installing collected packages: blessings 04:27:53 INFO - Running setup.py install for blessings 04:27:53 INFO - Successfully installed blessings 04:27:53 INFO - Cleaning up... 04:27:53 INFO - Return code: 0 04:27:53 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:27:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:53 INFO - Reading from file tmpfile_stdout 04:27:53 INFO - Current package versions: 04:27:53 INFO - argparse == 1.2.1 04:27:53 INFO - blessings == 1.6 04:27:53 INFO - blobuploader == 1.2.4 04:27:53 INFO - docopt == 0.6.1 04:27:53 INFO - functools32 == 3.2.3-2 04:27:53 INFO - jsonschema == 2.5.1 04:27:53 INFO - manifestparser == 1.1 04:27:53 INFO - mozInstall == 1.12 04:27:53 INFO - mozcrash == 0.17 04:27:53 INFO - mozdebug == 0.1 04:27:53 INFO - mozdevice == 0.48 04:27:53 INFO - mozfile == 1.2 04:27:53 INFO - mozhttpd == 0.7 04:27:53 INFO - mozinfo == 0.9 04:27:53 INFO - mozleak == 0.1 04:27:53 INFO - mozlog == 3.2 04:27:53 INFO - moznetwork == 0.27 04:27:53 INFO - mozprocess == 0.23 04:27:53 INFO - mozprofile == 0.28 04:27:53 INFO - mozrunner == 6.12 04:27:53 INFO - mozscreenshot == 0.1 04:27:53 INFO - mozsystemmonitor == 0.3 04:27:53 INFO - moztest == 0.7 04:27:53 INFO - mozversion == 1.4 04:27:53 INFO - psutil == 3.1.1 04:27:53 INFO - requests == 1.2.3 04:27:53 INFO - wsgiref == 0.1.2 04:27:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:27:53 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:27:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:53 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:27:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:53 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 0x24a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27683b0>, '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 0x27692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2769740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', '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:27:53 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:27:53 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:27:53 INFO - Using env: {'DISPLAY': ':0', 04:27:53 INFO - 'HOME': '/home/cltbld', 04:27:53 INFO - 'LANG': 'en_US.UTF-8', 04:27:53 INFO - 'LANGUAGE': 'en_US:en', 04:27:53 INFO - 'LOGNAME': 'cltbld', 04:27:53 INFO - 'MAIL': '/var/mail/cltbld', 04:27:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:53 INFO - 'MOZ_NO_REMOTE': '1', 04:27:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:53 INFO - 'NO_EM_RESTART': '1', 04:27:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:53 INFO - 'PWD': '/builds/slave/test', 04:27:53 INFO - 'SHELL': '/bin/bash', 04:27:53 INFO - 'SHLVL': '1', 04:27:53 INFO - 'TERM': 'linux', 04:27:53 INFO - 'TMOUT': '86400', 04:27:53 INFO - 'USER': 'cltbld', 04:27:53 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', 04:27:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:53 INFO - '_': '/tools/buildbot/bin/python'} 04:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 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:27:54 INFO - Cleaning up... 04:27:54 INFO - Return code: 0 04:27:54 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:27:54 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:27:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:27:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:54 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:27:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:27:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:27:54 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 0x24a9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x260c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x276a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27683b0>, '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 0x27692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2769740>, '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': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', '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:27:54 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:27:54 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:27:54 INFO - Using env: {'DISPLAY': ':0', 04:27:54 INFO - 'HOME': '/home/cltbld', 04:27:54 INFO - 'LANG': 'en_US.UTF-8', 04:27:54 INFO - 'LANGUAGE': 'en_US:en', 04:27:54 INFO - 'LOGNAME': 'cltbld', 04:27:54 INFO - 'MAIL': '/var/mail/cltbld', 04:27:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:27:54 INFO - 'MOZ_NO_REMOTE': '1', 04:27:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:27:54 INFO - 'NO_EM_RESTART': '1', 04:27:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:27:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:27:54 INFO - 'PWD': '/builds/slave/test', 04:27:54 INFO - 'SHELL': '/bin/bash', 04:27:54 INFO - 'SHLVL': '1', 04:27:54 INFO - 'TERM': 'linux', 04:27:54 INFO - 'TMOUT': '86400', 04:27:54 INFO - 'USER': 'cltbld', 04:27:54 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', 04:27:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:27:54 INFO - '_': '/tools/buildbot/bin/python'} 04:27:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:27:54 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:27:54 INFO - Cleaning up... 04:27:54 INFO - Return code: 0 04:27:54 INFO - Running post-action listener: _resource_record_post_action 04:27:54 INFO - Running post-action listener: _start_resource_monitoring 04:27:54 INFO - Starting resource monitoring. 04:27:54 INFO - ##### 04:27:54 INFO - ##### Finished create-virtualenv step (success) 04:27:54 INFO - ##### 04:27:54 INFO - ##### 04:27:54 INFO - ##### Running install step. 04:27:54 INFO - ##### 04:27:54 INFO - Running pre-action listener: _resource_record_pre_action 04:27:54 INFO - Running main action method: install 04:27:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:27:54 INFO - Reading from file tmpfile_stdout 04:27:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:27:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:27:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:27:54 INFO - Reading from file tmpfile_stdout 04:27:54 INFO - Output received: 04:27:54 INFO - Usage: mozinstall [options] installer 04:27:54 INFO - Options: 04:27:54 INFO - -h, --help show this help message and exit 04:27:54 INFO - -d DEST, --destination=DEST 04:27:54 INFO - Directory to install application into. [default: 04:27:54 INFO - "/builds/slave/test"] 04:27:54 INFO - --app=APP Application being installed. [default: firefox] 04:27:54 INFO - mkdir: /builds/slave/test/build/application 04:27:54 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:27:54 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:28:11 INFO - Reading from file tmpfile_stdout 04:28:11 INFO - Output received: 04:28:11 INFO - /builds/slave/test/build/application/firefox/firefox 04:28:11 INFO - Running post-action listener: _resource_record_post_action 04:28:11 INFO - ##### 04:28:11 INFO - ##### Finished install step (success) 04:28:11 INFO - ##### 04:28:11 INFO - ##### 04:28:11 INFO - ##### Running run-tests step. 04:28:11 INFO - ##### 04:28:11 INFO - Running pre-action listener: _resource_record_pre_action 04:28:11 INFO - Running main action method: run_tests 04:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:28:11 INFO - Python 2.7.3 04:28:11 INFO - Return code: 0 04:28:11 INFO - grabbing minidump binary from tooltool 04:28:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:28:11 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 0x27683b0>, '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 0x27692b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2769740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:28:11 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:28:11 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:28:11 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:28:11 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:28:11 INFO - Return code: 0 04:28:11 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:28:11 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:28:11 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:28:11 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:28:11 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:28:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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:28:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Inbound --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-022 --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:28:11 INFO - Using env: {'DISPLAY': ':0', 04:28:11 INFO - 'HOME': '/home/cltbld', 04:28:11 INFO - 'LANG': 'en_US.UTF-8', 04:28:11 INFO - 'LANGUAGE': 'en_US:en', 04:28:11 INFO - 'LOGNAME': 'cltbld', 04:28:11 INFO - 'MAIL': '/var/mail/cltbld', 04:28:11 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:28:11 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:28:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:28:11 INFO - 'MOZ_NO_REMOTE': '1', 04:28:11 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:28:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:28:11 INFO - 'NO_EM_RESTART': '1', 04:28:11 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:28:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:28:11 INFO - 'PWD': '/builds/slave/test', 04:28:11 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:28:11 INFO - 'SHELL': '/bin/bash', 04:28:11 INFO - 'SHLVL': '1', 04:28:11 INFO - 'TERM': 'linux', 04:28:11 INFO - 'TMOUT': '86400', 04:28:11 INFO - 'USER': 'cltbld', 04:28:11 INFO - 'XDG_SESSION_COOKIE': '9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070', 04:28:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:28:11 INFO - '_': '/tools/buildbot/bin/python'} 04:28:11 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Inbound', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-022', '--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:28:12 INFO - mozversion application_buildid: 20160720013036 04:28:12 INFO - mozversion application_changeset: 59d21113b4619c117c178b86ec8c7fd5d7fb5807 04:28:12 INFO - mozversion application_display_name: Nightly 04:28:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:28:12 INFO - mozversion application_name: Firefox 04:28:12 INFO - mozversion application_remotingname: firefox 04:28:12 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:28:12 INFO - mozversion application_vendor: Mozilla 04:28:12 INFO - mozversion application_version: 50.0a1 04:28:12 INFO - mozversion platform_buildid: 20160720013036 04:28:12 INFO - mozversion platform_changeset: 59d21113b4619c117c178b86ec8c7fd5d7fb5807 04:28:12 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 04:28:12 INFO - mozversion platform_version: 50.0a1 04:28:12 INFO - using testdate: 1469014092 04:28:12 INFO - actual date: 1469014092 04:28:12 INFO - starting webserver on 'localhost:32972' 04:28:12 INFO - SUITE-START | Running 2 tests 04:28:12 INFO - TEST-START | dromaeo_css 04:28:12 INFO - operating with platform_type : linux_ 04:28:12 INFO - Initialising browser for dromaeo_css test... 04:28:12 INFO - TEST-INFO | started process 23947 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGav6XE/profile http://localhost:32972/getInfo.html) 04:28:16 INFO - PROCESS | 23947 | __metrics Screen width/height:1600/1200 04:28:16 INFO - PROCESS | 23947 | colorDepth:24 04:28:16 INFO - PROCESS | 23947 | Browser inner width/height: 1024/697 04:28:16 INFO - PROCESS | 23947 | __metrics 04:28:17 INFO - PROCESS | 23947 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:28:17 INFO - PROCESS | 23947 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:28:17 INFO - TEST-INFO | 23947: exit 0 04:28:17 INFO - Browser initialized. 04:28:17 INFO - Running cycle 1/1 for dromaeo_css test... 04:28:17 INFO - TEST-INFO | started process 24032 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpGav6XE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:28:29 INFO - PROCESS | 24032 | RSS: Main: 157036544 04:28:29 INFO - PROCESS | 24032 | 04:29:21 INFO - PROCESS | 24032 | 1469014161103 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:31:28 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:32972/tests/dromaeo/cssquery-dojo.html (next: http://localhost:32972/tests/dromaeo/cssquery-ext.html) 04:31:30 INFO - PROCESS | 24032 | RSS: Main: 284098560 04:31:30 INFO - PROCESS | 24032 | 04:34:32 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:32972/tests/dromaeo/cssquery-ext.html (next: http://localhost:32972/tests/dromaeo/cssquery-jquery.html) 04:34:33 INFO - PROCESS | 24032 | RSS: Main: 241614848 04:34:33 INFO - PROCESS | 24032 | 04:37:35 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:32972/tests/dromaeo/cssquery-jquery.html (next: http://localhost:32972/tests/dromaeo/cssquery-mootools.html) 04:37:35 INFO - PROCESS | 24032 | RSS: Main: 238739456 04:37:35 INFO - PROCESS | 24032 | 04:40:37 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:32972/tests/dromaeo/cssquery-mootools.html (next: http://localhost:32972/tests/dromaeo/cssquery-prototype.html) 04:40:38 INFO - PROCESS | 24032 | RSS: Main: 218771456 04:40:38 INFO - PROCESS | 24032 | 04:43:41 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:32972/tests/dromaeo/cssquery-prototype.html (next: http://localhost:32972/tests/dromaeo/cssquery-yui.html) 04:43:41 INFO - PROCESS | 24032 | RSS: Main: 185778176 04:43:41 INFO - PROCESS | 24032 | 04:46:44 INFO - PROCESS | 24032 | Cycle 1(1): loaded http://localhost:32972/tests/dromaeo/cssquery-yui.html (next: http://localhost:32972/tests/dromaeo/cssquery-dojo.html) 04:46:44 INFO - PROCESS | 24032 | RSS: Main: 273203200 04:46:44 INFO - PROCESS | 24032 | 04:46:44 INFO - PROCESS | 24032 | __start_tp_report 04:46:44 INFO - PROCESS | 24032 | _x_x_mozilla_page_load 04:46:44 INFO - PROCESS | 24032 | _x_x_mozilla_page_load_details 04:46:44 INFO - PROCESS | 24032 | |i|pagename|runs| 04:46:44 INFO - PROCESS | 24032 | |0;dojo.html;2995.55066739989;3005.053408176426;3037.5139977603576;3046.527788192831;3052.0691189187287;5116.053530096935;5212.2963399941;5219.86950326242;5289.100852855015;5362.812301569451;5175;5202.245674377213;5223.2165175223645;5253.763580638871;5315.0698627740085;4614.330922016297;4669.042846216517;4684.836030738925;4708;4905.632077594177;4823.807047718087;4853.8543843684565;4854.077725232195;4867.36724225852;4876.902461950759;4666.65000124992;4679.227927391977;4709.411323584552;4724.220503616916;4725.645576581753;4704.0356726870905;4709.175894218532;4723.385959825201;4763.642726795504;4791.6406269529925;4753.78607962639;4762.9759601685455;4769.880752981168;4800.735959522225;4806.975965120187;5122.154844450662;5179.04187725272;5223.843284701465;5299.947000530023;5325.3077099977145;5594.9720251398885;5632.9436705632825;5636.661800291996;5639.6334238274385;5648.830535083913;5597.160425936101;5663.008973429633;5687.971560142173;5688.175214593861;5689.9146512802345;5122.615803814729;5188.948110518884;5221.895562088737;5232.215167724834;5302.840914772563;5766.308043034863;5771.451712087345;5772.971135144381;5777.162311464814;5779.479846813807;5560.165975103767;5563.082091454865;5566.693831839288;5566.832995010156;5569.443055694398;5427.728613569306;5454.0182767101505;5526.419725928719;5529.087700529368;5636.718164091779;5534.0315444797;5540.612157149041;5542;5542.168674698827;5563.916541251884;5494.478024587658;5536.197251398525;5540.833774986757;5548.9722551386985;5550.528205102531;4222.345536441856;4225.408442818008;4264.466941632296;4308.784560771949;4319.6112349888035;3876.1472476055224;3898.1618951924906;3898.200868821885;3898.629630185128;3899.239648268617;5278.419373868871;5320.654157479751;5330.840074797762;5344.652597581145;5348.03735327637;5648.774049038075;5648.802291919763;5654.038813401731;5708.857278568069;5710.600257981984;5267.841964741064;5305.840824775263;5306.283651707047;5309.522143007148;5314.840554783363;4778.4982576829625;4792.592629626451;4816.927746083811;4828.010257897123;4911.9754401227765;5713.085906254979;5729.140628905698;5743.712814359265;5774.653520788766;5792.913106303409;5486.286782718221;5584.385717571064;5588.413216612197;5591.524720398812;5592.86017849557;5615.803446879339;5652.491275785199;5672.631278966854;5731.942680573307;5733.426657334233;5423.3491980962535;5435.782568697208;5440.836774896759;5472.097103977799;5491.560675146058;5501.862453438696;5508.834734957958;5513.889722205453;5519.254900588369;5532.529734972572;5408.729563521887;5409.675419474844;5436.021516127135;5439.782408703608;5491.560675146058;5502.367227768857;5504.311961004874;5515.889682206413;5537.584681148849;5550.000999820071;5439.456054394687;5483.7806487740045;5490.615656904138;5500.724963751716;5501.037318469172;5280.683159010472;5483.917741233964;5556.888862222652;5609.49514543693;5617.354004289559;5461.918071228855;5473.206385074062;5477.726113694379;5509.173623956439;5531.585131115263 04:46:44 INFO - PROCESS | 24032 | |1;ext.html;572.6792995922282;605.4490413723511;610.3255902228036;624.0545573456214;635.9491240700744;43794.34308485371;44962;45154.32268515971;45179.548204517945;49265;46428.53571464284;46784.29823552641;46893.5931922042;46942.53057469424;46960.295595566095;9079.45523268606;9204.355695101345;9220.723378298662;9222.262219022496;9225.584848681792;9132.178103970642;9197.172254497094;9221.95389023054;9223.123803238681;9223.815523689522;9234.07659234078;9263.583138758739;9280.211182049534;9282;9285.303602229826;9187.26501879848;9188.035256298093;9194.31042671799;9231.90768092324;9235.815283694355;9080.046595107484;9081;9120.087991200893;9137.680181193626;9150.542472876396;44030;44340.3348949766;44363.33454998177;44433.555664443586;44467.555324446665;3595.442706380515;3603.333383324067;3702.1670124221832;3762.1535154590274;3858.5562660293863;33791.83104084488;33810.66189338124;33954.32091358184;34354.82822585871;35310.64689353099;4466.0844526871915;4495.370648109268;4527.230370836965;4585.679002469828;4616.238320677118;362730.9999999974;363333;363452;364051;366122;61324.69337653283;61900.69049654723;61918.38081619216;62167.37832621616;62294.377056229765;55373.72313138408;62705.372946270865;64018;64079.67960160263;70466;16414.753778693328;16643.583910402336;16665.083420411753;16681.666366672598;16686.666266674598;12904.225746455242;12928.806067908989;12969.481220751253;12984.805227921588;13017.869821301856;16312.836871631369;18363.724544131583;18837.717434238497;19077.90461047686;19305;6352.18868678789;6524.249711283263;6544.102210358943;6675.42601927396;6718.899216511756;939.4598106089027;995.4127065031666;1024.6721049264163;1054.9736256593646;1085.67972448128;32832.67167328296;32861.67138328586;33223.3355332892;33249.501257481155;33753;1080.3193987787802;1103.9116870650328;1106.44124717019;1116.4194618798342;1123;16750.74873876893;17206.397776077778;17454.56363590895;17512.737308940377;17520.21159047846;545069.1198160154;549398;549912;550415;550609;61011.69494152589;61358.38641613616;61419.07871381933;61491.692541537006;61570;1326.157889740022;1377.6831328794233;1388.576484172317;1563.4293482878668;1566.5222107257396;31787.841060795472;32625.673743263214;32949;33206.501902471;33849.15377115592;53401.198982014525;53554.732226338616;53564.1965370512;53654.73172634112;53751.46248537464;465453;467118;467196;467822;468532;28108.578371324038;29048.56427153637;29109.85445072761;30629.846850765603;44701.32948005848;35126.29747405089;48305.51694483151;48927.51072489372;50140;53442.46557534375;41488.58511414968;42576.36135457909;42888.142237155706;43187.35218971655;44437.11125777401;41611;41840.16319673529;42565.787171063945;43223;43788;42162.36756448595;42341.576584234994;43670.56329436665;43843.56156438522;43847.123057539306;34031.659683402846;37891;38155.80922095372;38311.233775324894;38849.22301553896;28237.57643635306;28288.71711282861;28501.857490712413;28631.856840715664;28781.136565903056 04:46:44 INFO - PROCESS | 24032 | |2;jquery.html;384.6862962981419;385.703008683314;396.9702272329576;405.3109713487072;416.7124683968062;18916.90541547292;20299.49251268719;20499.282525111605;20506.794932050674;21284.361469155912;20063.297784577542;20224.69662955057;20313.695294570593;20376.796232037676;20576.69134962973;5568.415316391782;5722.1416787482;5819.7963071292515;5833.533317334603;5840.240768700063;5632.26780518532;5754.597178197507;5763.106718458645;5786.276715410574;5788.768449262046;5905;5907.6750778707155;5958.553108516857;5964.075568286922;5964.880702385972;5767.509761670263;5855.970720146414;5931.110333449974;5931.288245410536;5946.048632218867;5821.243238379026;5822.796202132948;5827.35899051104;5827.533797296206;5829.562782791308;12804.80792788109;17821.376251831123;19054.52363690905;24049.879750601136;24220.757792422028;2047.5904819036102;2075.647139986206;2156.3315372234656;2262.230841513877;2662.267876334004;10295.124914382286;10299.639512617097;10597.205209609234;10792.892071079266;13773;1943.7278780970676;1965.4693232827058;1965.9705104423444;1987.5329297615049;2005.0576229172266;64813;67269;67408.6629566854;85884.57057714734;87769.56115219447;8765.737027889174;10376.792464150674;10962.506687199095;11405.429728513707;11480.483378247998;15626;15685.66671832907;15693;15728.13495257749;15843.128627925575;7432.2567743225245;7968.163342849033;8123;8125.553094579855;8567.871481927776;8117.878231826528;8160.102388737353;8409.369297302605;8494.957525212334;8515.446495977742;4720.480747117815;4763.309320148559;4823.300621409876;4841.612670986313;4966.205407134841;1864.3102052240758;1868.7290342900203;1876.9624607507774;1935.9322423715103;1948.366780796247;907.6641642592283;941.3645789092335;977.9902200977899;1018.2159737002614;1056.0179033498919;20458;20568.280110196072;20632.484187895123;20674.862882541605;20700.068496917676;962.6726912849665;995.5669283861544;1009.258195226508;1028.177458033585;1033.705393962717;10848.132149428027;10858.514050815518;12118.515259389702;12202.755944881053;12324.630261092181;509922;515888;538100;538314;538630;94637;98468.50765746269;99720.50139749255;101654.4917275409;103835;997.9700608981742;1037.9636712715019;1039.3607931122306;1043.4939054558533;1063.5373612478597;17993.190306436503;18387.72418413698;18927.432177034712;18954.905225473784;18991;44907.77546112249;45097.19611215646;45809;46121;46561.30158047564;42119.36820947627;49558.75220624018;61529;61753.691231543555;63848.68075659592;8247.463914845515;8491.405601607828;8571.528565928933;8827.691030814147;8905.376623636283;9700.708978730649;13101.902579938316;13451.529196478075;13583.52457663977;14342.713145737236;11651.242669226473;11941.462634181657;11968.581099661471;12068.275903445821;12342.691432713895;10434.426106564211;11331.036861866834;11641.476133574179;11846.58536951237;12405.766961946576;11714.824277635671;11730.354830484064;11810.76378472443;11955.701107472034;12392.132550721724;7444.441666875115;7574.863770434258;8774.736757897273;8797.120287971407;8983.865242021244;10859.728506787393;11377.146713996317;11521.942390287995;11757.764844702888;11881.22772019816 04:46:44 INFO - PROCESS | 24032 | |3;mootools.html;1422.4879043544322;1481.9996502360905;1589.793326867507;1712.777338945937;1766.6290079083392;8066.475679080863;8607.39748217625;8628.09405012474;8628.784280392993;8629.352798540103;7453.962730186341;8019.438639295252;8271.710490132846;8277.337812974962;8435.536045517494;2259.5029093599424;2282.417983414227;2283.4177284792354;2286.3483907086484;2305.965410518835;2245.9101635934544;2262.988685056581;2310.099061366069;2313.0400883633274;2313.699219101523;1947.5423275530238;2184.3119417383473;2249.32520243927;2252.6733623624564;2302.458922153293;2260.581792368417;2286.314105768263;2289.267434420986;2289.519200967799;2289.782470665284;2192.6382146945734;2198.274569392113;2200.460887082659;2205.647096464574;2210.2043264424956;8506.106858779802;8618.525981071038;8623.396362254645;8628.611712472954;8633.525156116411;4947.604191664658;5049.772760225762;5066.695998240118;5067.341245638044;5077.746112694351;3136.921576960571;3206.3106432116974;3279.8032118072992;3283.950740738891;3287.309664970359;1028.9794204115876;1060.2313322840955;1084.3710647824244;1087.7770057138268;1098.0940723902731;11862;11866.821997670042;11891.583794567236;11895.464704088337;11907.28556286617;4423.203823311835;4428.402165707588;4483.730976141442;4493.550644935481;4535.251683472256;10176.745581360377;10258.692239232685;10264.897351026544;10275.280730348804;10284.434356110485;5136.563392111712;5142.485751424828;5147.279380886679;5153.330067091254;5153.561947234452;4093.1404405074672;4143.606357396043;4437.534058923831;4653.837115700934;4730.290456431563;3805.391137418055;3824.3880979043774;3932.783696896698;3939.4878665773267;3984.561698213194;1241.975160496785;1248.0888951065592;1254.0782524844233;1257.352463481308;1281.9679508012375;821.2977903892206;930.1210356213448;942.8255772682076;946.9857952130724;953.2755106119399;5803.47768700819;5994.0409534474275;5995.520358371407;6025.935913705587;6103.969480152571;440.69371786608;450.86474057782533;451.56649616368;453.8774530876645;462.1358060427023;3962.5443074046275;4109.219248342805;4120.690948178899;4130.938035929464;4196.979015104966;9987.550560224661;10594.788104238027;10649.148068154529;10650.520726567323;10682.038616524394;10042.899571004342;10606.416647084485;10612.25714200014;10621.256512044238;10630.681079567625;7645.617719114022;8002;8015.719449819228;8018.55897925608;8022.237887400687;5761.654300741801;5886.38192989747;5940.46535811779;6014.8195554133445;6053.182820319201;9709.174720148867;9718;9743.80512389734;9837.065478779505;9847.882705218413;9350.859737103812;9717;9745.12293893553;10022;10041.146502547364;6876.759313424006;7078.575285482888;7299.598522081336;7421.666025028779;7619.809504762426;7853.253940875607;8070.2333278338465;8156;8172.5913704315735;8178.386621003568;7192.31672991065;7280.7815765525;7359.889601656087;7364.226756190523;7439.293267139613;7098.3256590623805;7167.283271672791;7219.45854060937;7266.418686505172;7331.120265568166;6744.325567443217;6770.390664840188;6818.522703410912;6825.146856642919;6825.761098361533;5046.747662616928;5065.797368105234;5180.559652429435;5226.686398816083;5268.841934741964;5086.21163719624;5105.7191854448365;5184.222366645034;5186.521841275218;5320.787168513216 04:46:44 INFO - PROCESS | 24032 | |4;prototype.html;327.8263001293038;337.360701470713;344.626080702438;344.7345543931172;346.93234819210267;5337.8398648040575;5392.56859451244;5402.567794576435;5412.621116521836;5427.647202931812;5027.874303142414;5132;5254.031472218204;5288.127458969275;5355.946440535594;4168.499780026394;4177.4778152730905;4189.769562674067;4197.328427451608;4207.389928460371;4142.0680346922;4194.077302993336;4196.685248606352;4206.179794939988;4208.600182982612;3971.642552170304;4030.496187976503;4108.424820525114;4131.566185550519;4171.707980441355;4115.662409716854;4126.690498212616;4130.483689538808;4139.379093136024;4140.3375459926265;3711.6659500645073;3720.776753394778;3729.7948612826285;3734.9439758403646;3744.2885851688366;5050.696958182521;5174.843345559206;5179.19722443022;5182.663126896739;5194.27280180775;4758.524147585248;4772.379590653228;4777.570018698334;4788.880277993043;4790.209615413452;5463.836084917459;5507.614466987313;5515.7242137893345;5536.861578460531;5542.11326187808;3936.5079365079364;4060.2691515527194;4104.7890872192775;4136.31750761124;4155.16896620674;5640.830775076754;5678.43215678433;5687.914681279784;5717.798033101477;5720.6281591696825;4200.550809970555;4203.159368126387;4208;4234.809433575497;4259.446271984684;4192.874213773592;4229.47265247935;4268.189044081614;4308.89227769302;4309.913801723948;4749;4757.833475828329;4767.427908650984;4772.403449568804;4828.565429111397;5508.724563771875;5546.251256080377;5553.389127196006;5568.16477528374;5574.470425309589;1428.6928310413311;1468.4933697874217;1471.8896082793833;1493.126520985214;1498.85760852721;960.9087136722001;977.9438206736708;1001.6644424117857;1003.9458568503043;1005.3716427232979;5272.9736351318;5291.206319052096;5293.232481290268;5324.893502129936;5336.359636843526;5661.547076233891;5663.263775709132;5665.3768085510565;5679.31848178213;5684.403137670568;5164.974175129176;5231.921521177185;5260.368755749335;5322.441143679858;5323.3611966563485;2981.3292009297734;2983.6275313355663;2997.595324631147;2999.460097182528;3010.668826429091;5560.860978475571;5715.428457154251;5739.799107031317;5746.626469279484;5782.421757824184;5716.771329146787;5723.942760572341;5727.541796656257;5730.77076916927;5750.396208398141;5724.656520608777;5766.567507436959;5767.250257466502;5770.3652598215;5773.278340207474;5384.192371144203;5588.441155884379;5593.384727679871;5617.410171931889;5643.407442218672;5545.140503222007;5556.388797232382;5561.833145005657;5565.833025009256;5566.860828479321;5570.944290557205;5713.857153571194;5715.828525144252;5724.425782909733;5735.426457354231;4097.201045796041;4134.545200028055;4140.420341152181;4142.502899652061;4149;5758.424157584375;5777.8555536111935;5778.566607504538;5803.47768700819;5809.970950145223;5377;5601;5682.204491371129;5698.6010979232715;5703.116017017369;5606.009866497498;5608.364068887617;5611.859703507445;5617.157426386075;5618.887622247614;5330.413654497925;5386.596005299697;5585.776568937197;5601.991641504405;5602.579806514609;5583.972080139736;5600.859978500407;5605.32736071674;5624;5627.634203776742;5443.292371991616;5493.7802487900035;5503.229547863382;5511.649645836796;5513.173024046425 04:46:44 INFO - PROCESS | 24032 | |5;yui.html;733.8422239218573;742.8699977503935;781.0315209140667;783.7256960063977;784.388177221767;14901.62745931351;15980.84019159811;15987.440439584589;16039.278232479537;16068.116253606062;14297.78553321701;14385.352659130338;14411.495597654084;14412.423503059892;14425.92787036066;642.3480167629837;766.0577489687673;783.4085265624474;784.1374488063113;784.7018133109439;749.153456594048;781.6677911887454;788.8816677498393;788.9329407000412;789.9644515996765;839.1566475691922;839.5718183726314;842.061101871412;842.9072801991807;844.7254642241265;677.6848765324148;837.5937670229933;839.0812060793421;839.3285371702614;839.49630221867;590.1236663554618;613.4570904749285;616.1189499016449;617.2161355079024;617.8702472480785;14453.710925781426;14474;14493.202873841934;14520.128792272497;14534;13759.312034398241;14104;14383.208923509203;14442.494512692005;14449.711005779825;12749.872501274962;12765.23408595478;12820.23078615286;12890.355482225852;13092.279924604143;4405.074934263808;4436.0906014267;4541.659375546814;4553.704009239422;4673.182193116225;74977;75800;76617.61691191564;77075;77137.61431192864;11243.156763242789;11275.379854108103;11305.943470282597;11331.886681133083;11718.531258749554;21869.453263668216;21917.890410547847;21948.122075117135;21998.780012199994;22019.559608807733;8473.195046470575;8614.784630384165;8623.5257060861;8672.436291641023;8744.8688269676;4742.928856067162;4782.95217047832;4784.928226076611;4847.975760121248;4861.6596838220985;3395.932081358359;3492.109512074405;3492.877749278814;3493.336266109482;3502.2995400919917;580.8867270882222;585.487698264019;603.2007589943343;605.3734384911595;607.471499795181;669.1167658690579;674.5143496682381;674.8717743628695;701.8631366883511;711.2247650061457;9171.58727857248;9344.439333640003;9440.858387124199;9885.209183265322;10051.346662467062;644.1947565543071;662.3372748699699;667.6695035957135;688.9189803603657;716.534252735726;4536.954630453653;4618.261078227468;4642.16441040616;4646.512116227815;4651.837185698484;62139.37860621336;64599;66402.33597664058;66445.33554664488;66700;97889;98016.50991745139;98532;100240;100644;87463;87972;89804;91169.54415227882;93788.53105734427;8656.134172075228;9046.140616641409;9065.32010099232;9079.54602269897;9111.271098312252;44983.55016449794;52719.73640131775;52834.73582632216;52852;55664;48103.27845082257;49209;49229.507704923926;57950.42049579619;73595.6320218417;12678.87321126777;12771.489140434278;12884.226946383247;13145.277009764171;13642.86357136416;12797.42411591462;13485.730285394433;14092.929535352258;14611;15932.203389830695;12685.619431417072;12751.936240318739;12970.805437918627;13059;13224.603261902159;12136.393180341125;12196.451159698012;12831.230126192459;13529.2558909257;14149.292535372984;14273.71452570922;14365.281735912953;14658.486952956595;14930.17884016346;15003.474878379204;10098.949505252427;10243.641472548425;10446.268761186644;10789.946050269698;11317.320960742381;10511.896250893546;11114.333140011626;11196.392306773178;11353.772924541629;11602.129840261845 04:46:44 INFO - PROCESS | 24032 | __end_tp_report 04:46:44 INFO - PROCESS | 24032 | __start_cc_report 04:46:44 INFO - PROCESS | 24032 | _x_x_mozilla_cycle_collect,1109 04:46:44 INFO - PROCESS | 24032 | __end_cc_report 04:46:44 INFO - PROCESS | 24032 | __startTimestamp1469015204987__endTimestamp 04:46:44 INFO - PROCESS | 24032 | 04:46:44 INFO - PROCESS | 24032 | ------- Summary: start ------- 04:46:44 INFO - PROCESS | 24032 | Number of tests: 6 04:46:44 INFO - PROCESS | 24032 | 04:46:44 INFO - PROCESS | 24032 | [#0] dojo.html Cycles:165 Average:5201.87 Median:5439.46 stddev:584.26 (10.7%) stddev-sans-first:559.83 04:46:44 INFO - PROCESS | 24032 | Values: 2995.6 3005.1 3037.5 3046.5 3052.1 5116.1 5212.3 5219.9 5289.1 5362.8 5175.0 5202.2 5223.2 5253.8 5315.1 4614.3 4669.0 4684.8 4708.0 4905.6 4823.8 4853.9 4854.1 4867.4 4876.9 4666.7 4679.2 4709.4 4724.2 4725.6 4704.0 4709.2 4723.4 4763.6 4791.6 4753.8 4763.0 4769.9 4800.7 4807.0 5122.2 5179.0 5223.8 5299.9 5325.3 5595.0 5632.9 5636.7 5639.6 5648.8 5597.2 5663.0 5688.0 5688.2 5689.9 5122.6 5188.9 5221.9 5232.2 5302.8 5766.3 5771.5 5773.0 5777.2 5779.5 5560.2 5563.1 5566.7 5566.8 5569.4 5427.7 5454.0 5526.4 5529.1 5636.7 5534.0 5540.6 5542.0 5542.2 5563.9 5494.5 5536.2 5540.8 5549.0 5550.5 4222.3 4225.4 4264.5 4308.8 4319.6 3876.1 3898.2 3898.2 3898.6 3899.2 5278.4 5320.7 5330.8 5344.7 5348.0 5648.8 5648.8 5654.0 5708.9 5710.6 5267.8 5305.8 5306.3 5309.5 5314.8 4778.5 4792.6 4816.9 4828.0 4912.0 5713.1 5729.1 5743.7 5774.7 5792.9 5486.3 5584.4 5588.4 5591.5 5592.9 5615.8 5652.5 5672.6 5731.9 5733.4 5423.3 5435.8 5440.8 5472.1 5491.6 5501.9 5508.8 5513.9 5519.3 5532.5 5408.7 5409.7 5436.0 5439.8 5491.6 5502.4 5504.3 5515.9 5537.6 5550.0 5439.5 5483.8 5490.6 5500.7 5501.0 5280.7 5483.9 5556.9 5609.5 5617.4 5461.9 5473.2 5477.7 5509.2 5531.6 04:46:44 INFO - PROCESS | 24032 | 04:46:44 INFO - PROCESS | 24032 | [#1] ext.html Cycles:180 Average:62830.88 Median:44398.45 stddev:123599.51 (278.4%) stddev-sans-first:123857.85 04:46:44 INFO - PROCESS | 24032 | Values: 572.7 605.4 610.3 624.1 635.9 43794.3 44962.0 45154.3 45179.5 49265.0 46428.5 46784.3 46893.6 46942.5 46960.3 9079.5 9204.4 9220.7 9222.3 9225.6 9132.2 9197.2 9222.0 9223.1 9223.8 9234.1 9263.6 9280.2 9282.0 9285.3 9187.3 9188.0 9194.3 9231.9 9235.8 9080.0 9081.0 9120.1 9137.7 9150.5 44030.0 44340.3 44363.3 44433.6 44467.6 3595.4 3603.3 3702.2 3762.2 3858.6 33791.8 33810.7 33954.3 34354.8 35310.6 4466.1 4495.4 4527.2 4585.7 4616.2 362731.0 363333.0 363452.0 364051.0 366122.0 61324.7 61900.7 61918.4 62167.4 62294.4 55373.7 62705.4 64018.0 64079.7 70466.0 16414.8 16643.6 16665.1 16681.7 16686.7 12904.2 12928.8 12969.5 12984.8 13017.9 16312.8 18363.7 18837.7 19077.9 19305.0 6352.2 6524.2 6544.1 6675.4 6718.9 939.5 995.4 1024.7 1055.0 1085.7 32832.7 32861.7 33223.3 33249.5 33753.0 1080.3 1103.9 1106.4 1116.4 1123.0 16750.7 17206.4 17454.6 17512.7 17520.2 545069.1 549398.0 549912.0 550415.0 550609.0 61011.7 61358.4 61419.1 61491.7 61570.0 1326.2 1377.7 1388.6 1563.4 1566.5 31787.8 32625.7 32949.0 33206.5 33849.2 53401.2 53554.7 53564.2 53654.7 53751.5 465453.0 467118.0 467196.0 467822.0 468532.0 28108.6 29048.6 29109.9 30629.8 44701.3 35126.3 48305.5 48927.5 50140.0 53442.5 41488.6 42576.4 42888.1 43187.4 44437.1 41611.0 41840.2 42565.8 43223.0 43788.0 42162.4 42341.6 43670.6 43843.6 43847.1 34031.7 37891.0 38155.8 38311.2 38849.2 28237.6 28288.7 28501.9 28631.9 28781.1 04:46:44 INFO - PROCESS | 24032 | 04:46:44 INFO - PROCESS | 24032 | [#2] jquery.html Cycles:180 Average:30252.77 Median:13156.06 stddev:86986.53 (661.2%) stddev-sans-first:87201.64 04:46:45 INFO - PROCESS | 24032 | Values: 384.7 385.7 397.0 405.3 416.7 18916.9 20299.5 20499.3 20506.8 21284.4 20063.3 20224.7 20313.7 20376.8 20576.7 5568.4 5722.1 5819.8 5833.5 5840.2 5632.3 5754.6 5763.1 5786.3 5788.8 5905.0 5907.7 5958.6 5964.1 5964.9 5767.5 5856.0 5931.1 5931.3 5946.0 5821.2 5822.8 5827.4 5827.5 5829.6 12804.8 17821.4 19054.5 24049.9 24220.8 2047.6 2075.6 2156.3 2262.2 2662.3 10295.1 10299.6 10597.2 10792.9 13773.0 1943.7 1965.5 1966.0 1987.5 2005.1 64813.0 67269.0 67408.7 85884.6 87769.6 8765.7 10376.8 10962.5 11405.4 11480.5 15626.0 15685.7 15693.0 15728.1 15843.1 7432.3 7968.2 8123.0 8125.6 8567.9 8117.9 8160.1 8409.4 8495.0 8515.4 4720.5 4763.3 4823.3 4841.6 4966.2 1864.3 1868.7 1877.0 1935.9 1948.4 907.7 941.4 978.0 1018.2 1056.0 20458.0 20568.3 20632.5 20674.9 20700.1 962.7 995.6 1009.3 1028.2 1033.7 10848.1 10858.5 12118.5 12202.8 12324.6 509922.0 515888.0 538100.0 538314.0 538630.0 94637.0 98468.5 99720.5 101654.5 103835.0 998.0 1038.0 1039.4 1043.5 1063.5 17993.2 18387.7 18927.4 18954.9 18991.0 44907.8 45097.2 45809.0 46121.0 46561.3 42119.4 49558.8 61529.0 61753.7 63848.7 8247.5 8491.4 8571.5 8827.7 8905.4 9700.7 13101.9 13451.5 13583.5 14342.7 11651.2 11941.5 11968.6 12068.3 12342.7 10434.4 11331.0 11641.5 11846.6 12405.8 11714.8 11730.4 11810.8 11955.7 12392.1 7444.4 7574.9 8774.7 8797.1 8983.9 10859.7 11377.1 11521.9 11757.8 11881.2 04:46:45 INFO - PROCESS | 24032 | 04:46:45 INFO - PROCESS | 24032 | [#3] mootools.html Cycles:180 Average:5600.92 Median:4838.95 stddev:3190.65 (65.9%) stddev-sans-first:3184.15 04:46:45 INFO - PROCESS | 24032 | Values: 1422.5 1482.0 1589.8 1712.8 1766.6 8066.5 8607.4 8628.1 8628.8 8629.4 7454.0 8019.4 8271.7 8277.3 8435.5 2259.5 2282.4 2283.4 2286.3 2306.0 2245.9 2263.0 2310.1 2313.0 2313.7 1947.5 2184.3 2249.3 2252.7 2302.5 2260.6 2286.3 2289.3 2289.5 2289.8 2192.6 2198.3 2200.5 2205.6 2210.2 8506.1 8618.5 8623.4 8628.6 8633.5 4947.6 5049.8 5066.7 5067.3 5077.7 3136.9 3206.3 3279.8 3284.0 3287.3 1029.0 1060.2 1084.4 1087.8 1098.1 11862.0 11866.8 11891.6 11895.5 11907.3 4423.2 4428.4 4483.7 4493.6 4535.3 10176.7 10258.7 10264.9 10275.3 10284.4 5136.6 5142.5 5147.3 5153.3 5153.6 4093.1 4143.6 4437.5 4653.8 4730.3 3805.4 3824.4 3932.8 3939.5 3984.6 1242.0 1248.1 1254.1 1257.4 1282.0 821.3 930.1 942.8 947.0 953.3 5803.5 5994.0 5995.5 6025.9 6104.0 440.7 450.9 451.6 453.9 462.1 3962.5 4109.2 4120.7 4130.9 4197.0 9987.6 10594.8 10649.1 10650.5 10682.0 10042.9 10606.4 10612.3 10621.3 10630.7 7645.6 8002.0 8015.7 8018.6 8022.2 5761.7 5886.4 5940.5 6014.8 6053.2 9709.2 9718.0 9743.8 9837.1 9847.9 9350.9 9717.0 9745.1 10022.0 10041.1 6876.8 7078.6 7299.6 7421.7 7619.8 7853.3 8070.2 8156.0 8172.6 8178.4 7192.3 7280.8 7359.9 7364.2 7439.3 7098.3 7167.3 7219.5 7266.4 7331.1 6744.3 6770.4 6818.5 6825.1 6825.8 5046.7 5065.8 5180.6 5226.7 5268.8 5086.2 5105.7 5184.2 5186.5 5320.8 04:46:45 INFO - PROCESS | 24032 | 04:46:45 INFO - PROCESS | 24032 | [#4] prototype.html Cycles:180 Average:4687.30 Median:5327.65 stddev:1347.94 (25.3%) stddev-sans-first:1311.41 04:46:45 INFO - PROCESS | 24032 | Values: 327.8 337.4 344.6 344.7 346.9 5337.8 5392.6 5402.6 5412.6 5427.6 5027.9 5132.0 5254.0 5288.1 5355.9 4168.5 4177.5 4189.8 4197.3 4207.4 4142.1 4194.1 4196.7 4206.2 4208.6 3971.6 4030.5 4108.4 4131.6 4171.7 4115.7 4126.7 4130.5 4139.4 4140.3 3711.7 3720.8 3729.8 3734.9 3744.3 5050.7 5174.8 5179.2 5182.7 5194.3 4758.5 4772.4 4777.6 4788.9 4790.2 5463.8 5507.6 5515.7 5536.9 5542.1 3936.5 4060.3 4104.8 4136.3 4155.2 5640.8 5678.4 5687.9 5717.8 5720.6 4200.6 4203.2 4208.0 4234.8 4259.4 4192.9 4229.5 4268.2 4308.9 4309.9 4749.0 4757.8 4767.4 4772.4 4828.6 5508.7 5546.3 5553.4 5568.2 5574.5 1428.7 1468.5 1471.9 1493.1 1498.9 960.9 977.9 1001.7 1003.9 1005.4 5273.0 5291.2 5293.2 5324.9 5336.4 5661.5 5663.3 5665.4 5679.3 5684.4 5165.0 5231.9 5260.4 5322.4 5323.4 2981.3 2983.6 2997.6 2999.5 3010.7 5560.9 5715.4 5739.8 5746.6 5782.4 5716.8 5723.9 5727.5 5730.8 5750.4 5724.7 5766.6 5767.3 5770.4 5773.3 5384.2 5588.4 5593.4 5617.4 5643.4 5545.1 5556.4 5561.8 5565.8 5566.9 5570.9 5713.9 5715.8 5724.4 5735.4 4097.2 4134.5 4140.4 4142.5 4149.0 5758.4 5777.9 5778.6 5803.5 5810.0 5377.0 5601.0 5682.2 5698.6 5703.1 5606.0 5608.4 5611.9 5617.2 5618.9 5330.4 5386.6 5585.8 5602.0 5602.6 5584.0 5600.9 5605.3 5624.0 5627.6 5443.3 5493.8 5503.2 5511.6 5513.2 04:46:45 INFO - PROCESS | 24032 | 04:46:45 INFO - PROCESS | 24032 | [#5] yui.html Cycles:180 Average:18995.36 Median:4783.94 stddev:25915.29 (541.7%) stddev-sans-first:25951.71 04:46:45 INFO - PROCESS | 24032 | Values: 733.8 742.9 781.0 783.7 784.4 14901.6 15980.8 15987.4 16039.3 16068.1 14297.8 14385.4 14411.5 14412.4 14425.9 642.3 766.1 783.4 784.1 784.7 749.2 781.7 788.9 788.9 790.0 839.2 839.6 842.1 842.9 844.7 677.7 837.6 839.1 839.3 839.5 590.1 613.5 616.1 617.2 617.9 14453.7 14474.0 14493.2 14520.1 14534.0 13759.3 14104.0 14383.2 14442.5 14449.7 12749.9 12765.2 12820.2 12890.4 13092.3 4405.1 4436.1 4541.7 4553.7 4673.2 74977.0 75800.0 76617.6 77075.0 77137.6 11243.2 11275.4 11305.9 11331.9 11718.5 21869.5 21917.9 21948.1 21998.8 22019.6 8473.2 8614.8 8623.5 8672.4 8744.9 4742.9 4783.0 4784.9 4848.0 4861.7 3395.9 3492.1 3492.9 3493.3 3502.3 580.9 585.5 603.2 605.4 607.5 669.1 674.5 674.9 701.9 711.2 9171.6 9344.4 9440.9 9885.2 10051.3 644.2 662.3 667.7 688.9 716.5 4537.0 4618.3 4642.2 4646.5 4651.8 62139.4 64599.0 66402.3 66445.3 66700.0 97889.0 98016.5 98532.0 100240.0 100644.0 87463.0 87972.0 89804.0 91169.5 93788.5 8656.1 9046.1 9065.3 9079.5 9111.3 44983.6 52719.7 52834.7 52852.0 55664.0 48103.3 49209.0 49229.5 57950.4 73595.6 12678.9 12771.5 12884.2 13145.3 13642.9 12797.4 13485.7 14092.9 14611.0 15932.2 12685.6 12751.9 12970.8 13059.0 13224.6 12136.4 12196.5 12831.2 13529.3 14149.3 14273.7 14365.3 14658.5 14930.2 15003.5 10098.9 10243.6 10446.3 10789.9 11317.3 10511.9 11114.3 11196.4 11353.8 11602.1 04:46:45 INFO - PROCESS | 24032 | -------- Summary: end -------- 04:46:45 INFO - PROCESS | 24032 | 04:46:45 INFO - TEST-INFO | 24032: exit 0 04:46:45 INFO - TEST-OK | dromaeo_css | took 1113614ms 04:46:45 INFO - TEST-START | kraken 04:46:45 INFO - operating with platform_type : linux_ 04:46:45 INFO - Initialising browser for kraken test... 04:46:45 INFO - TEST-INFO | started process 24218 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKcEV9p/profile http://localhost:32972/getInfo.html) 04:46:49 INFO - PROCESS | 24218 | __metrics Screen width/height:1600/1200 04:46:49 INFO - PROCESS | 24218 | colorDepth:24 04:46:49 INFO - PROCESS | 24218 | Browser inner width/height: 1024/697 04:46:49 INFO - PROCESS | 24218 | __metrics 04:46:50 INFO - PROCESS | 24218 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:46:50 INFO - PROCESS | 24218 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:46:51 INFO - TEST-INFO | 24218: exit 0 04:46:51 INFO - Browser initialized. 04:46:51 INFO - Running cycle 1/1 for kraken test... 04:46:51 INFO - TEST-INFO | started process 24300 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKcEV9p/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:47:03 INFO - PROCESS | 24300 | RSS: Main: 157507584 04:47:03 INFO - PROCESS | 24300 | 04:47:06 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:32972/tests/kraken/driver.html?testName=audio-beat-detection) 04:47:06 INFO - PROCESS | 24300 | RSS: Main: 213504000 04:47:06 INFO - PROCESS | 24300 | 04:47:09 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:32972/tests/kraken/driver.html?testName=audio-dft) 04:47:10 INFO - PROCESS | 24300 | RSS: Main: 192053248 04:47:10 INFO - PROCESS | 24300 | 04:47:13 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:32972/tests/kraken/driver.html?testName=audio-fft) 04:47:13 INFO - PROCESS | 24300 | RSS: Main: 270172160 04:47:13 INFO - PROCESS | 24300 | 04:47:16 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:32972/tests/kraken/driver.html?testName=audio-oscillator) 04:47:16 INFO - PROCESS | 24300 | RSS: Main: 180191232 04:47:16 INFO - PROCESS | 24300 | 04:47:18 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:32972/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:47:19 INFO - PROCESS | 24300 | RSS: Main: 184754176 04:47:19 INFO - PROCESS | 24300 | 04:47:22 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:32972/tests/kraken/driver.html?testName=imaging-darkroom) 04:47:22 INFO - PROCESS | 24300 | RSS: Main: 220098560 04:47:22 INFO - PROCESS | 24300 | 04:47:26 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:32972/tests/kraken/driver.html?testName=imaging-desaturate) 04:47:26 INFO - PROCESS | 24300 | RSS: Main: 220684288 04:47:26 INFO - PROCESS | 24300 | 04:47:29 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:32972/tests/kraken/driver.html?testName=json-parse-financial) 04:47:30 INFO - PROCESS | 24300 | RSS: Main: 220540928 04:47:30 INFO - PROCESS | 24300 | 04:47:31 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:32972/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:47:32 INFO - PROCESS | 24300 | RSS: Main: 184782848 04:47:32 INFO - PROCESS | 24300 | 04:47:34 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:32972/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:47:34 INFO - PROCESS | 24300 | RSS: Main: 190427136 04:47:34 INFO - PROCESS | 24300 | 04:47:36 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:32972/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:47:37 INFO - PROCESS | 24300 | RSS: Main: 194818048 04:47:37 INFO - PROCESS | 24300 | 04:47:40 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:32972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:47:40 INFO - PROCESS | 24300 | RSS: Main: 190955520 04:47:40 INFO - PROCESS | 24300 | 04:47:43 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:32972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:47:44 INFO - PROCESS | 24300 | RSS: Main: 193097728 04:47:44 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | Cycle 1(1): loaded http://localhost:32972/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:32972/tests/kraken/driver.html?testName=ai-astar) 04:47:45 INFO - PROCESS | 24300 | RSS: Main: 244146176 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | __start_tp_report 04:47:45 INFO - PROCESS | 24300 | _x_x_mozilla_page_load 04:47:45 INFO - PROCESS | 24300 | _x_x_mozilla_page_load_details 04:47:45 INFO - PROCESS | 24300 | |i|pagename|runs| 04:47:45 INFO - PROCESS | 24300 | |0;ai-astar;101;112;112;112;112;111;111;111;111;111 04:47:45 INFO - PROCESS | 24300 | |1;audio-beat-detection;146;116;125;173;123;120;143;118;155;119 04:47:45 INFO - PROCESS | 24300 | |2;audio-dft;162;161;160;160;161;161;158;160;161;161 04:47:45 INFO - PROCESS | 24300 | |3;audio-fft;74;74;75;123;75;75;75;74;110;77 04:47:45 INFO - PROCESS | 24300 | |4;audio-oscillator;84;84;124;84;84;82;126;84;84;122 04:47:45 INFO - PROCESS | 24300 | |5;imaging-gaussian-blur;117;116;116;116;117;117;117;117;117;117 04:47:45 INFO - PROCESS | 24300 | |6;imaging-darkroom;145;145;146;145;145;145;146;146;146;145 04:47:45 INFO - PROCESS | 24300 | |7;imaging-desaturate;94;94;94;94;96;95;95;94;94;96 04:47:45 INFO - PROCESS | 24300 | |8;json-parse-financial;52;50;50;52;52;51;50;51;50;50 04:47:45 INFO - PROCESS | 24300 | |9;json-stringify-tinderbox;64;64;64;64;64;63;63;64;64;63 04:47:45 INFO - PROCESS | 24300 | |10;stanford-crypto-aes;76;76;74;75;75;76;75;75;74;79 04:47:45 INFO - PROCESS | 24300 | |11;stanford-crypto-ccm;121;129;130;129;139;125;128;143;163;121 04:47:45 INFO - PROCESS | 24300 | |12;stanford-crypto-pbkdf2;167;161;161;157;159;157;166;155;160;158 04:47:45 INFO - PROCESS | 24300 | |13;stanford-crypto-sha256-iterative;63;63;62;62;61;61;63;62;61;62 04:47:45 INFO - PROCESS | 24300 | __end_tp_report 04:47:45 INFO - PROCESS | 24300 | __start_cc_report 04:47:45 INFO - PROCESS | 24300 | _x_x_mozilla_cycle_collect,1734 04:47:45 INFO - PROCESS | 24300 | __end_cc_report 04:47:45 INFO - PROCESS | 24300 | __startTimestamp1469015265908__endTimestamp 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | ------- Summary: start ------- 04:47:45 INFO - PROCESS | 24300 | Number of tests: 14 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#0] ai-astar Cycles:10 Average:110.40 Median:111.50 stddev:3.34 (3.0%) stddev-sans-first:0.53 04:47:45 INFO - PROCESS | 24300 | Values: 101.0 112.0 112.0 112.0 112.0 111.0 111.0 111.0 111.0 111.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#1] audio-beat-detection Cycles:10 Average:133.80 Median:134.00 stddev:19.41 (14.5%) stddev-sans-first:20.08 04:47:45 INFO - PROCESS | 24300 | Values: 146.0 116.0 125.0 173.0 123.0 120.0 143.0 118.0 155.0 119.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#2] audio-dft Cycles:10 Average:160.50 Median:161.00 stddev:1.08 (0.7%) stddev-sans-first:1.00 04:47:45 INFO - PROCESS | 24300 | Values: 162.0 161.0 160.0 160.0 161.0 161.0 158.0 160.0 161.0 161.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#3] audio-fft Cycles:10 Average:83.20 Median:75.00 stddev:17.84 (23.8%) stddev-sans-first:18.61 04:47:45 INFO - PROCESS | 24300 | Values: 74.0 74.0 75.0 123.0 75.0 75.0 75.0 74.0 110.0 77.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#4] audio-oscillator Cycles:10 Average:95.80 Median:84.00 stddev:19.49 (23.2%) stddev-sans-first:20.20 04:47:45 INFO - PROCESS | 24300 | Values: 84.0 84.0 124.0 84.0 84.0 82.0 126.0 84.0 84.0 122.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#5] imaging-gaussian-blur Cycles:10 Average:116.70 Median:117.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:47:45 INFO - PROCESS | 24300 | Values: 117.0 116.0 116.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#6] imaging-darkroom Cycles:10 Average:145.40 Median:145.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 04:47:45 INFO - PROCESS | 24300 | Values: 145.0 145.0 146.0 145.0 145.0 145.0 146.0 146.0 146.0 145.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#7] imaging-desaturate Cycles:10 Average:94.60 Median:94.50 stddev:0.84 (0.9%) stddev-sans-first:0.87 04:47:45 INFO - PROCESS | 24300 | Values: 94.0 94.0 94.0 94.0 96.0 95.0 95.0 94.0 94.0 96.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#8] json-parse-financial Cycles:10 Average:50.80 Median:51.00 stddev:0.92 (1.8%) stddev-sans-first:0.87 04:47:45 INFO - PROCESS | 24300 | Values: 52.0 50.0 50.0 52.0 52.0 51.0 50.0 51.0 50.0 50.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#9] json-stringify-tinderbox Cycles:10 Average:63.70 Median:64.00 stddev:0.48 (0.8%) stddev-sans-first:0.50 04:47:45 INFO - PROCESS | 24300 | Values: 64.0 64.0 64.0 64.0 64.0 63.0 63.0 64.0 64.0 63.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#10] stanford-crypto-aes Cycles:10 Average:75.50 Median:75.50 stddev:1.43 (1.9%) stddev-sans-first:1.51 04:47:45 INFO - PROCESS | 24300 | Values: 76.0 76.0 74.0 75.0 75.0 76.0 75.0 75.0 74.0 79.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#11] stanford-crypto-ccm Cycles:10 Average:132.80 Median:129.50 stddev:12.71 (9.8%) stddev-sans-first:12.74 04:47:45 INFO - PROCESS | 24300 | Values: 121.0 129.0 130.0 129.0 139.0 125.0 128.0 143.0 163.0 121.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:160.10 Median:160.50 stddev:3.87 (2.4%) stddev-sans-first:3.20 04:47:45 INFO - PROCESS | 24300 | Values: 167.0 161.0 161.0 157.0 159.0 157.0 166.0 155.0 160.0 158.0 04:47:45 INFO - PROCESS | 24300 | 04:47:45 INFO - PROCESS | 24300 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:62.00 Median:62.00 stddev:0.82 (1.3%) stddev-sans-first:0.78 04:47:45 INFO - PROCESS | 24300 | Values: 63.0 63.0 62.0 62.0 61.0 61.0 63.0 62.0 61.0 62.0 04:47:45 INFO - PROCESS | 24300 | -------- Summary: end -------- 04:47:45 INFO - PROCESS | 24300 | 04:47:46 INFO - TEST-INFO | 24300: exit 0 04:47:46 INFO - TEST-OK | kraken | took 61189ms 04:47:46 INFO - SUITE-END | took 1174s 04:47:47 INFO - Completed test suite (00:19:34) 04:47:47 INFO - javascript benchmark 04:47:47 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2995.55066739989, 3005.053408176426, 3037.5139977603576, 3046.527788192831, 3052.0691189187287, 5116.053530096935, 5212.2963399941, 5219.86950326242, 5289.100852855015, 5362.812301569451, 5175.0, 5202.245674377213, 5223.2165175223645, 5253.763580638871, 5315.0698627740085, 4614.330922016297, 4669.042846216517, 4684.836030738925, 4708.0, 4905.632077594177, 4823.807047718087, 4853.8543843684565, 4854.077725232195, 4867.36724225852, 4876.902461950759, 4666.65000124992, 4679.227927391977, 4709.411323584552, 4724.220503616916, 4725.645576581753, 4704.0356726870905, 4709.175894218532, 4723.385959825201, 4763.642726795504, 4791.6406269529925, 4753.78607962639, 4762.9759601685455, 4769.880752981168, 4800.735959522225, 4806.975965120187, 5122.154844450662, 5179.04187725272, 5223.843284701465, 5299.947000530023, 5325.3077099977145, 5594.9720251398885, 5632.9436705632825, 5636.661800291996, 5639.6334238274385, 5648.830535083913, 5597.160425936101, 5663.008973429633, 5687.971560142173, 5688.175214593861, 5689.9146512802345, 5122.615803814729, 5188.948110518884, 5221.895562088737, 5232.215167724834, 5302.840914772563, 5766.308043034863, 5771.451712087345, 5772.971135144381, 5777.162311464814, 5779.479846813807, 5560.165975103767, 5563.082091454865, 5566.693831839288, 5566.832995010156, 5569.443055694398, 5427.728613569306, 5454.0182767101505, 5526.419725928719, 5529.087700529368, 5636.718164091779, 5534.0315444797, 5540.612157149041, 5542.0, 5542.168674698827, 5563.916541251884, 5494.478024587658, 5536.197251398525, 5540.833774986757, 5548.9722551386985, 5550.528205102531, 4222.345536441856, 4225.408442818008, 4264.466941632296, 4308.784560771949, 4319.6112349888035, 3876.1472476055224, 3898.1618951924906, 3898.200868821885, 3898.629630185128, 3899.239648268617, 5278.419373868871, 5320.654157479751, 5330.840074797762, 5344.652597581145, 5348.03735327637, 5648.774049038075, 5648.802291919763, 5654.038813401731, 5708.857278568069, 5710.600257981984, 5267.841964741064, 5305.840824775263, 5306.283651707047, 5309.522143007148, 5314.840554783363, 4778.4982576829625, 4792.592629626451, 4816.927746083811, 4828.010257897123, 4911.9754401227765, 5713.085906254979, 5729.140628905698, 5743.712814359265, 5774.653520788766, 5792.913106303409, 5486.286782718221, 5584.385717571064, 5588.413216612197, 5591.524720398812, 5592.86017849557, 5615.803446879339, 5652.491275785199, 5672.631278966854, 5731.942680573307, 5733.426657334233, 5423.3491980962535, 5435.782568697208, 5440.836774896759, 5472.097103977799, 5491.560675146058, 5501.862453438696, 5508.834734957958, 5513.889722205453, 5519.254900588369, 5532.529734972572, 5408.729563521887, 5409.675419474844, 5436.021516127135, 5439.782408703608, 5491.560675146058, 5502.367227768857, 5504.311961004874, 5515.889682206413, 5537.584681148849, 5550.000999820071, 5439.456054394687, 5483.7806487740045, 5490.615656904138, 5500.724963751716, 5501.037318469172, 5280.683159010472, 5483.917741233964, 5556.888862222652, 5609.49514543693, 5617.354004289559, 5461.918071228855, 5473.206385074062, 5477.726113694379, 5509.173623956439, 5531.585131115263], "value": 5162.752643622049, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.6792995922282, 605.4490413723511, 610.3255902228036, 624.0545573456214, 635.9491240700744, 43794.34308485371, 44962.0, 45154.32268515971, 45179.548204517945, 49265.0, 46428.53571464284, 46784.29823552641, 46893.5931922042, 46942.53057469424, 46960.295595566095, 9079.45523268606, 9204.355695101345, 9220.723378298662, 9222.262219022496, 9225.584848681792, 9132.178103970642, 9197.172254497094, 9221.95389023054, 9223.123803238681, 9223.815523689522, 9234.07659234078, 9263.583138758739, 9280.211182049534, 9282.0, 9285.303602229826, 9187.26501879848, 9188.035256298093, 9194.31042671799, 9231.90768092324, 9235.815283694355, 9080.046595107484, 9081.0, 9120.087991200893, 9137.680181193626, 9150.542472876396, 44030.0, 44340.3348949766, 44363.33454998177, 44433.555664443586, 44467.555324446665, 3595.442706380515, 3603.333383324067, 3702.1670124221832, 3762.1535154590274, 3858.5562660293863, 33791.83104084488, 33810.66189338124, 33954.32091358184, 34354.82822585871, 35310.64689353099, 4466.0844526871915, 4495.370648109268, 4527.230370836965, 4585.679002469828, 4616.238320677118, 362730.9999999974, 363333.0, 363452.0, 364051.0, 366122.0, 61324.69337653283, 61900.69049654723, 61918.38081619216, 62167.37832621616, 62294.377056229765, 55373.72313138408, 62705.372946270865, 64018.0, 64079.67960160263, 70466.0, 16414.753778693328, 16643.583910402336, 16665.083420411753, 16681.666366672598, 16686.666266674598, 12904.225746455242, 12928.806067908989, 12969.481220751253, 12984.805227921588, 13017.869821301856, 16312.836871631369, 18363.724544131583, 18837.717434238497, 19077.90461047686, 19305.0, 6352.18868678789, 6524.249711283263, 6544.102210358943, 6675.42601927396, 6718.899216511756, 939.4598106089027, 995.4127065031666, 1024.6721049264163, 1054.9736256593646, 1085.67972448128, 32832.67167328296, 32861.67138328586, 33223.3355332892, 33249.501257481155, 33753.0, 1080.3193987787802, 1103.9116870650328, 1106.44124717019, 1116.4194618798342, 1123.0, 16750.74873876893, 17206.397776077778, 17454.56363590895, 17512.737308940377, 17520.21159047846, 545069.1198160154, 549398.0, 549912.0, 550415.0, 550609.0, 61011.69494152589, 61358.38641613616, 61419.07871381933, 61491.692541537006, 61570.0, 1326.157889740022, 1377.6831328794233, 1388.576484172317, 1563.4293482878668, 1566.5222107257396, 31787.841060795472, 32625.673743263214, 32949.0, 33206.501902471, 33849.15377115592, 53401.198982014525, 53554.732226338616, 53564.1965370512, 53654.73172634112, 53751.46248537464, 465453.0, 467118.0, 467196.0, 467822.0, 468532.0, 28108.578371324038, 29048.56427153637, 29109.85445072761, 30629.846850765603, 44701.32948005848, 35126.29747405089, 48305.51694483151, 48927.51072489372, 50140.0, 53442.46557534375, 41488.58511414968, 42576.36135457909, 42888.142237155706, 43187.35218971655, 44437.11125777401, 41611.0, 41840.16319673529, 42565.787171063945, 43223.0, 43788.0, 42162.36756448595, 42341.576584234994, 43670.56329436665, 43843.56156438522, 43847.123057539306, 34031.659683402846, 37891.0, 38155.80922095372, 38311.233775324894, 38849.22301553896, 28237.57643635306, 28288.71711282861, 28501.857490712413, 28631.856840715664, 28781.136565903056], "value": 20777.646174057314, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.6862962981419, 385.703008683314, 396.9702272329576, 405.3109713487072, 416.7124683968062, 18916.90541547292, 20299.49251268719, 20499.282525111605, 20506.794932050674, 21284.361469155912, 20063.297784577542, 20224.69662955057, 20313.695294570593, 20376.796232037676, 20576.69134962973, 5568.415316391782, 5722.1416787482, 5819.7963071292515, 5833.533317334603, 5840.240768700063, 5632.26780518532, 5754.597178197507, 5763.106718458645, 5786.276715410574, 5788.768449262046, 5905.0, 5907.6750778707155, 5958.553108516857, 5964.075568286922, 5964.880702385972, 5767.509761670263, 5855.970720146414, 5931.110333449974, 5931.288245410536, 5946.048632218867, 5821.243238379026, 5822.796202132948, 5827.35899051104, 5827.533797296206, 5829.562782791308, 12804.80792788109, 17821.376251831123, 19054.52363690905, 24049.879750601136, 24220.757792422028, 2047.5904819036102, 2075.647139986206, 2156.3315372234656, 2262.230841513877, 2662.267876334004, 10295.124914382286, 10299.639512617097, 10597.205209609234, 10792.892071079266, 13773.0, 1943.7278780970676, 1965.4693232827058, 1965.9705104423444, 1987.5329297615049, 2005.0576229172266, 64813.0, 67269.0, 67408.6629566854, 85884.57057714734, 87769.56115219447, 8765.737027889174, 10376.792464150674, 10962.506687199095, 11405.429728513707, 11480.483378247998, 15626.0, 15685.66671832907, 15693.0, 15728.13495257749, 15843.128627925575, 7432.2567743225245, 7968.163342849033, 8123.0, 8125.553094579855, 8567.871481927776, 8117.878231826528, 8160.102388737353, 8409.369297302605, 8494.957525212334, 8515.446495977742, 4720.480747117815, 4763.309320148559, 4823.300621409876, 4841.612670986313, 4966.205407134841, 1864.3102052240758, 1868.7290342900203, 1876.9624607507774, 1935.9322423715103, 1948.366780796247, 907.6641642592283, 941.3645789092335, 977.9902200977899, 1018.2159737002614, 1056.0179033498919, 20458.0, 20568.280110196072, 20632.484187895123, 20674.862882541605, 20700.068496917676, 962.6726912849665, 995.5669283861544, 1009.258195226508, 1028.177458033585, 1033.705393962717, 10848.132149428027, 10858.514050815518, 12118.515259389702, 12202.755944881053, 12324.630261092181, 509922.0, 515888.0, 538100.0, 538314.0, 538630.0, 94637.0, 98468.50765746269, 99720.50139749255, 101654.4917275409, 103835.0, 997.9700608981742, 1037.9636712715019, 1039.3607931122306, 1043.4939054558533, 1063.5373612478597, 17993.190306436503, 18387.72418413698, 18927.432177034712, 18954.905225473784, 18991.0, 44907.77546112249, 45097.19611215646, 45809.0, 46121.0, 46561.30158047564, 42119.36820947627, 49558.75220624018, 61529.0, 61753.691231543555, 63848.68075659592, 8247.463914845515, 8491.405601607828, 8571.528565928933, 8827.691030814147, 8905.376623636283, 9700.708978730649, 13101.902579938316, 13451.529196478075, 13583.52457663977, 14342.713145737236, 11651.242669226473, 11941.462634181657, 11968.581099661471, 12068.275903445821, 12342.691432713895, 10434.426106564211, 11331.036861866834, 11641.476133574179, 11846.58536951237, 12405.766961946576, 11714.824277635671, 11730.354830484064, 11810.76378472443, 11955.701107472034, 12392.132550721724, 7444.441666875115, 7574.863770434258, 8774.736757897273, 8797.120287971407, 8983.865242021244, 10859.728506787393, 11377.146713996317, 11521.942390287995, 11757.764844702888, 11881.22772019816], "value": 9346.259711839408, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1422.4879043544322, 1481.9996502360905, 1589.793326867507, 1712.777338945937, 1766.6290079083392, 8066.475679080863, 8607.39748217625, 8628.09405012474, 8628.784280392993, 8629.352798540103, 7453.962730186341, 8019.438639295252, 8271.710490132846, 8277.337812974962, 8435.536045517494, 2259.5029093599424, 2282.417983414227, 2283.4177284792354, 2286.3483907086484, 2305.965410518835, 2245.9101635934544, 2262.988685056581, 2310.099061366069, 2313.0400883633274, 2313.699219101523, 1947.5423275530238, 2184.3119417383473, 2249.32520243927, 2252.6733623624564, 2302.458922153293, 2260.581792368417, 2286.314105768263, 2289.267434420986, 2289.519200967799, 2289.782470665284, 2192.6382146945734, 2198.274569392113, 2200.460887082659, 2205.647096464574, 2210.2043264424956, 8506.106858779802, 8618.525981071038, 8623.396362254645, 8628.611712472954, 8633.525156116411, 4947.604191664658, 5049.772760225762, 5066.695998240118, 5067.341245638044, 5077.746112694351, 3136.921576960571, 3206.3106432116974, 3279.8032118072992, 3283.950740738891, 3287.309664970359, 1028.9794204115876, 1060.2313322840955, 1084.3710647824244, 1087.7770057138268, 1098.0940723902731, 11862.0, 11866.821997670042, 11891.583794567236, 11895.464704088337, 11907.28556286617, 4423.203823311835, 4428.402165707588, 4483.730976141442, 4493.550644935481, 4535.251683472256, 10176.745581360377, 10258.692239232685, 10264.897351026544, 10275.280730348804, 10284.434356110485, 5136.563392111712, 5142.485751424828, 5147.279380886679, 5153.330067091254, 5153.561947234452, 4093.1404405074672, 4143.606357396043, 4437.534058923831, 4653.837115700934, 4730.290456431563, 3805.391137418055, 3824.3880979043774, 3932.783696896698, 3939.4878665773267, 3984.561698213194, 1241.975160496785, 1248.0888951065592, 1254.0782524844233, 1257.352463481308, 1281.9679508012375, 821.2977903892206, 930.1210356213448, 942.8255772682076, 946.9857952130724, 953.2755106119399, 5803.47768700819, 5994.0409534474275, 5995.520358371407, 6025.935913705587, 6103.969480152571, 440.69371786608, 450.86474057782533, 451.56649616368, 453.8774530876645, 462.1358060427023, 3962.5443074046275, 4109.219248342805, 4120.690948178899, 4130.938035929464, 4196.979015104966, 9987.550560224661, 10594.788104238027, 10649.148068154529, 10650.520726567323, 10682.038616524394, 10042.899571004342, 10606.416647084485, 10612.25714200014, 10621.256512044238, 10630.681079567625, 7645.617719114022, 8002.0, 8015.719449819228, 8018.55897925608, 8022.237887400687, 5761.654300741801, 5886.38192989747, 5940.46535811779, 6014.8195554133445, 6053.182820319201, 9709.174720148867, 9718.0, 9743.80512389734, 9837.065478779505, 9847.882705218413, 9350.859737103812, 9717.0, 9745.12293893553, 10022.0, 10041.146502547364, 6876.759313424006, 7078.575285482888, 7299.598522081336, 7421.666025028779, 7619.809504762426, 7853.253940875607, 8070.2333278338465, 8156.0, 8172.5913704315735, 8178.386621003568, 7192.31672991065, 7280.7815765525, 7359.889601656087, 7364.226756190523, 7439.293267139613, 7098.3256590623805, 7167.283271672791, 7219.45854060937, 7266.418686505172, 7331.120265568166, 6744.325567443217, 6770.390664840188, 6818.522703410912, 6825.146856642919, 6825.761098361533, 5046.747662616928, 5065.797368105234, 5180.559652429435, 5226.686398816083, 5268.841934741964, 5086.21163719624, 5105.7191854448365, 5184.222366645034, 5186.521841275218, 5320.787168513216], "value": 4414.967983903062, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [327.8263001293038, 337.360701470713, 344.626080702438, 344.7345543931172, 346.93234819210267, 5337.8398648040575, 5392.56859451244, 5402.567794576435, 5412.621116521836, 5427.647202931812, 5027.874303142414, 5132.0, 5254.031472218204, 5288.127458969275, 5355.946440535594, 4168.499780026394, 4177.4778152730905, 4189.769562674067, 4197.328427451608, 4207.389928460371, 4142.0680346922, 4194.077302993336, 4196.685248606352, 4206.179794939988, 4208.600182982612, 3971.642552170304, 4030.496187976503, 4108.424820525114, 4131.566185550519, 4171.707980441355, 4115.662409716854, 4126.690498212616, 4130.483689538808, 4139.379093136024, 4140.3375459926265, 3711.6659500645073, 3720.776753394778, 3729.7948612826285, 3734.9439758403646, 3744.2885851688366, 5050.696958182521, 5174.843345559206, 5179.19722443022, 5182.663126896739, 5194.27280180775, 4758.524147585248, 4772.379590653228, 4777.570018698334, 4788.880277993043, 4790.209615413452, 5463.836084917459, 5507.614466987313, 5515.7242137893345, 5536.861578460531, 5542.11326187808, 3936.5079365079364, 4060.2691515527194, 4104.7890872192775, 4136.31750761124, 4155.16896620674, 5640.830775076754, 5678.43215678433, 5687.914681279784, 5717.798033101477, 5720.6281591696825, 4200.550809970555, 4203.159368126387, 4208.0, 4234.809433575497, 4259.446271984684, 4192.874213773592, 4229.47265247935, 4268.189044081614, 4308.89227769302, 4309.913801723948, 4749.0, 4757.833475828329, 4767.427908650984, 4772.403449568804, 4828.565429111397, 5508.724563771875, 5546.251256080377, 5553.389127196006, 5568.16477528374, 5574.470425309589, 1428.6928310413311, 1468.4933697874217, 1471.8896082793833, 1493.126520985214, 1498.85760852721, 960.9087136722001, 977.9438206736708, 1001.6644424117857, 1003.9458568503043, 1005.3716427232979, 5272.9736351318, 5291.206319052096, 5293.232481290268, 5324.893502129936, 5336.359636843526, 5661.547076233891, 5663.263775709132, 5665.3768085510565, 5679.31848178213, 5684.403137670568, 5164.974175129176, 5231.921521177185, 5260.368755749335, 5322.441143679858, 5323.3611966563485, 2981.3292009297734, 2983.6275313355663, 2997.595324631147, 2999.460097182528, 3010.668826429091, 5560.860978475571, 5715.428457154251, 5739.799107031317, 5746.626469279484, 5782.421757824184, 5716.771329146787, 5723.942760572341, 5727.541796656257, 5730.77076916927, 5750.396208398141, 5724.656520608777, 5766.567507436959, 5767.250257466502, 5770.3652598215, 5773.278340207474, 5384.192371144203, 5588.441155884379, 5593.384727679871, 5617.410171931889, 5643.407442218672, 5545.140503222007, 5556.388797232382, 5561.833145005657, 5565.833025009256, 5566.860828479321, 5570.944290557205, 5713.857153571194, 5715.828525144252, 5724.425782909733, 5735.426457354231, 4097.201045796041, 4134.545200028055, 4140.420341152181, 4142.502899652061, 4149.0, 5758.424157584375, 5777.8555536111935, 5778.566607504538, 5803.47768700819, 5809.970950145223, 5377.0, 5601.0, 5682.204491371129, 5698.6010979232715, 5703.116017017369, 5606.009866497498, 5608.364068887617, 5611.859703507445, 5617.157426386075, 5618.887622247614, 5330.413654497925, 5386.596005299697, 5585.776568937197, 5601.991641504405, 5602.579806514609, 5583.972080139736, 5600.859978500407, 5605.32736071674, 5624.0, 5627.634203776742, 5443.292371991616, 5493.7802487900035, 5503.229547863382, 5511.649645836796, 5513.173024046425], "value": 4262.4334446737075, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [733.8422239218573, 742.8699977503935, 781.0315209140667, 783.7256960063977, 784.388177221767, 14901.62745931351, 15980.84019159811, 15987.440439584589, 16039.278232479537, 16068.116253606062, 14297.78553321701, 14385.352659130338, 14411.495597654084, 14412.423503059892, 14425.92787036066, 642.3480167629837, 766.0577489687673, 783.4085265624474, 784.1374488063113, 784.7018133109439, 749.153456594048, 781.6677911887454, 788.8816677498393, 788.9329407000412, 789.9644515996765, 839.1566475691922, 839.5718183726314, 842.061101871412, 842.9072801991807, 844.7254642241265, 677.6848765324148, 837.5937670229933, 839.0812060793421, 839.3285371702614, 839.49630221867, 590.1236663554618, 613.4570904749285, 616.1189499016449, 617.2161355079024, 617.8702472480785, 14453.710925781426, 14474.0, 14493.202873841934, 14520.128792272497, 14534.0, 13759.312034398241, 14104.0, 14383.208923509203, 14442.494512692005, 14449.711005779825, 12749.872501274962, 12765.23408595478, 12820.23078615286, 12890.355482225852, 13092.279924604143, 4405.074934263808, 4436.0906014267, 4541.659375546814, 4553.704009239422, 4673.182193116225, 74977.0, 75800.0, 76617.61691191564, 77075.0, 77137.61431192864, 11243.156763242789, 11275.379854108103, 11305.943470282597, 11331.886681133083, 11718.531258749554, 21869.453263668216, 21917.890410547847, 21948.122075117135, 21998.780012199994, 22019.559608807733, 8473.195046470575, 8614.784630384165, 8623.5257060861, 8672.436291641023, 8744.8688269676, 4742.928856067162, 4782.95217047832, 4784.928226076611, 4847.975760121248, 4861.6596838220985, 3395.932081358359, 3492.109512074405, 3492.877749278814, 3493.336266109482, 3502.2995400919917, 580.8867270882222, 585.487698264019, 603.2007589943343, 605.3734384911595, 607.471499795181, 669.1167658690579, 674.5143496682381, 674.8717743628695, 701.8631366883511, 711.2247650061457, 9171.58727857248, 9344.439333640003, 9440.858387124199, 9885.209183265322, 10051.346662467062, 644.1947565543071, 662.3372748699699, 667.6695035957135, 688.9189803603657, 716.534252735726, 4536.954630453653, 4618.261078227468, 4642.16441040616, 4646.512116227815, 4651.837185698484, 62139.37860621336, 64599.0, 66402.33597664058, 66445.33554664488, 66700.0, 97889.0, 98016.50991745139, 98532.0, 100240.0, 100644.0, 87463.0, 87972.0, 89804.0, 91169.54415227882, 93788.53105734427, 8656.134172075228, 9046.140616641409, 9065.32010099232, 9079.54602269897, 9111.271098312252, 44983.55016449794, 52719.73640131775, 52834.73582632216, 52852.0, 55664.0, 48103.27845082257, 49209.0, 49229.507704923926, 57950.42049579619, 73595.6320218417, 12678.87321126777, 12771.489140434278, 12884.226946383247, 13145.277009764171, 13642.86357136416, 12797.42411591462, 13485.730285394433, 14092.929535352258, 14611.0, 15932.203389830695, 12685.619431417072, 12751.936240318739, 12970.805437918627, 13059.0, 13224.603261902159, 12136.393180341125, 12196.451159698012, 12831.230126192459, 13529.2558909257, 14149.292535372984, 14273.71452570922, 14365.281735912953, 14658.486952956595, 14930.17884016346, 15003.474878379204, 10098.949505252427, 10243.641472548425, 10446.268761186644, 10789.946050269698, 11317.320960742381, 10511.896250893546, 11114.333140011626, 11196.392306773178, 11353.772924541629, 11602.129840261845], "value": 7329.9011966839935, "unit": "score"}], "name": "dromaeo_css", "value": 7191.30826217845, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 112.0, 112.0, 112.0, 112.0, 111.0, 111.0, 111.0, 111.0, 111.0], "value": 110.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 116.0, 125.0, 173.0, 123.0, 120.0, 143.0, 118.0, 155.0, 119.0], "value": 133.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 161.0, 160.0, 160.0, 161.0, 161.0, 158.0, 160.0, 161.0, 161.0], "value": 160.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [74.0, 74.0, 75.0, 123.0, 75.0, 75.0, 75.0, 74.0, 110.0, 77.0], "value": 83.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 84.0, 124.0, 84.0, 84.0, 82.0, 126.0, 84.0, 84.0, 122.0], "value": 95.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 116.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 116.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 145.0, 146.0, 145.0, 145.0, 145.0, 146.0, 146.0, 146.0, 145.0], "value": 145.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 96.0, 95.0, 95.0, 94.0, 94.0, 96.0], "value": 94.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 50.0, 52.0, 52.0, 51.0, 50.0, 51.0, 50.0, 50.0], "value": 50.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 63.0, 63.0, 64.0, 64.0, 63.0], "value": 63.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 74.0, 75.0, 75.0, 76.0, 75.0, 75.0, 74.0, 79.0], "value": 75.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 129.0, 130.0, 129.0, 139.0, 125.0, 128.0, 143.0, 163.0, 121.0], "value": 132.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 161.0, 161.0, 157.0, 159.0, 157.0, 166.0, 155.0, 160.0, 158.0], "value": 160.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 62.0, 62.0, 61.0, 61.0, 63.0, 62.0, 61.0, 62.0], "value": 62.0, "unit": "score"}], "name": "kraken", "value": 1485.3, "alertThreshold": 2.0}]} 04:47:47 INFO - Return code: 0 04:47:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:47:47 INFO - # TBPL SUCCESS # 04:47:47 INFO - Running post-action listener: _resource_record_post_action 04:47:47 INFO - ##### 04:47:47 INFO - ##### Finished run-tests step (success) 04:47:47 INFO - ##### 04:47:47 INFO - Running post-run listener: _resource_record_post_run 04:47:47 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 552910848; Read time: 0; Write time: 498252 04:47:47 INFO - TinderboxPrint: CPU usage
13.0% 04:47:47 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 04:47:47 INFO - TinderboxPrint: I/O write bytes / time
552,910,848 / 498,252 04:47:47 INFO - TinderboxPrint: CPU idle
8,276.6 (87.0%) 04:47:47 INFO - TinderboxPrint: CPU user
1,191.5 (12.5%) 04:47:47 INFO - TinderboxPrint: Swap in / out
0 / 0 04:47:47 INFO - install - Wall time: 18s; CPU: 14.0%; Read bytes: 0; Write bytes: 257679360; Read time: 0; Write time: 311960 04:47:47 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295231488; Read time: 0; Write time: 186292 04:47:47 INFO - Running post-run listener: _upload_blobber_files 04:47:47 INFO - Blob upload gear active. 04:47:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:47:47 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:47:47 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', 'Mozilla-Inbound', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:47:47 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 Mozilla-Inbound -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:47:48 INFO - (blobuploader) - INFO - Open directory for files ... 04:47:48 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:47:48 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:48 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:47:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:49 INFO - (blobuploader) - INFO - Done attempting. 04:47:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:47:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:47:59 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:47:59 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:47:59 INFO - (blobuploader) - INFO - Done attempting. 04:47:59 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:47:59 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:47:59 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:48:00 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:48:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:48:00 INFO - (blobuploader) - INFO - Done attempting. 04:48:00 INFO - (blobuploader) - INFO - Iteration through files over. 04:48:00 INFO - Return code: 0 04:48:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:48:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:48:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/240e0888a695862bf1d5d0d861ed49821104bb3d1e61a0dacc8710f1046abad78e683c808a9a0a8846c22c686755c431ee38a62143381dc6befd7a7fb863bdc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac60711c7695965f4d213d8320056c3524aff7ccafc611ea08c360096e87aad3e5d1354e9d2439a66fa944f57ae9699610f37d98786fe8f0303bb2cb5826e040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b7ed5774ffbbe6adab141c4f72e5b87023b51b1aa3744f72616b01ba9b23b94f43d0141334749b009a7a7cfdde51011e128c439173b6a0ca9d3d52a79be615c"} 04:48:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:48:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:48:00 INFO - Contents: 04:48:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/240e0888a695862bf1d5d0d861ed49821104bb3d1e61a0dacc8710f1046abad78e683c808a9a0a8846c22c686755c431ee38a62143381dc6befd7a7fb863bdc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac60711c7695965f4d213d8320056c3524aff7ccafc611ea08c360096e87aad3e5d1354e9d2439a66fa944f57ae9699610f37d98786fe8f0303bb2cb5826e040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b7ed5774ffbbe6adab141c4f72e5b87023b51b1aa3744f72616b01ba9b23b94f43d0141334749b009a7a7cfdde51011e128c439173b6a0ca9d3d52a79be615c"} 04:48:00 INFO - Running post-run listener: copy_logs_to_upload_dir 04:48:00 INFO - Copying logs to upload dir... 04:48:00 INFO - mkdir: /builds/slave/test/build/upload/logs 04:48:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1238.510250 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 38 secs) (at 2016-07-20 04:48:00.804317) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 04:48:00.807790) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/240e0888a695862bf1d5d0d861ed49821104bb3d1e61a0dacc8710f1046abad78e683c808a9a0a8846c22c686755c431ee38a62143381dc6befd7a7fb863bdc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac60711c7695965f4d213d8320056c3524aff7ccafc611ea08c360096e87aad3e5d1354e9d2439a66fa944f57ae9699610f37d98786fe8f0303bb2cb5826e040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b7ed5774ffbbe6adab141c4f72e5b87023b51b1aa3744f72616b01ba9b23b94f43d0141334749b009a7a7cfdde51011e128c439173b6a0ca9d3d52a79be615c"} build_url:https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/Z6kATvWsTRafEg1etWTXwQ/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/Mozilla-Inbound/sha512/240e0888a695862bf1d5d0d861ed49821104bb3d1e61a0dacc8710f1046abad78e683c808a9a0a8846c22c686755c431ee38a62143381dc6befd7a7fb863bdc2", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/ac60711c7695965f4d213d8320056c3524aff7ccafc611ea08c360096e87aad3e5d1354e9d2439a66fa944f57ae9699610f37d98786fe8f0303bb2cb5826e040", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/3b7ed5774ffbbe6adab141c4f72e5b87023b51b1aa3744f72616b01ba9b23b94f43d0141334749b009a7a7cfdde51011e128c439173b6a0ca9d3d52a79be615c"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-20 04:48:00.833465) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:48:00.833795) ========= 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=9c43b49b387003dc8f5b4e5c000001c4-1469014040.464968-1659379070 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004453 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-20 04:48:00.919297) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 04:48:00.919645) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-20 04:48:00.919936) ========= ========= Total master_lag: 0.17 =========