builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs-pgo slave: talos-linux64-ix-016 starttime: 1467274592.99 results: success (0) buildid: 20160629223106 builduid: 665543db0a784c78832b5b8cef3764b2 revision: 633d41ede644 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:32.990578) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:32.991061) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:32.991342) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:33.029430) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:33.029975) ========= 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=00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-06-30 01:16:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 212M=0s 2016-06-30 01:16:33 (212 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110415 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:33.154286) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:33.154561) ========= 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=00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:33.203523) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:33.203824) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 633d41ede644 --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 633d41ede644 --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=00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-06-30 01:16:33,598 Setting DEBUG logging. 2016-06-30 01:16:33,598 attempt 1/10 2016-06-30 01:16:33,598 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/633d41ede644?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-06-30 01:16:34,073 unpacking tar archive at: mozilla-inbound-633d41ede644/testing/mozharness/ program finished with exit code 0 elapsedTime=0.902894 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:34.122357) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:34.122676) ========= script_repo_revision: 633d41ede644 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:34.123060) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:34.123321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-06-30 01:16:34.132755) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-30 01:16:34.133105) ========= /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=00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:16:34 INFO - MultiFileLogger online at 20160630 01:16:34 in /builds/slave/test 01:16:34 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 01:16:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:16:34 INFO - {'append_to_log': False, 01:16:34 INFO - 'base_work_dir': '/builds/slave/test', 01:16:34 INFO - 'blob_upload_branch': 'Mozilla-Inbound', 01:16:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:16:34 INFO - 'branch': 'Mozilla-Inbound', 01:16:34 INFO - 'buildbot_json_path': 'buildprops.json', 01:16:34 INFO - 'config_files': ('talos/linux_config.py',), 01:16:34 INFO - 'default_actions': ('clobber', 01:16:34 INFO - 'read-buildbot-config', 01:16:34 INFO - 'download-and-extract', 01:16:34 INFO - 'populate-webroot', 01:16:34 INFO - 'create-virtualenv', 01:16:34 INFO - 'install', 01:16:34 INFO - 'run-tests'), 01:16:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:16:34 INFO - 'download_minidump_stackwalk': True, 01:16:34 INFO - 'download_symbols': 'ondemand', 01:16:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:16:34 INFO - 'tooltool.py': '/tools/tooltool.py', 01:16:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:16:34 INFO - '/tools/misc-python/virtualenv.py')}, 01:16:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:16:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:16:34 INFO - 'installer_path': 'installer.exe', 01:16:34 INFO - 'log_level': 'info', 01:16:34 INFO - 'log_name': 'talos', 01:16:34 INFO - 'log_to_console': True, 01:16:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:16:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:16:34 INFO - 'opt_config_files': (), 01:16:34 INFO - 'pip_index': False, 01:16:34 INFO - 'sps_profile': False, 01:16:34 INFO - 'sps_profile_interval': 0, 01:16:34 INFO - 'suite': 'dromaeojs', 01:16:34 INFO - 'system_bits': '32', 01:16:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:16:34 INFO - 'title': 'talos-linux64-ix-016', 01:16:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:16:34 INFO - 'use_talos_json': True, 01:16:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:16:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:16:34 INFO - 'work_dir': 'build'} 01:16:34 INFO - ##### 01:16:34 INFO - ##### Running clobber step. 01:16:34 INFO - ##### 01:16:34 INFO - Running pre-action listener: _resource_record_pre_action 01:16:34 INFO - Running main action method: clobber 01:16:34 INFO - rmtree: /builds/slave/test/build 01:16:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:16:35 INFO - Running post-action listener: _resource_record_post_action 01:16:35 INFO - ##### 01:16:35 INFO - ##### Finished clobber step (success) 01:16:35 INFO - ##### 01:16:35 INFO - ##### 01:16:35 INFO - ##### Running read-buildbot-config step. 01:16:35 INFO - ##### 01:16:35 INFO - Running pre-action listener: _resource_record_pre_action 01:16:35 INFO - Running main action method: read_buildbot_config 01:16:35 INFO - Using buildbot properties: 01:16:35 INFO - { 01:16:35 INFO - "project": "", 01:16:35 INFO - "product": "firefox", 01:16:35 INFO - "script_repo_revision": "production", 01:16:35 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 01:16:35 INFO - "repository": "", 01:16:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound pgo talos dromaeojs", 01:16:35 INFO - "buildid": "20160629223106", 01:16:35 INFO - "pgo_build": "True", 01:16:35 INFO - "basedir": "/builds/slave/test", 01:16:35 INFO - "buildnumber": 2002, 01:16:35 INFO - "slavename": "talos-linux64-ix-016", 01:16:35 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:16:35 INFO - "platform": "ubuntu64_hw", 01:16:35 INFO - "scheduler": "tests-mozilla-inbound-linux64-pgo-talos", 01:16:35 INFO - "branch": "mozilla-inbound", 01:16:35 INFO - "repo_path": "integration/mozilla-inbound", 01:16:35 INFO - "revision": "633d41ede644", 01:16:35 INFO - "stage_platform": "linux64-pgo", 01:16:35 INFO - "builduid": "665543db0a784c78832b5b8cef3764b2", 01:16:35 INFO - "slavebuilddir": "test" 01:16:35 INFO - } 01:16:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:16:35 INFO - Running post-action listener: _resource_record_post_action 01:16:35 INFO - ##### 01:16:35 INFO - ##### Finished read-buildbot-config step (success) 01:16:35 INFO - ##### 01:16:35 INFO - ##### 01:16:35 INFO - ##### Running download-and-extract step. 01:16:35 INFO - ##### 01:16:35 INFO - Running pre-action listener: _resource_record_pre_action 01:16:35 INFO - Running main action method: download_and_extract 01:16:35 INFO - mkdir: /builds/slave/test/build/tests 01:16:35 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')]} 01:16:35 INFO - https://queue.taskcluster.net/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:16:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:16:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:16:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/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 01:16:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/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 01:16:36 INFO - Downloaded 1361 bytes. 01:16:36 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:16:36 INFO - Using the following test package requirements: 01:16:36 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:16:36 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:16:36 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:16:36 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:36 INFO - u'jsshell-linux-x86_64.zip'], 01:16:36 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:16:36 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:16:36 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:16:36 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:16:36 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:16:36 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:16:36 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:16:36 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:36 INFO - https://queue.taskcluster.net/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:16:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:16:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:16:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/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 01:16:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/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 01:16:39 INFO - Downloaded 24267647 bytes. 01:16:39 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'] 01:16:39 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 01:16:41 INFO - Return code: 0 01:16:41 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:16:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:41 INFO - https://queue.taskcluster.net/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:16:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:16:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:16:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/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 01:16:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/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 01:16:47 INFO - Downloaded 24267647 bytes. 01:16:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:16:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:16:48 INFO - Return code: 0 01:16:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:48 INFO - https://queue.taskcluster.net/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:16:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:16:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:16:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/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 01:16:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/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 01:16:51 INFO - Downloaded 14405242 bytes. 01:16:51 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'] 01:16:51 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 01:16:51 INFO - Return code: 0 01:16:51 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')]} 01:16:51 INFO - https://queue.taskcluster.net/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:16:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:16:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:16:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/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 01:16:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/HdL1wBIWSr6L20EcOLjY2Q/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 01:16:53 INFO - Downloaded 60332955 bytes. 01:16:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:16:53 INFO - mkdir: /builds/slave/test/properties 01:16:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:16:53 INFO - Writing to file /builds/slave/test/properties/build_url 01:16:53 INFO - Contents: 01:16:53 INFO - build_url:https://queue.taskcluster.net/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:16:53 INFO - Running post-action listener: _resource_record_post_action 01:16:53 INFO - Running post-action listener: set_extra_try_arguments 01:16:53 INFO - ##### 01:16:53 INFO - ##### Finished download-and-extract step (success) 01:16:53 INFO - ##### 01:16:53 INFO - ##### 01:16:53 INFO - ##### Running populate-webroot step. 01:16:53 INFO - ##### 01:16:53 INFO - Running pre-action listener: _resource_record_pre_action 01:16:53 INFO - Running main action method: populate_webroot 01:16:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:16:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:16:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:16:53 INFO - '--tppagecycles', 01:16:53 INFO - '7'], 01:16:53 INFO - 'tests': ['tsvgm']}}, 01:16:53 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:16:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:16:53 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:16:53 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:16:53 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:16:53 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:16:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:53 INFO - 'talos_options': ['--disable-e10s'], 01:16:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:16:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:16:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:53 INFO - 'talos_options': ['--disable-e10s'], 01:16:53 INFO - 'tests': ['damp', 'tps']}, 01:16:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:53 INFO - 'tests': ['damp', 'tps']}, 01:16:53 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:16:53 INFO - 'tests': ['dromaeo_dom']}, 01:16:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:16:53 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:16:53 INFO - 'tests': ['basic_compositor_video']}, 01:16:53 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:16:53 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:16:53 INFO - 'tests': ['a11yr', 01:16:53 INFO - 'ts_paint', 01:16:53 INFO - 'tpaint', 01:16:53 INFO - 'sessionrestore', 01:16:53 INFO - 'sessionrestore_no_auto_restore', 01:16:53 INFO - 'tabpaint']}, 01:16:53 INFO - 'other-e10s': {'tests': ['a11yr', 01:16:53 INFO - 'ts_paint', 01:16:53 INFO - 'tpaint', 01:16:53 INFO - 'sessionrestore', 01:16:53 INFO - 'sessionrestore_no_auto_restore', 01:16:53 INFO - 'tabpaint']}, 01:16:53 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:16:53 INFO - 'ts_paint', 01:16:53 INFO - 'tpaint', 01:16:53 INFO - 'sessionrestore', 01:16:53 INFO - 'sessionrestore_no_auto_restore', 01:16:53 INFO - 'tabpaint']}, 01:16:53 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:16:53 INFO - 'ts_paint', 01:16:53 INFO - 'tpaint', 01:16:53 INFO - 'sessionrestore', 01:16:53 INFO - 'sessionrestore_no_auto_restore', 01:16:53 INFO - 'tabpaint']}, 01:16:53 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:16:53 INFO - 'tests': ['a11yr', 01:16:53 INFO - 'ts_paint', 01:16:53 INFO - 'tpaint', 01:16:53 INFO - 'sessionrestore', 01:16:53 INFO - 'sessionrestore_no_auto_restore', 01:16:53 INFO - 'tabpaint']}, 01:16:53 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:16:53 INFO - 'tests': ['a11yr', 01:16:53 INFO - 'ts_paint', 01:16:53 INFO - 'tpaint', 01:16:53 INFO - 'sessionrestore', 01:16:53 INFO - 'sessionrestore_no_auto_restore', 01:16:53 INFO - 'tabpaint']}, 01:16:53 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:16:53 INFO - 'tests': ['tsvgx', 01:16:53 INFO - 'tsvgr_opacity', 01:16:53 INFO - 'tart', 01:16:53 INFO - 'tscrollx', 01:16:53 INFO - 'cart']}, 01:16:53 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:16:53 INFO - 'tsvgr_opacity', 01:16:53 INFO - 'tart', 01:16:53 INFO - 'tscrollx', 01:16:53 INFO - 'cart']}, 01:16:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:53 INFO - 'talos_options': ['--disable-e10s'], 01:16:53 INFO - 'tests': ['tp5o']}, 01:16:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:53 INFO - 'tests': ['tp5o']}, 01:16:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:53 INFO - 'talos_options': ['--disable-e10s', 01:16:53 INFO - '--xperf_path', 01:16:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:16:53 INFO - 'tests': ['tp5n']}, 01:16:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:16:53 INFO - 'talos_options': ['--xperf_path', 01:16:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:16:53 INFO - 'tests': ['tp5n']}}, 01:16:53 INFO - 'talos.zip': {'path': '', 01:16:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:16:53 INFO - Running post-action listener: _resource_record_post_action 01:16:53 INFO - ##### 01:16:53 INFO - ##### Finished populate-webroot step (success) 01:16:53 INFO - ##### 01:16:53 INFO - ##### 01:16:53 INFO - ##### Running create-virtualenv step. 01:16:53 INFO - ##### 01:16:53 INFO - Running pre-action listener: _resource_record_pre_action 01:16:53 INFO - Running main action method: create_virtualenv 01:16:53 INFO - Creating virtualenv /builds/slave/test/build/venv 01:16:53 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 01:16:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:16:54 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:16:54 INFO - Using real prefix '/usr' 01:16:54 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:16:54 INFO - Installing distribute.............................................................................................................................................................................................done. 01:16:56 INFO - Installing pip.................done. 01:16:56 INFO - Return code: 0 01:16:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x273f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe3b0>, '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 0x29ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ff740>, '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': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', '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 01:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:16:56 INFO - Using env: {'DISPLAY': ':0', 01:16:56 INFO - 'HOME': '/home/cltbld', 01:16:56 INFO - 'LANG': 'en_US.UTF-8', 01:16:56 INFO - 'LANGUAGE': 'en_US:en', 01:16:56 INFO - 'LOGNAME': 'cltbld', 01:16:56 INFO - 'MAIL': '/var/mail/cltbld', 01:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:56 INFO - 'MOZ_NO_REMOTE': '1', 01:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:56 INFO - 'NO_EM_RESTART': '1', 01:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:56 INFO - 'PWD': '/builds/slave/test', 01:16:56 INFO - 'SHELL': '/bin/bash', 01:16:56 INFO - 'SHLVL': '1', 01:16:56 INFO - 'TERM': 'linux', 01:16:56 INFO - 'TMOUT': '86400', 01:16:56 INFO - 'USER': 'cltbld', 01:16:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', 01:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:56 INFO - '_': '/tools/buildbot/bin/python'} 01:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:56 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 01:16:56 INFO - Cleaning up... 01:16:56 INFO - Return code: 0 01:16:56 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x273f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe3b0>, '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 0x29ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ff740>, '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': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', '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 01:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:16:56 INFO - Using env: {'DISPLAY': ':0', 01:16:56 INFO - 'HOME': '/home/cltbld', 01:16:56 INFO - 'LANG': 'en_US.UTF-8', 01:16:56 INFO - 'LANGUAGE': 'en_US:en', 01:16:56 INFO - 'LOGNAME': 'cltbld', 01:16:56 INFO - 'MAIL': '/var/mail/cltbld', 01:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:56 INFO - 'MOZ_NO_REMOTE': '1', 01:16:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:56 INFO - 'NO_EM_RESTART': '1', 01:16:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:56 INFO - 'PWD': '/builds/slave/test', 01:16:56 INFO - 'SHELL': '/bin/bash', 01:16:56 INFO - 'SHLVL': '1', 01:16:56 INFO - 'TERM': 'linux', 01:16:56 INFO - 'TMOUT': '86400', 01:16:56 INFO - 'USER': 'cltbld', 01:16:56 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', 01:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:56 INFO - '_': '/tools/buildbot/bin/python'} 01:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:56 INFO - Downloading/unpacking psutil>=3.1.1 01:16:56 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 01:16:56 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 01:16:56 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 01:16:56 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 01:16:56 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 01:16:56 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 01:16:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:16:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:16:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:16:58 INFO - Installing collected packages: psutil 01:16:58 INFO - Running setup.py install for psutil 01:16:59 INFO - building 'psutil._psutil_linux' extension 01:16:59 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 01:16:59 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 01:16:59 INFO - building 'psutil._psutil_posix' extension 01:16:59 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 01:16:59 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 01:16:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:16:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:16:59 INFO - Successfully installed psutil 01:16:59 INFO - Cleaning up... 01:16:59 INFO - Return code: 0 01:16:59 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:16:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:16:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:16:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:16:59 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 0x273f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe3b0>, '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 0x29ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ff740>, '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': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', '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 01:16:59 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 01:16:59 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 01:16:59 INFO - Using env: {'DISPLAY': ':0', 01:16:59 INFO - 'HOME': '/home/cltbld', 01:16:59 INFO - 'LANG': 'en_US.UTF-8', 01:16:59 INFO - 'LANGUAGE': 'en_US:en', 01:16:59 INFO - 'LOGNAME': 'cltbld', 01:16:59 INFO - 'MAIL': '/var/mail/cltbld', 01:16:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:16:59 INFO - 'MOZ_NO_REMOTE': '1', 01:16:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:16:59 INFO - 'NO_EM_RESTART': '1', 01:16:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:16:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:16:59 INFO - 'PWD': '/builds/slave/test', 01:16:59 INFO - 'SHELL': '/bin/bash', 01:16:59 INFO - 'SHLVL': '1', 01:16:59 INFO - 'TERM': 'linux', 01:16:59 INFO - 'TMOUT': '86400', 01:16:59 INFO - 'USER': 'cltbld', 01:16:59 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', 01:16:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:16:59 INFO - '_': '/tools/buildbot/bin/python'} 01:16:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:16:59 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:16:59 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 01:16:59 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 01:16:59 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 01:16:59 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 01:16:59 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 01:16:59 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 01:17:01 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:17:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:17:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:17:01 INFO - Installing collected packages: mozsystemmonitor 01:17:01 INFO - Running setup.py install for mozsystemmonitor 01:17:01 INFO - Successfully installed mozsystemmonitor 01:17:01 INFO - Cleaning up... 01:17:01 INFO - Return code: 0 01:17:01 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x273f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe3b0>, '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 0x29ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ff740>, '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': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', '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 01:17:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:17:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:17:01 INFO - Using env: {'DISPLAY': ':0', 01:17:01 INFO - 'HOME': '/home/cltbld', 01:17:01 INFO - 'LANG': 'en_US.UTF-8', 01:17:01 INFO - 'LANGUAGE': 'en_US:en', 01:17:01 INFO - 'LOGNAME': 'cltbld', 01:17:01 INFO - 'MAIL': '/var/mail/cltbld', 01:17:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:01 INFO - 'MOZ_NO_REMOTE': '1', 01:17:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:01 INFO - 'NO_EM_RESTART': '1', 01:17:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:01 INFO - 'PWD': '/builds/slave/test', 01:17:01 INFO - 'SHELL': '/bin/bash', 01:17:01 INFO - 'SHLVL': '1', 01:17:01 INFO - 'TERM': 'linux', 01:17:01 INFO - 'TMOUT': '86400', 01:17:01 INFO - 'USER': 'cltbld', 01:17:01 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', 01:17:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:01 INFO - '_': '/tools/buildbot/bin/python'} 01:17:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:02 INFO - Downloading/unpacking jsonschema==2.5.1 01:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:03 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:17:03 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:04 INFO - Downloading functools32-3.2.3-2.tar.gz 01:17:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:17:04 INFO - warning: no files found matching '*.txt' 01:17:04 INFO - no previously-included directories found matching 'build' 01:17:04 INFO - no previously-included directories found matching 'dist' 01:17:04 INFO - no previously-included directories found matching '.git*' 01:17:04 INFO - Installing collected packages: jsonschema, functools32 01:17:04 INFO - Running setup.py install for functools32 01:17:04 INFO - warning: no files found matching '*.txt' 01:17:04 INFO - no previously-included directories found matching 'build' 01:17:04 INFO - no previously-included directories found matching 'dist' 01:17:04 INFO - no previously-included directories found matching '.git*' 01:17:04 INFO - Successfully installed jsonschema functools32 01:17:04 INFO - Cleaning up... 01:17:04 INFO - Return code: 0 01:17:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x273f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe3b0>, '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 0x29ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ff740>, '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': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', '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 01:17:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:17:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:17:04 INFO - Using env: {'DISPLAY': ':0', 01:17:04 INFO - 'HOME': '/home/cltbld', 01:17:04 INFO - 'LANG': 'en_US.UTF-8', 01:17:04 INFO - 'LANGUAGE': 'en_US:en', 01:17:04 INFO - 'LOGNAME': 'cltbld', 01:17:04 INFO - 'MAIL': '/var/mail/cltbld', 01:17:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:04 INFO - 'MOZ_NO_REMOTE': '1', 01:17:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:04 INFO - 'NO_EM_RESTART': '1', 01:17:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:04 INFO - 'PWD': '/builds/slave/test', 01:17:04 INFO - 'SHELL': '/bin/bash', 01:17:04 INFO - 'SHLVL': '1', 01:17:04 INFO - 'TERM': 'linux', 01:17:04 INFO - 'TMOUT': '86400', 01:17:04 INFO - 'USER': 'cltbld', 01:17:04 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', 01:17:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:04 INFO - '_': '/tools/buildbot/bin/python'} 01:17:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:04 INFO - Downloading/unpacking blobuploader==1.2.4 01:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:06 INFO - Downloading blobuploader-1.2.4.tar.gz 01:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:17:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:17:06 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 01:17:06 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 01:17:06 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 01:17:06 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 01:17:06 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 01:17:06 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 01:17:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:17:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:17:07 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 01:17:07 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 01:17:07 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 01:17:07 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 01:17:07 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 01:17:07 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 01:17:07 INFO - Downloading docopt-0.6.1.tar.gz 01:17:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:17:07 INFO - Installing collected packages: blobuploader, requests, docopt 01:17:07 INFO - Running setup.py install for blobuploader 01:17:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:17:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:17:07 INFO - Running setup.py install for requests 01:17:07 INFO - Running setup.py install for docopt 01:17:07 INFO - Successfully installed blobuploader requests docopt 01:17:07 INFO - Cleaning up... 01:17:08 INFO - Return code: 0 01:17:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:08 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 0x273f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe3b0>, '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 0x29ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ff740>, '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': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', '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 01:17:08 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 01:17:08 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 01:17:08 INFO - Using env: {'DISPLAY': ':0', 01:17:08 INFO - 'HOME': '/home/cltbld', 01:17:08 INFO - 'LANG': 'en_US.UTF-8', 01:17:08 INFO - 'LANGUAGE': 'en_US:en', 01:17:08 INFO - 'LOGNAME': 'cltbld', 01:17:08 INFO - 'MAIL': '/var/mail/cltbld', 01:17:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:08 INFO - 'MOZ_NO_REMOTE': '1', 01:17:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:08 INFO - 'NO_EM_RESTART': '1', 01:17:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:08 INFO - 'PWD': '/builds/slave/test', 01:17:08 INFO - 'SHELL': '/bin/bash', 01:17:08 INFO - 'SHLVL': '1', 01:17:08 INFO - 'TERM': 'linux', 01:17:08 INFO - 'TMOUT': '86400', 01:17:08 INFO - 'USER': 'cltbld', 01:17:08 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', 01:17:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:08 INFO - '_': '/tools/buildbot/bin/python'} 01:17:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:17:08 INFO - Running setup.py (path:/tmp/pip-qMUxHl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:17:08 INFO - Running setup.py (path:/tmp/pip-1PKeNj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:17:08 INFO - Running setup.py (path:/tmp/pip-IofC8v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:17:08 INFO - Running setup.py (path:/tmp/pip-m2qw8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:17:08 INFO - Running setup.py (path:/tmp/pip-STwdFV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:17:08 INFO - Running setup.py (path:/tmp/pip-cY2uws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:17:08 INFO - Running setup.py (path:/tmp/pip-95Z3j9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:17:08 INFO - Running setup.py (path:/tmp/pip-m1h4e0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:17:08 INFO - Running setup.py (path:/tmp/pip-j3utVd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:17:08 INFO - Running setup.py (path:/tmp/pip-CryoiO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:17:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:17:08 INFO - Running setup.py (path:/tmp/pip-w7aRAW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:17:09 INFO - Running setup.py (path:/tmp/pip-x9tGaB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:17:09 INFO - Running setup.py (path:/tmp/pip-b4iKZW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:17:09 INFO - Running setup.py (path:/tmp/pip-vygUPI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:09 INFO - Running setup.py (path:/tmp/pip-03azFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:17:09 INFO - Running setup.py (path:/tmp/pip-Te9tCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:17:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:17:09 INFO - Running setup.py (path:/tmp/pip-d_ln94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:17:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:17:09 INFO - Running setup.py install for manifestparser 01:17:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:17:09 INFO - Running setup.py install for mozcrash 01:17:09 INFO - Running setup.py install for mozdebug 01:17:09 INFO - Running setup.py install for mozdevice 01:17:09 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:17:09 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:17:09 INFO - Running setup.py install for mozfile 01:17:09 INFO - Running setup.py install for mozhttpd 01:17:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Running setup.py install for mozinfo 01:17:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Running setup.py install for mozInstall 01:17:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Running setup.py install for mozleak 01:17:10 INFO - Running setup.py install for mozlog 01:17:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Running setup.py install for moznetwork 01:17:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Running setup.py install for mozprocess 01:17:10 INFO - Running setup.py install for mozprofile 01:17:10 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Running setup.py install for mozrunner 01:17:10 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:17:10 INFO - Running setup.py install for mozscreenshot 01:17:11 INFO - Running setup.py install for moztest 01:17:11 INFO - Running setup.py install for mozversion 01:17:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:17:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:17:11 INFO - Cleaning up... 01:17:11 INFO - Return code: 0 01:17:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17: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')]} 01:17:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17: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')]} 01:17:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:11 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 0x273f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe3b0>, '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 0x29ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ff740>, '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': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', '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 01:17:11 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 01:17:11 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 01:17:11 INFO - Using env: {'DISPLAY': ':0', 01:17:11 INFO - 'HOME': '/home/cltbld', 01:17:11 INFO - 'LANG': 'en_US.UTF-8', 01:17:11 INFO - 'LANGUAGE': 'en_US:en', 01:17:11 INFO - 'LOGNAME': 'cltbld', 01:17:11 INFO - 'MAIL': '/var/mail/cltbld', 01:17:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:11 INFO - 'MOZ_NO_REMOTE': '1', 01:17:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:11 INFO - 'NO_EM_RESTART': '1', 01:17:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:11 INFO - 'PWD': '/builds/slave/test', 01:17:11 INFO - 'SHELL': '/bin/bash', 01:17:11 INFO - 'SHLVL': '1', 01:17:11 INFO - 'TERM': 'linux', 01:17:11 INFO - 'TMOUT': '86400', 01:17:11 INFO - 'USER': 'cltbld', 01:17:11 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', 01:17:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:11 INFO - '_': '/tools/buildbot/bin/python'} 01:17:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:17:11 INFO - Running setup.py (path:/tmp/pip-LsvKMa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:17:11 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)) 01:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:17:11 INFO - Running setup.py (path:/tmp/pip-ukbV_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:17:11 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)) 01:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:17:11 INFO - Running setup.py (path:/tmp/pip-_v95gR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:17:11 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)) 01:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:17:11 INFO - Running setup.py (path:/tmp/pip-ObKFEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:17:11 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)) 01:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:17:11 INFO - Running setup.py (path:/tmp/pip-fL1fQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:17:11 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)) 01:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:17:11 INFO - Running setup.py (path:/tmp/pip-_iq7ux-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:17:11 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)) 01:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:17:11 INFO - Running setup.py (path:/tmp/pip-gjA02p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:17:11 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)) 01:17:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:17:12 INFO - Running setup.py (path:/tmp/pip-_nfXhQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:17:12 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)) 01:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:17:12 INFO - Running setup.py (path:/tmp/pip-d5_edn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:17:12 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)) 01:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:17:12 INFO - Running setup.py (path:/tmp/pip-itJ6Io-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:17:12 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)) 01:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:17:12 INFO - Running setup.py (path:/tmp/pip-9aBMYx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:17:12 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)) 01:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:17:12 INFO - Running setup.py (path:/tmp/pip-_Jy0oe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 01:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:17:12 INFO - Running setup.py (path:/tmp/pip-AmTBcr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:17:12 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)) 01:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:17:12 INFO - Running setup.py (path:/tmp/pip-nOusg4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:17:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 01:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:12 INFO - Running setup.py (path:/tmp/pip-zTHyAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:12 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)) 01:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:17:12 INFO - Running setup.py (path:/tmp/pip-tXAmEg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:17:12 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)) 01:17:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:17:12 INFO - Running setup.py (path:/tmp/pip-pZPleU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:17:12 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)) 01:17:12 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)) 01:17:12 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)) 01:17:12 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)) 01:17:12 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)) 01:17:12 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)) 01:17:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:17:12 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 01:17:12 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 01:17:12 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 01:17:12 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 01:17:12 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 01:17:12 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 01:17:14 INFO - Downloading blessings-1.6.tar.gz 01:17:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:17:14 INFO - Installing collected packages: blessings 01:17:14 INFO - Running setup.py install for blessings 01:17:14 INFO - Successfully installed blessings 01:17:14 INFO - Cleaning up... 01:17:14 INFO - Return code: 0 01:17:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:17:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:17:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:17:15 INFO - Reading from file tmpfile_stdout 01:17:15 INFO - Current package versions: 01:17:15 INFO - argparse == 1.2.1 01:17:15 INFO - blessings == 1.6 01:17:15 INFO - blobuploader == 1.2.4 01:17:15 INFO - docopt == 0.6.1 01:17:15 INFO - functools32 == 3.2.3-2 01:17:15 INFO - jsonschema == 2.5.1 01:17:15 INFO - manifestparser == 1.1 01:17:15 INFO - mozInstall == 1.12 01:17:15 INFO - mozcrash == 0.17 01:17:15 INFO - mozdebug == 0.1 01:17:15 INFO - mozdevice == 0.48 01:17:15 INFO - mozfile == 1.2 01:17:15 INFO - mozhttpd == 0.7 01:17:15 INFO - mozinfo == 0.9 01:17:15 INFO - mozleak == 0.1 01:17:15 INFO - mozlog == 3.2 01:17:15 INFO - moznetwork == 0.27 01:17:15 INFO - mozprocess == 0.22 01:17:15 INFO - mozprofile == 0.28 01:17:15 INFO - mozrunner == 6.11 01:17:15 INFO - mozscreenshot == 0.1 01:17:15 INFO - mozsystemmonitor == 0.3 01:17:15 INFO - moztest == 0.7 01:17:15 INFO - mozversion == 1.4 01:17:15 INFO - psutil == 3.1.1 01:17:15 INFO - requests == 1.2.3 01:17:15 INFO - wsgiref == 0.1.2 01:17:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17:15 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')]} 01:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:15 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')]} 01:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:15 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 0x273f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe3b0>, '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 0x29ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ff740>, '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': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', '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 01:17:15 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 01:17:15 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 01:17:15 INFO - Using env: {'DISPLAY': ':0', 01:17:15 INFO - 'HOME': '/home/cltbld', 01:17:15 INFO - 'LANG': 'en_US.UTF-8', 01:17:15 INFO - 'LANGUAGE': 'en_US:en', 01:17:15 INFO - 'LOGNAME': 'cltbld', 01:17:15 INFO - 'MAIL': '/var/mail/cltbld', 01:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:15 INFO - 'MOZ_NO_REMOTE': '1', 01:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:15 INFO - 'NO_EM_RESTART': '1', 01:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:15 INFO - 'PWD': '/builds/slave/test', 01:17:15 INFO - 'SHELL': '/bin/bash', 01:17:15 INFO - 'SHLVL': '1', 01:17:15 INFO - 'TERM': 'linux', 01:17:15 INFO - 'TMOUT': '86400', 01:17:15 INFO - 'USER': 'cltbld', 01:17:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', 01:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:15 INFO - '_': '/tools/buildbot/bin/python'} 01:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:15 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)) 01:17:15 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)) 01:17:15 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)) 01:17:15 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)) 01:17:15 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)) 01:17:15 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)) 01:17:15 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)) 01:17:15 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)) 01:17:15 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)) 01:17:15 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)) 01:17:15 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)) 01:17:15 INFO - Cleaning up... 01:17:15 INFO - Return code: 0 01:17:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:17:15 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')]} 01:17:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:15 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')]} 01:17:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:15 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 0x273f030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28a28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2a00180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x29fe3b0>, '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 0x29ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ff740>, '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': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', '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 01:17:15 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 01:17:15 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 01:17:15 INFO - Using env: {'DISPLAY': ':0', 01:17:15 INFO - 'HOME': '/home/cltbld', 01:17:15 INFO - 'LANG': 'en_US.UTF-8', 01:17:15 INFO - 'LANGUAGE': 'en_US:en', 01:17:15 INFO - 'LOGNAME': 'cltbld', 01:17:15 INFO - 'MAIL': '/var/mail/cltbld', 01:17:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:15 INFO - 'MOZ_NO_REMOTE': '1', 01:17:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:15 INFO - 'NO_EM_RESTART': '1', 01:17:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:15 INFO - 'PWD': '/builds/slave/test', 01:17:15 INFO - 'SHELL': '/bin/bash', 01:17:15 INFO - 'SHLVL': '1', 01:17:15 INFO - 'TERM': 'linux', 01:17:15 INFO - 'TMOUT': '86400', 01:17:15 INFO - 'USER': 'cltbld', 01:17:15 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', 01:17:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:15 INFO - '_': '/tools/buildbot/bin/python'} 01:17:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:15 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:17:15 INFO - Cleaning up... 01:17:15 INFO - Return code: 0 01:17:15 INFO - Running post-action listener: _resource_record_post_action 01:17:15 INFO - Running post-action listener: _start_resource_monitoring 01:17:15 INFO - Starting resource monitoring. 01:17:15 INFO - ##### 01:17:15 INFO - ##### Finished create-virtualenv step (success) 01:17:15 INFO - ##### 01:17:15 INFO - ##### 01:17:15 INFO - ##### Running install step. 01:17:15 INFO - ##### 01:17:15 INFO - Running pre-action listener: _resource_record_pre_action 01:17:15 INFO - Running main action method: install 01:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:17:15 INFO - Reading from file tmpfile_stdout 01:17:15 INFO - Detecting whether we're running mozinstall >=1.0... 01:17:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:17:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:17:15 INFO - Reading from file tmpfile_stdout 01:17:15 INFO - Output received: 01:17:15 INFO - Usage: mozinstall [options] installer 01:17:15 INFO - Options: 01:17:15 INFO - -h, --help show this help message and exit 01:17:15 INFO - -d DEST, --destination=DEST 01:17:15 INFO - Directory to install application into. [default: 01:17:15 INFO - "/builds/slave/test"] 01:17:15 INFO - --app=APP Application being installed. [default: firefox] 01:17:15 INFO - mkdir: /builds/slave/test/build/application 01:17:15 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'] 01:17:15 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 01:17:32 INFO - Reading from file tmpfile_stdout 01:17:32 INFO - Output received: 01:17:32 INFO - /builds/slave/test/build/application/firefox/firefox 01:17:32 INFO - Running post-action listener: _resource_record_post_action 01:17:32 INFO - ##### 01:17:32 INFO - ##### Finished install step (success) 01:17:32 INFO - ##### 01:17:32 INFO - ##### 01:17:32 INFO - ##### Running run-tests step. 01:17:32 INFO - ##### 01:17:32 INFO - Running pre-action listener: _resource_record_pre_action 01:17:32 INFO - Running main action method: run_tests 01:17:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:17:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:17:32 INFO - Python 2.7.3 01:17:32 INFO - Return code: 0 01:17:32 INFO - grabbing minidump binary from tooltool 01:17:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:32 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 0x29fe3b0>, '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 0x29ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29ff740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:17:32 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 01:17:32 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 01:17:32 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 01:17:33 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:17:33 INFO - Return code: 0 01:17:33 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:17:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:17:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:17:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:17:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:17:33 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/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 01:17:33 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/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-016 --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 01:17:33 INFO - Using env: {'DISPLAY': ':0', 01:17:33 INFO - 'HOME': '/home/cltbld', 01:17:33 INFO - 'LANG': 'en_US.UTF-8', 01:17:33 INFO - 'LANGUAGE': 'en_US:en', 01:17:33 INFO - 'LOGNAME': 'cltbld', 01:17:33 INFO - 'MAIL': '/var/mail/cltbld', 01:17:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:17:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:33 INFO - 'MOZ_NO_REMOTE': '1', 01:17:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:17:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:33 INFO - 'NO_EM_RESTART': '1', 01:17:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:33 INFO - 'PWD': '/builds/slave/test', 01:17:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:17:33 INFO - 'SHELL': '/bin/bash', 01:17:33 INFO - 'SHLVL': '1', 01:17:33 INFO - 'TERM': 'linux', 01:17:33 INFO - 'TMOUT': '86400', 01:17:33 INFO - 'USER': 'cltbld', 01:17:33 INFO - 'XDG_SESSION_COOKIE': '00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282', 01:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:33 INFO - '_': '/tools/buildbot/bin/python'} 01:17:33 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/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-016', '--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 01:17:33 INFO - mozversion application_buildid: 20160629223106 01:17:33 INFO - mozversion application_changeset: 633d41ede644bf0fed6ca98328168d9c8f44c1de 01:17:33 INFO - mozversion application_display_name: Nightly 01:17:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:17:33 INFO - mozversion application_name: Firefox 01:17:33 INFO - mozversion application_remotingname: firefox 01:17:33 INFO - mozversion application_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:17:33 INFO - mozversion application_vendor: Mozilla 01:17:33 INFO - mozversion application_version: 50.0a1 01:17:33 INFO - mozversion platform_buildid: 20160629223106 01:17:33 INFO - mozversion platform_changeset: 633d41ede644bf0fed6ca98328168d9c8f44c1de 01:17:33 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 01:17:33 INFO - mozversion platform_version: 50.0a1 01:17:33 INFO - using testdate: 1467274653 01:17:33 INFO - actual date: 1467274653 01:17:33 INFO - starting webserver on 'localhost:51906' 01:17:33 INFO - SUITE-START | Running 2 tests 01:17:33 INFO - TEST-START | dromaeo_css 01:17:33 INFO - operating with platform_type : linux_ 01:17:33 INFO - Initialising browser for dromaeo_css test... 01:17:33 INFO - TEST-INFO | started process 6769 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAPYtLi/profile http://localhost:51906/getInfo.html) 01:17:37 INFO - PROCESS | 6769 | __metrics Screen width/height:1600/1200 01:17:37 INFO - PROCESS | 6769 | colorDepth:24 01:17:37 INFO - PROCESS | 6769 | Browser inner width/height: 1024/697 01:17:37 INFO - PROCESS | 6769 | __metrics 01:17:38 INFO - PROCESS | 6769 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:17:39 INFO - TEST-INFO | 6769: exit 0 01:17:39 INFO - Browser initialized. 01:17:39 INFO - Running cycle 1/1 for dromaeo_css test... 01:17:39 INFO - TEST-INFO | started process 6854 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAPYtLi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:17:50 INFO - PROCESS | 6854 | RSS: Main: 157151232 01:17:50 INFO - PROCESS | 6854 | 01:18:42 INFO - PROCESS | 6854 | 1467274722675 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] 01:20:50 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:51906/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51906/tests/dromaeo/cssquery-ext.html) 01:20:51 INFO - PROCESS | 6854 | RSS: Main: 287051776 01:20:51 INFO - PROCESS | 6854 | 01:23:54 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:51906/tests/dromaeo/cssquery-ext.html (next: http://localhost:51906/tests/dromaeo/cssquery-jquery.html) 01:23:54 INFO - PROCESS | 6854 | RSS: Main: 238436352 01:23:54 INFO - PROCESS | 6854 | 01:26:56 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:51906/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51906/tests/dromaeo/cssquery-mootools.html) 01:26:57 INFO - PROCESS | 6854 | RSS: Main: 237715456 01:26:57 INFO - PROCESS | 6854 | 01:29:59 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:51906/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51906/tests/dromaeo/cssquery-prototype.html) 01:30:00 INFO - PROCESS | 6854 | RSS: Main: 233922560 01:30:00 INFO - PROCESS | 6854 | 01:33:02 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:51906/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51906/tests/dromaeo/cssquery-yui.html) 01:33:03 INFO - PROCESS | 6854 | RSS: Main: 228909056 01:33:03 INFO - PROCESS | 6854 | 01:36:05 INFO - PROCESS | 6854 | Cycle 1(1): loaded http://localhost:51906/tests/dromaeo/cssquery-yui.html (next: http://localhost:51906/tests/dromaeo/cssquery-dojo.html) 01:36:06 INFO - PROCESS | 6854 | RSS: Main: 273727488 01:36:06 INFO - PROCESS | 6854 | 01:36:06 INFO - PROCESS | 6854 | __start_tp_report 01:36:06 INFO - PROCESS | 6854 | _x_x_mozilla_page_load 01:36:06 INFO - PROCESS | 6854 | _x_x_mozilla_page_load_details 01:36:06 INFO - PROCESS | 6854 | |i|pagename|runs| 01:36:06 INFO - PROCESS | 6854 | |0;dojo.html;3115.5326700994847;3118.0801663509264;3137.2313783123136;3162.8892988745397;3210.9197270068244;5322.547583455401;5373.973130134349;5423.945760542393;5451.563874890009;5514.724263786815;5401.810936617219;5431.131019036955;5463.972680136594;5500.28496295481;5542.584306177033;4821.90356192876;4870.050340183666;4905.4358748744;4917.926231106536;5039.370078740158;4993.176125939216;5026.698398096108;5034.84895453137;5042.243663450475;5047.823326183584;4825.90348193036;4847.103285892122;4855.5872750816225;4889.266610008492;4981.452040275567;4803.975980120112;4817.060673168733;4846.491118432585;4890.682105663156;4954.43024052235;4861.1006963711825;4896.167651499253;4899.142650036265;4912.926306105412;4926.679765815246;5198.116320225571;5371.650842695212;5424.376196737387;5444.156155795818;5509.779608815643;5898.498627616657;5953.8809223815715;5956.791512297049;5958.463738263577;5966.254218222723;5938.970305148447;5984.880302393971;6009.338972712998;6010.218671572711;6011.1884895539415;5346.224797404393;5488.423715509894;5535.335759708821;5540.9168862467095;5590.413006634326;6035.698215089228;6054.022810960045;6055.810991023313;6062.444973910784;6096.237970253718;5822.82531524055;5826.533877289807;5869.970650146722;5886.352501224862;5892.410758924159;5723.284589426322;5749.712514374264;5754.424557544212;5767.971160144172;5870.471657550841;5796.565257605696;5799.072148456226;5800.0429929062075;5800.622959507618;5802.245708057925;5671.262735844314;5726.713664316768;5785.595008349459;5789.421057894177;5790.276215473066;4422.137683151755;4448.332750087448;4483.730976141442;4499.010217752089;4512.435945506812;3997.2205419942834;4002.4396584478195;4012.8194231259663;4045.3527435610163;4054.1283624020975;5356.1697936819855;5593.328800543961;5601.29983752031;5604.3835178131185;5605.159226116115;5847.9415205848245;5848.883022339614;5878.911816322759;5945.078512830518;5980;5556.111022236423;5561.221428999943;5564.693941833238;5571.554275658019;5576.1356989666665;5079.263506791494;5084.313617661643;5084.745762711849;5085.313482679865;5133.512316329943;5898.085796701518;6022.518198544106;6040.60736052164;6086.786962456381;6093.939060609426;5841.649501029951;5851.239338886088;5851.707414629337;5858.414158584107;5861.296644402699;5857.824265272048;5958.463738263577;6001.549883758648;6016.759329626766;6023.698815059141;5648.802291919763;5664.716764161693;5672;5686.971565142313;5713.314402271754;5759.596828222152;5791.0734282514595;5792.304923409218;5795.507381872588;5799.246098007232;5491.945080549143;5614.07367784311;5626.521745651502;5627.634203776742;5631.099024156116;5640.125780504029;5682.147677848356;5685.772569097356;5687.971560142173;5725.656460612377;5554.444555544414;5576.052071147996;5578.219049333178;5580.665160090245;5592.189132575672;5615.494605485526;5618.971905140448;5669.206311116364;5707.571932105192;5755.971220143872;5487.451254874641;5510.3938566758425;5515.200295957144;5541.168824676331;5545.112781954868 01:36:06 INFO - PROCESS | 6854 | |1;ext.html;572.8768314812314;622.3962756126556;640.2573015302249;647.6696884588861;653.7744478155041;31392.372152556934;45011.77494112529;45218.32172517411;45988;46040.309395359094;43666.56333436665;47328.763356183255;47343.52656473434;47401.52598474014;47449.52550474494;8089.555074470902;8935.508547029911;9079.682211122612;9080.8637870432;10621.150307975344;10614.469276536181;10722;11055.613053543128;11068.778624427507;11073.612423565177;11133.10935125188;11200.719982000475;11203.327800331965;11209.047230985376;11211.551537938472;11082.6121085762;11125;11161.38612376319;11166.832497512503;11173.944130279297;10926.617568385069;10947.83578246327;10990.890091099147;10996;11004.889951100467;44628.10743785139;44845.3273200899;44948.10103797906;45053.32420013702;45056.54943450589;3680.4479328100997;3749.493818334517;3795.0891785971166;3809.9619003809885;3854.5952674969003;34136;35227;35503.4674479883;35608.64391356105;35669.64330356689;4301.03242707519;4305.354196870463;4324.805383757738;4339.240632889232;4352.804123814404;394441;397463;397715;398233;398686;66717;67077;67154.32845671578;67256;67258.66370668115;69743;69830;70007;70073;70094.64952675204;16695.24871380791;17069.829301707072;17176.570585735455;17197.226124824163;17199.57001074983;12983.935080324538;13018.349082545836;13026.54407095766;13029.218246905217;13036.152650077714;20286.594268114553;21055.473613159487;21059.473513162295;21103.366898993056;21111.155553777982;7227.89158162628;7268.27317268269;7369.189389167187;7514.286142816533;7526.924730752732;958.5693822828242;997.6059456514636;1011.9392836429838;1048.7692707604315;1091.9080919080918;30725;32877.67122328746;33059.187682295415;33121.33757324888;33280;954.8710924025306;1123.9606613768478;1131.4060118437885;1140.749035212252;1207.1610230889623;16845.91577042107;17222.311107555808;17261.223244954006;17355.47933561995;17388.739168912478;701049;705963;709022;711190;712839;60202.69898650479;60829.69585152046;60882.08676869851;60883.69558152181;60895.391046089855;1244.2472304255796;1367.746966811143;1367.883729882971;1383;1410.2102822419479;33557;34438.65561344455;34973.47539786854;35672.324575656414;35761.64238357583;51157.744211280195;51211.487885122166;51799.74100129475;51869;51879.22181167361;472711;473772;474278;478496;479526;26997.59503607487;29653;30202.54696179603;30318.938837140595;31482;48280.51719482901;49891.50108498868;50532;50894.74552627361;51152.23271650854;41333.79333103315;41584.792076039426;41867;42090.36864447097;43333.91665208395;41876;41992.370114447695;42540.57459425366;42591.14817703691;43340.56659433365;42588.36117458303;42817;42820;43108.35337470003;44037.779811100736;36858.26283474369;38745.6125438742;38755.41866872056;39000.609993900835;39017.41473877951;29158.854205728836;29589.5561566581;29623;29626.407471850012;29706.257343566584 01:36:06 INFO - PROCESS | 6854 | |2;jquery.html;405.8660641988144;406.06807377069623;410.9198706252281;412.60183922514784;425.12000159669475;19126.13932373043;20456.590868182626;20583.27958521452;20647.070881810316;21607.351779446602;20500.077496512655;20679.793202067976;20790.272340468087;20814.89592552035;20815.27146549871;5776.82669519914;5947.434993675615;5987.161797348353;5991.101334799771;5992.5505587080925;5706.486416222539;5870.735816888229;5899.852503687399;5974.701264936757;5980.79067232647;5773.30720313563;5848.532117430616;5857.3849745776715;5871.677057761822;5875;5672.404397538261;5842.328132264802;5851.268591426072;5942.405759424067;5945.6135351202465;5292.841214763564;5304.814331498417;5312.043832110218;5321.255024296602;5330.5735541157;24577.508449831083;25326.240212793644;25565.872170639213;25608.74391256082;25615.87192064028;2450.7426720194303;2484.8012159027235;2486.925392238236;2509.146890057389;2597.8181527293095;14491.492797752027;14987.475438359605;15378.615534611612;15484.845151548565;15636;1968.8326492248177;2014.2849288502664;2029.8680585761879;2045.5193029638024;2075.865068770525;56077.74862635367;81549;85177;85892;88167.55916220442;10557.524911379007;10800;11152.044708152345;11258.155638327158;11270.718232044264;13889.305534723224;16052.117133557533;16062.839371606367;16066.839331606769;16085.276162572713;8066.15305392937;8124.268815806606;8374.958125209458;8516.148385161434;8642.654293828176;8270.462419942685;8331.875021874677;8332.583370831435;8433.831323373499;8439.409241353047;6989.545679530916;6996.962813101125;7052.9647351762915;7130.180029296594;7148.428125749928;1911.0027278666464;1914.009430192612;1951.4926119209108;1993.9401817945484;2013.647277283336;922.6493932305681;986.792773517555;991.2417000994245;1073.1843798712878;1090.7000574841982;20729.378118656463;20884.164633414493;21044.368668939955;21116.577668446545;21221.78778212229;1018.7962407518378;1074.8280275155937;1084.7233955341337;1127.932324060559;1168.7896178687918;11663.533458661728;12102.878971210175;12271.570495032809;12305.200161989442;12313.384330783605;453554;453606;459274;460143;465890;69737.65131174312;87201.56399217964;89291.55354223188;90209.54895225482;90519;1025.9692209233735;1036.5801850250662;1053.2995557953875;1057.984130238047;1066.5307264803307;19180.520486987378;19467.8053219466;19939.501512462306;20067.49831254172;20102.59794804125;43836;44425.77787111044;44898;45313.09373812571;45563;54530;55821.88356232934;57588;57973;58107.41892581189;5786.884262314814;5977.581569290108;8010.198980101944;8258.926339575817;8688.26149777276;13927.86072139306;14465;14526.491572794901;14890.627734306729;14890.702185956437;11745.354005529778;12074.45664945062;12306.446209920396;12417.875821242033;12445.564405246136;5910.586258961831;9270.212031977357;10470.842937355794;11007.669769906915;11450.912163344468;12289.631311060682;12545.184563003375;12779.977601791648;12908.677283067998;12965.351732413154;8467.195616416431;8505.064442911398;8613.69852055175;8725.956370218108;8745.650173992968;10922.378629128792;12304.753904921672;12421.503139874303;12455.564055258023;12611.87388126107 01:36:06 INFO - PROCESS | 6854 | |3;mootools.html;1512.53111535424;1523.603862995621;1649.356750867162;1794.838464538193;1822.9726554101683;8753.518556479392;9303.348765586412;9386.108319709634;9409.576569054392;9418.858717119248;7256.9637151814295;8724.825503489943;8931.41945773526;8959.686410975617;9179.678711245107;2474.6164344526537;2505.2838805418255;2506.0727530813533;2512.6733524641772;2514.710808257046;2123.0764617391405;2461.384653836541;2548.3374322676145;2549.0568489658854;2549.3244290263096;2405.747396523366;2442.1330427698176;2458.483718419134;2466.5313590417854;2471.1845091119885;2422.2248880358206;2462.2859370782453;2521.672182616248;2522.608995605684;2525.255049760325;2496.987515062431;2507.28542365425;2515.446601747631;2519.5842685956795;2520.710118336378;9285.675001374919;9314.487703176323;9329.860052099224;9333.626654933794;9342.439453632736;5539.833804985857;5546.944530554683;5595.1886976388605;5612.438756124396;5617.21359009739;3479.0606536235327;3517.1383011162175;3581.9104522387147;3603.963960360415;3616.2044350242904;1192.6600918738118;1216.4525963316455;1217.7442737025235;1229.274727910537;1257.7987521996529;12981.41583628739;13024.218546887218;13035.478580856849;13044.934775326063;13103.60689179326;4787.952120478751;4941.50584941503;5128.076946149728;5134.589232861437;5141.845744627667;10711.571537138427;10842.186835987333;10868.836967445495;10892.183086268562;10904.454777261106;5796.043652797325;5804.622699524602;5807.5063619591965;5807.5063619591965;5808.593398462067;5182.352205974254;5250.1337279349245;5295.4969277918535;5297.231901374279;5301.151815709545;4239.130978149472;4268.146370725867;4315.244832154361;4345.717528360647;4350.129974005212;1267.797152455621;1322.312397553267;1355.966100847467;1389.3122904162503;1408.1128888800195;927.0775578299636;940.5076547149971;950.8716323296405;968.5496244246318;998.0967224661692;5976.880462390728;6028.125921741323;6046.667433291212;6232.937670623326;6235;962.5716556132454;966.1111777165025;987.3187500624546;993.4089216915924;1019.6889948565611;4009.6792256619983;4160.604742549453;4180.122174343422;4198.076423186894;4204.642605378516;11156.330620162817;11678.532858685727;11719.355435450962;11745.11911606633;11755.294682318918;10192.847107293248;10909.563617455371;11548.133889958286;11598.18812683121;11601;8268.875966860502;8631.870521942301;8698.913010869937;8706.347023973227;8712.039791046964;5788.507976822018;5901.085331773582;5943.524518038633;6003.6998150093195;6067.453929146398;10538.683839484827;10572.36565806054;10731.839022414513;10781.9460902695;10855.2401331906;10972.506237219184;11010.064144547803;11028;11107.777844443228;11112.888871111185;7432.368248698921;7436.442266829901;7519.060117485315;7588.165301816685;7602.7339043133225;8791.340649451444;8826.161514656098;8881.467111973303;8890.911090889009;8912.643494260157;7961.40289478303;8118;8141.00545366389;8209.876851847108;8289.626966786389;7709.691612335668;7920.643571039433;7928.286454219148;8002.799930001796;8034.799130021796;7088.113985751781;7310.52481588695;7326.157491888288;7395.630218488946;7410.555366678017;5130.307408499804;5154.587632989427;5174.6119041072825;5199.7140157291715;5269.868253293698;5197.220416937338;5200.6879587224885;5242.790288388422;5266.605004624592;5417.160340147283 01:36:06 INFO - PROCESS | 6854 | |4;prototype.html;341.28671077448126;343.6563436563436;352.7248745978137;352.742497976477;357.16958072481486;5262.473752624735;5370.677759334442;5502.532284755795;5535.25274087998;5551.139573366129;5374.193870919364;5384.703841288738;5407.8368652539;5441.959265275522;5463.590230732691;4271.722338048033;4275.893102672427;4283.635890949273;4290.099079193373;4301.548337424572;3980.741251818637;4139.56534563871;4242.321228603424;4251.893702657428;4277.780832462749;4197.244495990721;4225.42956700846;4247.214265360903;4252.14957008598;4262.254105531535;4241.915161696764;4243.257429949746;4258.190943720714;4262.936055959163;4266.935995960048;3705.3330400527893;3815.465834783133;3824.426336049587;3848.826802793881;3853.5183102112237;5245.370555533323;5250.291210686547;5254.264402983586;5255.921161182585;5267.947320526784;4830.88407976853;4888.633352498541;4893.290472881448;4916.459189489154;4922.1386257405165;5348.946510534884;5654.773809047633;5666.744996475169;5671.7731290748325;5696.857578560528;4094.5700701426517;4136.379543068534;4137.358709400048;4141.192467468844;4153.273177193979;5946.405359464062;5960.701964901781;5962.910556341659;5976.64140151588;5995.880082398371;4019.8995025124023;4163.167366526707;4167.416561681367;4170.979145104255;4205.537390887;4239.682023848224;4256.659467242675;4271.359296105609;4277.550857160016;4279.079997800425;4837.298591704183;4845.563899249085;4848.151573474628;4854.247591623304;4896.290037944478;5511.338639363302;5697.658140511582;5709.628874123168;5730.77076916927;5763.164341170591;1375.5185685010167;1423.665438621923;1463.1952426165778;1472.0946617829957;1475.7048590281986;992.7567745902156;998.1316254858319;1006.2151521812998;1014.1835822163082;1016.6797458800454;5355.464453554613;5420.457954204627;5422.40353561108;5424.24060631504;5425.674459532441;5731.885362292731;5743;5766.971165144231;5779.797707080316;5784;5169.431362550116;5416.8624588836;5420.91868621971;5423.294971653739;5471.316085489314;2666.6400035994893;2674.866256687158;2698.9595156072673;2702.162329677806;2730.5904114383;5214.765335559909;5234.241035049897;5250.159974404153;5256;5272.753610157841;5223.268742376071;5572.665640061609;6026.6986650667295;6072.483838873657;6072.574919755575;6058.757954619293;6090.786822461193;6090.939090609126;6106.480949119375;6131.559083615258;5565.666060036411;5901.970490147522;5916.674582897982;5955.196048533393;5964.045752679551;5787.826365209051;5795.145553422864;5825.621334613236;5830.416958304136;5861.267341582302;6049.879002420015;6050.878982420415;6062.242219722535;6069.575129740876;6077.665728384981;3983.8605648803314;4206.137741762993;4221.493420789525;4238.114039252503;4248.553901840262;5678.488935995781;5760.135979603093;5885.676287804212;5887.61730487517;5914.497267732291;5673.205751194753;5675.77296908119;5677.943220567741;5690.459406356389;5781.653100813965;5646.407127251744;5646.745896434588;5658.264425624642;5660.575456840836;5680.829575112753;5441.945580544144;5568.9939801398705;5594.944050559442;5606.6916319602815;5611.859703507282;5602.663840169603;5659.377468478382;5660.9150862737915;5678.346990096026;5700.486956173964;5405.594580406564;5532.391436942014;5580.9441905580425;5588.441155884379;5608.10270356741 01:36:06 INFO - PROCESS | 6854 | |5;yui.html;784.5332027443673;825.154216927649;825.607836277768;854.5043874552753;871.0810095349403;13216.074874758771;13760.793588096161;13944.79082813756;14618.26908654567;14657.780133298009;13271.20372777634;13576.389062492186;13718.931405342959;13933.233672148028;13973.580792576238;820.7373640435078;838.4969018588858;839.8026463781007;847.0174597466939;847.8770578266148;669.7990602819135;794.1383598795285;822.7161629237934;828.888100106487;830.3315830756238;868.2316150207081;874.5583480342418;874.9650013999433;875.5797217335682;878.508035500122;699.464909344352;861.9181177788131;862.5385418800911;862.5773371048203;863.22741146674;616.0697347006053;631.0912286307703;631.1101347100612;634.9936500634981;635.4312889963503;13183.340832958314;13192;13220;13307.800382994263;13348.799768003488;13957.232352220726;14625.122492650475;14644.633884152874;14689.33897974583;14766.926165369212;13865.514706985308;13868;14042.789358159636;14194.929025354808;14271.928640356835;4494.325851122358;4560.612347950429;4574.679772415932;4590.744851338282;4743.928841067353;79136;80686.59656701738;81534.59232703858;81941.59029204876;84003.57998210032;10623.256372053882;11108.666739997812;11168.497417616227;11203.60787372438;11367.772644547063;19755.604887902162;19765.60468790616;19825.702614460795;19843.60312793736;19846.305379311656;7818.179091195457;7864.764057078297;7966.203379661987;7982.321502672338;8143.104258531557;4418.138462999685;4633.443986721615;4683.718976861399;4861.197902346144;4863.294822250754;3673.94489082664;3803.8858834235016;3813.6758375537834;3813.809309534512;3813.904652383713;665.012456502094;665.1851481934591;668.0513670587777;692.5948320232619;699.5592776550842;726.6330503095903;766.1993217088157;769.6267310354474;796.1004065406054;799.6961154761153;9695.757606059764;10215.336003159771;10333.173346132291;10413.791724165474;10820.729481763019;577.3475972151442;615.3754829262988;678.5826716569275;714.0717067811823;769.1155171552647;4442.8667139985855;4494;4595.931061034087;4681.227597446383;4770.27918223786;71005.6449717748;118758.40620796841;120055;123394;129218;105910.47044764881;108154;109793;110534;110730.44634776935;94962;95841.9999999986;96470.51764741272;97450.51274743582;100565;9366.765830854283;9652.131308182297;9673.177779888789;9676;9744.12302892743;47748.28377574409;48560.5143948556;48855;51508.227376590134;54703.72648136734;50408.24387634115;70113.29886701067;81830.59084704539;85212;89234;13641.79537306961;13764.93117534406;13848.792268115785;13851.861481385056;13972.301384930915;14548.927255364079;14877.404903803726;15875.206239687739;15994.520164395086;16037.518874433787;13713.314334283445;13881.167129972235;14208.928955355157;14284.285785710881;14712.190829504052;14201.857981420468;14340.713185736018;14459.566213013626;15017.24913754286;15037.473688420852;13404.865951340362;13590.45638174462;13734.682210235967;13815.585532434043;13879.583612491642;10530.947345263532;10536;10750;10954.561817527529;11166;11100.444977751242;11570.537178512765;12177.626895909805;12524.561640342545;12555.811662824883 01:36:06 INFO - PROCESS | 6854 | __end_tp_report 01:36:06 INFO - PROCESS | 6854 | __start_cc_report 01:36:06 INFO - PROCESS | 6854 | _x_x_mozilla_cycle_collect,1038 01:36:06 INFO - PROCESS | 6854 | __end_cc_report 01:36:06 INFO - PROCESS | 6854 | __startTimestamp1467275766195__endTimestamp 01:36:06 INFO - PROCESS | 6854 | 01:36:06 INFO - PROCESS | 6854 | ------- Summary: start ------- 01:36:06 INFO - PROCESS | 6854 | Number of tests: 6 01:36:06 INFO - PROCESS | 6854 | 01:36:06 INFO - PROCESS | 6854 | [#0] dojo.html Cycles:165 Average:5414.13 Median:5593.33 stddev:619.92 (11.1%) stddev-sans-first:595.01 01:36:06 INFO - PROCESS | 6854 | Values: 3115.5 3118.1 3137.2 3162.9 3210.9 5322.5 5374.0 5423.9 5451.6 5514.7 5401.8 5431.1 5464.0 5500.3 5542.6 4821.9 4870.1 4905.4 4917.9 5039.4 4993.2 5026.7 5034.8 5042.2 5047.8 4825.9 4847.1 4855.6 4889.3 4981.5 4804.0 4817.1 4846.5 4890.7 4954.4 4861.1 4896.2 4899.1 4912.9 4926.7 5198.1 5371.7 5424.4 5444.2 5509.8 5898.5 5953.9 5956.8 5958.5 5966.3 5939.0 5984.9 6009.3 6010.2 6011.2 5346.2 5488.4 5535.3 5540.9 5590.4 6035.7 6054.0 6055.8 6062.4 6096.2 5822.8 5826.5 5870.0 5886.4 5892.4 5723.3 5749.7 5754.4 5768.0 5870.5 5796.6 5799.1 5800.0 5800.6 5802.2 5671.3 5726.7 5785.6 5789.4 5790.3 4422.1 4448.3 4483.7 4499.0 4512.4 3997.2 4002.4 4012.8 4045.4 4054.1 5356.2 5593.3 5601.3 5604.4 5605.2 5847.9 5848.9 5878.9 5945.1 5980.0 5556.1 5561.2 5564.7 5571.6 5576.1 5079.3 5084.3 5084.7 5085.3 5133.5 5898.1 6022.5 6040.6 6086.8 6093.9 5841.6 5851.2 5851.7 5858.4 5861.3 5857.8 5958.5 6001.5 6016.8 6023.7 5648.8 5664.7 5672.0 5687.0 5713.3 5759.6 5791.1 5792.3 5795.5 5799.2 5491.9 5614.1 5626.5 5627.6 5631.1 5640.1 5682.1 5685.8 5688.0 5725.7 5554.4 5576.1 5578.2 5580.7 5592.2 5615.5 5619.0 5669.2 5707.6 5756.0 5487.5 5510.4 5515.2 5541.2 5545.1 01:36:06 INFO - PROCESS | 6854 | 01:36:06 INFO - PROCESS | 6854 | [#1] ext.html Cycles:180 Average:69003.28 Median:397589.00 stddev:144977.19 (36.5%) stddev-sans-first:145292.85 01:36:06 INFO - PROCESS | 6854 | Values: 572.9 622.4 640.3 647.7 653.8 31392.4 45011.8 45218.3 45988.0 46040.3 43666.6 47328.8 47343.5 47401.5 47449.5 8089.6 8935.5 9079.7 9080.9 10621.2 10614.5 10722.0 11055.6 11068.8 11073.6 11133.1 11200.7 11203.3 11209.0 11211.6 11082.6 11125.0 11161.4 11166.8 11173.9 10926.6 10947.8 10990.9 10996.0 11004.9 44628.1 44845.3 44948.1 45053.3 45056.5 3680.4 3749.5 3795.1 3810.0 3854.6 34136.0 35227.0 35503.5 35608.6 35669.6 4301.0 4305.4 4324.8 4339.2 4352.8 394441.0 397463.0 397715.0 398233.0 398686.0 66717.0 67077.0 67154.3 67256.0 67258.7 69743.0 69830.0 70007.0 70073.0 70094.6 16695.2 17069.8 17176.6 17197.2 17199.6 12983.9 13018.3 13026.5 13029.2 13036.2 20286.6 21055.5 21059.5 21103.4 21111.2 7227.9 7268.3 7369.2 7514.3 7526.9 958.6 997.6 1011.9 1048.8 1091.9 30725.0 32877.7 33059.2 33121.3 33280.0 954.9 1124.0 1131.4 1140.7 1207.2 16845.9 17222.3 17261.2 17355.5 17388.7 701049.0 705963.0 709022.0 711190.0 712839.0 60202.7 60829.7 60882.1 60883.7 60895.4 1244.2 1367.7 1367.9 1383.0 1410.2 33557.0 34438.7 34973.5 35672.3 35761.6 51157.7 51211.5 51799.7 51869.0 51879.2 472711.0 473772.0 474278.0 478496.0 479526.0 26997.6 29653.0 30202.5 30318.9 31482.0 48280.5 49891.5 50532.0 50894.7 51152.2 41333.8 41584.8 41867.0 42090.4 43333.9 41876.0 41992.4 42540.6 42591.1 43340.6 42588.4 42817.0 42820.0 43108.4 44037.8 36858.3 38745.6 38755.4 39000.6 39017.4 29158.9 29589.6 29623.0 29626.4 29706.3 01:36:06 INFO - PROCESS | 6854 | 01:36:06 INFO - PROCESS | 6854 | [#2] jquery.html Cycles:180 Average:28498.54 Median:25446.06 stddev:75555.29 (296.9%) stddev-sans-first:75737.80 01:36:06 INFO - PROCESS | 6854 | Values: 405.9 406.1 410.9 412.6 425.1 19126.1 20456.6 20583.3 20647.1 21607.4 20500.1 20679.8 20790.3 20814.9 20815.3 5776.8 5947.4 5987.2 5991.1 5992.6 5706.5 5870.7 5899.9 5974.7 5980.8 5773.3 5848.5 5857.4 5871.7 5875.0 5672.4 5842.3 5851.3 5942.4 5945.6 5292.8 5304.8 5312.0 5321.3 5330.6 24577.5 25326.2 25565.9 25608.7 25615.9 2450.7 2484.8 2486.9 2509.1 2597.8 14491.5 14987.5 15378.6 15484.8 15636.0 1968.8 2014.3 2029.9 2045.5 2075.9 56077.7 81549.0 85177.0 85892.0 88167.6 10557.5 10800.0 11152.0 11258.2 11270.7 13889.3 16052.1 16062.8 16066.8 16085.3 8066.2 8124.3 8375.0 8516.1 8642.7 8270.5 8331.9 8332.6 8433.8 8439.4 6989.5 6997.0 7053.0 7130.2 7148.4 1911.0 1914.0 1951.5 1993.9 2013.6 922.6 986.8 991.2 1073.2 1090.7 20729.4 20884.2 21044.4 21116.6 21221.8 1018.8 1074.8 1084.7 1127.9 1168.8 11663.5 12102.9 12271.6 12305.2 12313.4 453554.0 453606.0 459274.0 460143.0 465890.0 69737.7 87201.6 89291.6 90209.5 90519.0 1026.0 1036.6 1053.3 1058.0 1066.5 19180.5 19467.8 19939.5 20067.5 20102.6 43836.0 44425.8 44898.0 45313.1 45563.0 54530.0 55821.9 57588.0 57973.0 58107.4 5786.9 5977.6 8010.2 8258.9 8688.3 13927.9 14465.0 14526.5 14890.6 14890.7 11745.4 12074.5 12306.4 12417.9 12445.6 5910.6 9270.2 10470.8 11007.7 11450.9 12289.6 12545.2 12780.0 12908.7 12965.4 8467.2 8505.1 8613.7 8726.0 8745.7 10922.4 12304.8 12421.5 12455.6 12611.9 01:36:06 INFO - PROCESS | 6854 | 01:36:06 INFO - PROCESS | 6854 | [#3] mootools.html Cycles:180 Average:6075.12 Median:5138.22 stddev:3450.76 (67.2%) stddev-sans-first:3443.41 01:36:06 INFO - PROCESS | 6854 | Values: 1512.5 1523.6 1649.4 1794.8 1823.0 8753.5 9303.3 9386.1 9409.6 9418.9 7257.0 8724.8 8931.4 8959.7 9179.7 2474.6 2505.3 2506.1 2512.7 2514.7 2123.1 2461.4 2548.3 2549.1 2549.3 2405.7 2442.1 2458.5 2466.5 2471.2 2422.2 2462.3 2521.7 2522.6 2525.3 2497.0 2507.3 2515.4 2519.6 2520.7 9285.7 9314.5 9329.9 9333.6 9342.4 5539.8 5546.9 5595.2 5612.4 5617.2 3479.1 3517.1 3581.9 3604.0 3616.2 1192.7 1216.5 1217.7 1229.3 1257.8 12981.4 13024.2 13035.5 13044.9 13103.6 4788.0 4941.5 5128.1 5134.6 5141.8 10711.6 10842.2 10868.8 10892.2 10904.5 5796.0 5804.6 5807.5 5807.5 5808.6 5182.4 5250.1 5295.5 5297.2 5301.2 4239.1 4268.1 4315.2 4345.7 4350.1 1267.8 1322.3 1356.0 1389.3 1408.1 927.1 940.5 950.9 968.5 998.1 5976.9 6028.1 6046.7 6232.9 6235.0 962.6 966.1 987.3 993.4 1019.7 4009.7 4160.6 4180.1 4198.1 4204.6 11156.3 11678.5 11719.4 11745.1 11755.3 10192.8 10909.6 11548.1 11598.2 11601.0 8268.9 8631.9 8698.9 8706.3 8712.0 5788.5 5901.1 5943.5 6003.7 6067.5 10538.7 10572.4 10731.8 10781.9 10855.2 10972.5 11010.1 11028.0 11107.8 11112.9 7432.4 7436.4 7519.1 7588.2 7602.7 8791.3 8826.2 8881.5 8890.9 8912.6 7961.4 8118.0 8141.0 8209.9 8289.6 7709.7 7920.6 7928.3 8002.8 8034.8 7088.1 7310.5 7326.2 7395.6 7410.6 5130.3 5154.6 5174.6 5199.7 5269.9 5197.2 5200.7 5242.8 5266.6 5417.2 01:36:06 INFO - PROCESS | 6854 | 01:36:06 INFO - PROCESS | 6854 | [#4] prototype.html Cycles:180 Average:4763.28 Median:5395.15 stddev:1402.73 (26.0%) stddev-sans-first:1366.83 01:36:06 INFO - PROCESS | 6854 | Values: 341.3 343.7 352.7 352.7 357.2 5262.5 5370.7 5502.5 5535.3 5551.1 5374.2 5384.7 5407.8 5442.0 5463.6 4271.7 4275.9 4283.6 4290.1 4301.5 3980.7 4139.6 4242.3 4251.9 4277.8 4197.2 4225.4 4247.2 4252.1 4262.3 4241.9 4243.3 4258.2 4262.9 4266.9 3705.3 3815.5 3824.4 3848.8 3853.5 5245.4 5250.3 5254.3 5255.9 5267.9 4830.9 4888.6 4893.3 4916.5 4922.1 5348.9 5654.8 5666.7 5671.8 5696.9 4094.6 4136.4 4137.4 4141.2 4153.3 5946.4 5960.7 5962.9 5976.6 5995.9 4019.9 4163.2 4167.4 4171.0 4205.5 4239.7 4256.7 4271.4 4277.6 4279.1 4837.3 4845.6 4848.2 4854.2 4896.3 5511.3 5697.7 5709.6 5730.8 5763.2 1375.5 1423.7 1463.2 1472.1 1475.7 992.8 998.1 1006.2 1014.2 1016.7 5355.5 5420.5 5422.4 5424.2 5425.7 5731.9 5743.0 5767.0 5779.8 5784.0 5169.4 5416.9 5420.9 5423.3 5471.3 2666.6 2674.9 2699.0 2702.2 2730.6 5214.8 5234.2 5250.2 5256.0 5272.8 5223.3 5572.7 6026.7 6072.5 6072.6 6058.8 6090.8 6090.9 6106.5 6131.6 5565.7 5902.0 5916.7 5955.2 5964.0 5787.8 5795.1 5825.6 5830.4 5861.3 6049.9 6050.9 6062.2 6069.6 6077.7 3983.9 4206.1 4221.5 4238.1 4248.6 5678.5 5760.1 5885.7 5887.6 5914.5 5673.2 5675.8 5677.9 5690.5 5781.7 5646.4 5646.7 5658.3 5660.6 5680.8 5441.9 5569.0 5594.9 5606.7 5611.9 5602.7 5659.4 5660.9 5678.3 5700.5 5405.6 5532.4 5580.9 5588.4 5608.1 01:36:06 INFO - PROCESS | 6854 | 01:36:06 INFO - PROCESS | 6854 | [#5] yui.html Cycles:180 Average:21475.03 Median:4468.43 stddev:31701.62 (709.5%) stddev-sans-first:31752.49 01:36:06 INFO - PROCESS | 6854 | Values: 784.5 825.2 825.6 854.5 871.1 13216.1 13760.8 13944.8 14618.3 14657.8 13271.2 13576.4 13718.9 13933.2 13973.6 820.7 838.5 839.8 847.0 847.9 669.8 794.1 822.7 828.9 830.3 868.2 874.6 875.0 875.6 878.5 699.5 861.9 862.5 862.6 863.2 616.1 631.1 631.1 635.0 635.4 13183.3 13192.0 13220.0 13307.8 13348.8 13957.2 14625.1 14644.6 14689.3 14766.9 13865.5 13868.0 14042.8 14194.9 14271.9 4494.3 4560.6 4574.7 4590.7 4743.9 79136.0 80686.6 81534.6 81941.6 84003.6 10623.3 11108.7 11168.5 11203.6 11367.8 19755.6 19765.6 19825.7 19843.6 19846.3 7818.2 7864.8 7966.2 7982.3 8143.1 4418.1 4633.4 4683.7 4861.2 4863.3 3673.9 3803.9 3813.7 3813.8 3813.9 665.0 665.2 668.1 692.6 699.6 726.6 766.2 769.6 796.1 799.7 9695.8 10215.3 10333.2 10413.8 10820.7 577.3 615.4 678.6 714.1 769.1 4442.9 4494.0 4595.9 4681.2 4770.3 71005.6 118758.4 120055.0 123394.0 129218.0 105910.5 108154.0 109793.0 110534.0 110730.4 94962.0 95842.0 96470.5 97450.5 100565.0 9366.8 9652.1 9673.2 9676.0 9744.1 47748.3 48560.5 48855.0 51508.2 54703.7 50408.2 70113.3 81830.6 85212.0 89234.0 13641.8 13764.9 13848.8 13851.9 13972.3 14548.9 14877.4 15875.2 15994.5 16037.5 13713.3 13881.2 14208.9 14284.3 14712.2 14201.9 14340.7 14459.6 15017.2 15037.5 13404.9 13590.5 13734.7 13815.6 13879.6 10530.9 10536.0 10750.0 10954.6 11166.0 11100.4 11570.5 12177.6 12524.6 12555.8 01:36:06 INFO - PROCESS | 6854 | -------- Summary: end -------- 01:36:06 INFO - PROCESS | 6854 | 01:36:06 INFO - TEST-INFO | 6854: exit 0 01:36:06 INFO - TEST-OK | dromaeo_css | took 1113640ms 01:36:06 INFO - TEST-START | kraken 01:36:06 INFO - operating with platform_type : linux_ 01:36:06 INFO - Initialising browser for kraken test... 01:36:06 INFO - TEST-INFO | started process 7040 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCR5KJg/profile http://localhost:51906/getInfo.html) 01:36:10 INFO - PROCESS | 7040 | __metrics Screen width/height:1600/1200 01:36:10 INFO - PROCESS | 7040 | colorDepth:24 01:36:10 INFO - PROCESS | 7040 | Browser inner width/height: 1024/697 01:36:10 INFO - PROCESS | 7040 | __metrics 01:36:12 INFO - PROCESS | 7040 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:36:12 INFO - TEST-INFO | 7040: exit 0 01:36:12 INFO - Browser initialized. 01:36:12 INFO - Running cycle 1/1 for kraken test... 01:36:12 INFO - TEST-INFO | started process 7121 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCR5KJg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:36:24 INFO - PROCESS | 7121 | RSS: Main: 157995008 01:36:24 INFO - PROCESS | 7121 | 01:36:27 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51906/tests/kraken/driver.html?testName=audio-beat-detection) 01:36:27 INFO - PROCESS | 7121 | RSS: Main: 214847488 01:36:27 INFO - PROCESS | 7121 | 01:36:30 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51906/tests/kraken/driver.html?testName=audio-dft) 01:36:31 INFO - PROCESS | 7121 | RSS: Main: 204058624 01:36:31 INFO - PROCESS | 7121 | 01:36:34 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51906/tests/kraken/driver.html?testName=audio-fft) 01:36:35 INFO - PROCESS | 7121 | RSS: Main: 269639680 01:36:35 INFO - PROCESS | 7121 | 01:36:37 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51906/tests/kraken/driver.html?testName=audio-oscillator) 01:36:37 INFO - PROCESS | 7121 | RSS: Main: 180756480 01:36:37 INFO - PROCESS | 7121 | 01:36:39 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51906/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:36:40 INFO - PROCESS | 7121 | RSS: Main: 184549376 01:36:40 INFO - PROCESS | 7121 | 01:36:43 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51906/tests/kraken/driver.html?testName=imaging-darkroom) 01:36:44 INFO - PROCESS | 7121 | RSS: Main: 219979776 01:36:44 INFO - PROCESS | 7121 | 01:36:47 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51906/tests/kraken/driver.html?testName=imaging-desaturate) 01:36:48 INFO - PROCESS | 7121 | RSS: Main: 221085696 01:36:48 INFO - PROCESS | 7121 | 01:36:50 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51906/tests/kraken/driver.html?testName=json-parse-financial) 01:36:51 INFO - PROCESS | 7121 | RSS: Main: 221507584 01:36:51 INFO - PROCESS | 7121 | 01:36:52 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51906/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:36:53 INFO - PROCESS | 7121 | RSS: Main: 208773120 01:36:53 INFO - PROCESS | 7121 | 01:36:55 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51906/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:36:55 INFO - PROCESS | 7121 | RSS: Main: 212094976 01:36:55 INFO - PROCESS | 7121 | 01:36:57 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51906/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:36:58 INFO - PROCESS | 7121 | RSS: Main: 211886080 01:36:58 INFO - PROCESS | 7121 | 01:37:00 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51906/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:37:01 INFO - PROCESS | 7121 | RSS: Main: 224399360 01:37:01 INFO - PROCESS | 7121 | 01:37:04 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51906/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:37:04 INFO - PROCESS | 7121 | RSS: Main: 224964608 01:37:04 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | Cycle 1(1): loaded http://localhost:51906/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51906/tests/kraken/driver.html?testName=ai-astar) 01:37:06 INFO - PROCESS | 7121 | RSS: Main: 266567680 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | __start_tp_report 01:37:06 INFO - PROCESS | 7121 | _x_x_mozilla_page_load 01:37:06 INFO - PROCESS | 7121 | _x_x_mozilla_page_load_details 01:37:06 INFO - PROCESS | 7121 | |i|pagename|runs| 01:37:06 INFO - PROCESS | 7121 | |0;ai-astar;101;110;111;110;112;110;111;110;110;109 01:37:06 INFO - PROCESS | 7121 | |1;audio-beat-detection;156;116;125;176;123;118;147;128;160;115 01:37:06 INFO - PROCESS | 7121 | |2;audio-dft;161;161;161;160;160;159;161;161;162;162 01:37:06 INFO - PROCESS | 7121 | |3;audio-fft;75;74;76;116;77;76;74;75;97;75 01:37:06 INFO - PROCESS | 7121 | |4;audio-oscillator;88;83;109;84;84;84;119;83;84;129 01:37:06 INFO - PROCESS | 7121 | |5;imaging-gaussian-blur;117;118;117;116;117;117;117;117;116;116 01:37:06 INFO - PROCESS | 7121 | |6;imaging-darkroom;146;146;146;146;146;146;146;147;146;145 01:37:06 INFO - PROCESS | 7121 | |7;imaging-desaturate;95;95;95;95;94;95;95;95;95;95 01:37:06 INFO - PROCESS | 7121 | |8;json-parse-financial;54;51;52;52;52;52;52;52;52;51 01:37:06 INFO - PROCESS | 7121 | |9;json-stringify-tinderbox;61;60;61;61;60;61;60;62;61;61 01:37:06 INFO - PROCESS | 7121 | |10;stanford-crypto-aes;75;75;76;83;74;75;75;74;74;79 01:37:06 INFO - PROCESS | 7121 | |11;stanford-crypto-ccm;126;119;117;115;120;118;126;119;155;116 01:37:06 INFO - PROCESS | 7121 | |12;stanford-crypto-pbkdf2;151;155;155;154;153;154;153;157;153;156 01:37:06 INFO - PROCESS | 7121 | |13;stanford-crypto-sha256-iterative;64;69;66;61;66;61;63;68;59;61 01:37:06 INFO - PROCESS | 7121 | __end_tp_report 01:37:06 INFO - PROCESS | 7121 | __start_cc_report 01:37:06 INFO - PROCESS | 7121 | _x_x_mozilla_cycle_collect,1597 01:37:06 INFO - PROCESS | 7121 | __end_cc_report 01:37:06 INFO - PROCESS | 7121 | __startTimestamp1467275826763__endTimestamp 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | ------- Summary: start ------- 01:37:06 INFO - PROCESS | 7121 | Number of tests: 14 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#0] ai-astar Cycles:10 Average:109.40 Median:110.00 stddev:3.06 (2.8%) stddev-sans-first:0.87 01:37:06 INFO - PROCESS | 7121 | Values: 101.0 110.0 111.0 110.0 112.0 110.0 111.0 110.0 110.0 109.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#1] audio-beat-detection Cycles:10 Average:136.40 Median:137.50 stddev:21.64 (15.7%) stddev-sans-first:21.76 01:37:06 INFO - PROCESS | 7121 | Values: 156.0 116.0 125.0 176.0 123.0 118.0 147.0 128.0 160.0 115.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 01:37:06 INFO - PROCESS | 7121 | Values: 161.0 161.0 161.0 160.0 160.0 159.0 161.0 161.0 162.0 162.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#3] audio-fft Cycles:10 Average:81.50 Median:75.50 stddev:13.95 (18.5%) stddev-sans-first:14.59 01:37:06 INFO - PROCESS | 7121 | Values: 75.0 74.0 76.0 116.0 77.0 76.0 74.0 75.0 97.0 75.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:84.00 stddev:17.47 (20.8%) stddev-sans-first:18.37 01:37:06 INFO - PROCESS | 7121 | Values: 88.0 83.0 109.0 84.0 84.0 84.0 119.0 83.0 84.0 129.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 01:37:06 INFO - PROCESS | 7121 | Values: 117.0 118.0 117.0 116.0 117.0 117.0 117.0 117.0 116.0 116.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.47 (0.3%) stddev-sans-first:0.50 01:37:06 INFO - PROCESS | 7121 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 145.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 01:37:06 INFO - PROCESS | 7121 | Values: 95.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#8] json-parse-financial Cycles:10 Average:52.00 Median:52.00 stddev:0.82 (1.6%) stddev-sans-first:0.44 01:37:06 INFO - PROCESS | 7121 | Values: 54.0 51.0 52.0 52.0 52.0 52.0 52.0 52.0 52.0 51.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.63 (1.0%) stddev-sans-first:0.67 01:37:06 INFO - PROCESS | 7121 | Values: 61.0 60.0 61.0 61.0 60.0 61.0 60.0 62.0 61.0 61.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#10] stanford-crypto-aes Cycles:10 Average:76.00 Median:75.00 stddev:2.87 (3.8%) stddev-sans-first:3.02 01:37:06 INFO - PROCESS | 7121 | Values: 75.0 75.0 76.0 83.0 74.0 75.0 75.0 74.0 74.0 79.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#11] stanford-crypto-ccm Cycles:10 Average:123.10 Median:119.50 stddev:11.82 (9.9%) stddev-sans-first:12.49 01:37:06 INFO - PROCESS | 7121 | Values: 126.0 119.0 117.0 115.0 120.0 118.0 126.0 119.0 155.0 116.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.10 Median:154.50 stddev:1.73 (1.1%) stddev-sans-first:1.42 01:37:06 INFO - PROCESS | 7121 | Values: 151.0 155.0 155.0 154.0 153.0 154.0 153.0 157.0 153.0 156.0 01:37:06 INFO - PROCESS | 7121 | 01:37:06 INFO - PROCESS | 7121 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:63.80 Median:65.00 stddev:3.36 (5.2%) stddev-sans-first:3.56 01:37:06 INFO - PROCESS | 7121 | Values: 64.0 69.0 66.0 61.0 66.0 61.0 63.0 68.0 59.0 61.0 01:37:06 INFO - PROCESS | 7121 | -------- Summary: end -------- 01:37:06 INFO - PROCESS | 7121 | 01:37:07 INFO - TEST-INFO | 7121: exit 0 01:37:07 INFO - TEST-OK | kraken | took 60837ms 01:37:07 INFO - SUITE-END | took 1174s 01:37:07 INFO - Completed test suite (00:19:34) 01:37:07 INFO - javascript benchmark 01:37:07 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3115.5326700994847, 3118.0801663509264, 3137.2313783123136, 3162.8892988745397, 3210.9197270068244, 5322.547583455401, 5373.973130134349, 5423.945760542393, 5451.563874890009, 5514.724263786815, 5401.810936617219, 5431.131019036955, 5463.972680136594, 5500.28496295481, 5542.584306177033, 4821.90356192876, 4870.050340183666, 4905.4358748744, 4917.926231106536, 5039.370078740158, 4993.176125939216, 5026.698398096108, 5034.84895453137, 5042.243663450475, 5047.823326183584, 4825.90348193036, 4847.103285892122, 4855.5872750816225, 4889.266610008492, 4981.452040275567, 4803.975980120112, 4817.060673168733, 4846.491118432585, 4890.682105663156, 4954.43024052235, 4861.1006963711825, 4896.167651499253, 4899.142650036265, 4912.926306105412, 4926.679765815246, 5198.116320225571, 5371.650842695212, 5424.376196737387, 5444.156155795818, 5509.779608815643, 5898.498627616657, 5953.8809223815715, 5956.791512297049, 5958.463738263577, 5966.254218222723, 5938.970305148447, 5984.880302393971, 6009.338972712998, 6010.218671572711, 6011.1884895539415, 5346.224797404393, 5488.423715509894, 5535.335759708821, 5540.9168862467095, 5590.413006634326, 6035.698215089228, 6054.022810960045, 6055.810991023313, 6062.444973910784, 6096.237970253718, 5822.82531524055, 5826.533877289807, 5869.970650146722, 5886.352501224862, 5892.410758924159, 5723.284589426322, 5749.712514374264, 5754.424557544212, 5767.971160144172, 5870.471657550841, 5796.565257605696, 5799.072148456226, 5800.0429929062075, 5800.622959507618, 5802.245708057925, 5671.262735844314, 5726.713664316768, 5785.595008349459, 5789.421057894177, 5790.276215473066, 4422.137683151755, 4448.332750087448, 4483.730976141442, 4499.010217752089, 4512.435945506812, 3997.2205419942834, 4002.4396584478195, 4012.8194231259663, 4045.3527435610163, 4054.1283624020975, 5356.1697936819855, 5593.328800543961, 5601.29983752031, 5604.3835178131185, 5605.159226116115, 5847.9415205848245, 5848.883022339614, 5878.911816322759, 5945.078512830518, 5980.0, 5556.111022236423, 5561.221428999943, 5564.693941833238, 5571.554275658019, 5576.1356989666665, 5079.263506791494, 5084.313617661643, 5084.745762711849, 5085.313482679865, 5133.512316329943, 5898.085796701518, 6022.518198544106, 6040.60736052164, 6086.786962456381, 6093.939060609426, 5841.649501029951, 5851.239338886088, 5851.707414629337, 5858.414158584107, 5861.296644402699, 5857.824265272048, 5958.463738263577, 6001.549883758648, 6016.759329626766, 6023.698815059141, 5648.802291919763, 5664.716764161693, 5672.0, 5686.971565142313, 5713.314402271754, 5759.596828222152, 5791.0734282514595, 5792.304923409218, 5795.507381872588, 5799.246098007232, 5491.945080549143, 5614.07367784311, 5626.521745651502, 5627.634203776742, 5631.099024156116, 5640.125780504029, 5682.147677848356, 5685.772569097356, 5687.971560142173, 5725.656460612377, 5554.444555544414, 5576.052071147996, 5578.219049333178, 5580.665160090245, 5592.189132575672, 5615.494605485526, 5618.971905140448, 5669.206311116364, 5707.571932105192, 5755.971220143872, 5487.451254874641, 5510.3938566758425, 5515.200295957144, 5541.168824676331, 5545.112781954868], "value": 5372.099965266791, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.8768314812314, 622.3962756126556, 640.2573015302249, 647.6696884588861, 653.7744478155041, 31392.372152556934, 45011.77494112529, 45218.32172517411, 45988.0, 46040.309395359094, 43666.56333436665, 47328.763356183255, 47343.52656473434, 47401.52598474014, 47449.52550474494, 8089.555074470902, 8935.508547029911, 9079.682211122612, 9080.8637870432, 10621.150307975344, 10614.469276536181, 10722.0, 11055.613053543128, 11068.778624427507, 11073.612423565177, 11133.10935125188, 11200.719982000475, 11203.327800331965, 11209.047230985376, 11211.551537938472, 11082.6121085762, 11125.0, 11161.38612376319, 11166.832497512503, 11173.944130279297, 10926.617568385069, 10947.83578246327, 10990.890091099147, 10996.0, 11004.889951100467, 44628.10743785139, 44845.3273200899, 44948.10103797906, 45053.32420013702, 45056.54943450589, 3680.4479328100997, 3749.493818334517, 3795.0891785971166, 3809.9619003809885, 3854.5952674969003, 34136.0, 35227.0, 35503.4674479883, 35608.64391356105, 35669.64330356689, 4301.03242707519, 4305.354196870463, 4324.805383757738, 4339.240632889232, 4352.804123814404, 394441.0, 397463.0, 397715.0, 398233.0, 398686.0, 66717.0, 67077.0, 67154.32845671578, 67256.0, 67258.66370668115, 69743.0, 69830.0, 70007.0, 70073.0, 70094.64952675204, 16695.24871380791, 17069.829301707072, 17176.570585735455, 17197.226124824163, 17199.57001074983, 12983.935080324538, 13018.349082545836, 13026.54407095766, 13029.218246905217, 13036.152650077714, 20286.594268114553, 21055.473613159487, 21059.473513162295, 21103.366898993056, 21111.155553777982, 7227.89158162628, 7268.27317268269, 7369.189389167187, 7514.286142816533, 7526.924730752732, 958.5693822828242, 997.6059456514636, 1011.9392836429838, 1048.7692707604315, 1091.9080919080918, 30725.0, 32877.67122328746, 33059.187682295415, 33121.33757324888, 33280.0, 954.8710924025306, 1123.9606613768478, 1131.4060118437885, 1140.749035212252, 1207.1610230889623, 16845.91577042107, 17222.311107555808, 17261.223244954006, 17355.47933561995, 17388.739168912478, 701049.0, 705963.0, 709022.0, 711190.0, 712839.0, 60202.69898650479, 60829.69585152046, 60882.08676869851, 60883.69558152181, 60895.391046089855, 1244.2472304255796, 1367.746966811143, 1367.883729882971, 1383.0, 1410.2102822419479, 33557.0, 34438.65561344455, 34973.47539786854, 35672.324575656414, 35761.64238357583, 51157.744211280195, 51211.487885122166, 51799.74100129475, 51869.0, 51879.22181167361, 472711.0, 473772.0, 474278.0, 478496.0, 479526.0, 26997.59503607487, 29653.0, 30202.54696179603, 30318.938837140595, 31482.0, 48280.51719482901, 49891.50108498868, 50532.0, 50894.74552627361, 51152.23271650854, 41333.79333103315, 41584.792076039426, 41867.0, 42090.36864447097, 43333.91665208395, 41876.0, 41992.370114447695, 42540.57459425366, 42591.14817703691, 43340.56659433365, 42588.36117458303, 42817.0, 42820.0, 43108.35337470003, 44037.779811100736, 36858.26283474369, 38745.6125438742, 38755.41866872056, 39000.609993900835, 39017.41473877951, 29158.854205728836, 29589.5561566581, 29623.0, 29626.407471850012, 29706.257343566584], "value": 21641.966748507682, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [405.8660641988144, 406.06807377069623, 410.9198706252281, 412.60183922514784, 425.12000159669475, 19126.13932373043, 20456.590868182626, 20583.27958521452, 20647.070881810316, 21607.351779446602, 20500.077496512655, 20679.793202067976, 20790.272340468087, 20814.89592552035, 20815.27146549871, 5776.82669519914, 5947.434993675615, 5987.161797348353, 5991.101334799771, 5992.5505587080925, 5706.486416222539, 5870.735816888229, 5899.852503687399, 5974.701264936757, 5980.79067232647, 5773.30720313563, 5848.532117430616, 5857.3849745776715, 5871.677057761822, 5875.0, 5672.404397538261, 5842.328132264802, 5851.268591426072, 5942.405759424067, 5945.6135351202465, 5292.841214763564, 5304.814331498417, 5312.043832110218, 5321.255024296602, 5330.5735541157, 24577.508449831083, 25326.240212793644, 25565.872170639213, 25608.74391256082, 25615.87192064028, 2450.7426720194303, 2484.8012159027235, 2486.925392238236, 2509.146890057389, 2597.8181527293095, 14491.492797752027, 14987.475438359605, 15378.615534611612, 15484.845151548565, 15636.0, 1968.8326492248177, 2014.2849288502664, 2029.8680585761879, 2045.5193029638024, 2075.865068770525, 56077.74862635367, 81549.0, 85177.0, 85892.0, 88167.55916220442, 10557.524911379007, 10800.0, 11152.044708152345, 11258.155638327158, 11270.718232044264, 13889.305534723224, 16052.117133557533, 16062.839371606367, 16066.839331606769, 16085.276162572713, 8066.15305392937, 8124.268815806606, 8374.958125209458, 8516.148385161434, 8642.654293828176, 8270.462419942685, 8331.875021874677, 8332.583370831435, 8433.831323373499, 8439.409241353047, 6989.545679530916, 6996.962813101125, 7052.9647351762915, 7130.180029296594, 7148.428125749928, 1911.0027278666464, 1914.009430192612, 1951.4926119209108, 1993.9401817945484, 2013.647277283336, 922.6493932305681, 986.792773517555, 991.2417000994245, 1073.1843798712878, 1090.7000574841982, 20729.378118656463, 20884.164633414493, 21044.368668939955, 21116.577668446545, 21221.78778212229, 1018.7962407518378, 1074.8280275155937, 1084.7233955341337, 1127.932324060559, 1168.7896178687918, 11663.533458661728, 12102.878971210175, 12271.570495032809, 12305.200161989442, 12313.384330783605, 453554.0, 453606.0, 459274.0, 460143.0, 465890.0, 69737.65131174312, 87201.56399217964, 89291.55354223188, 90209.54895225482, 90519.0, 1025.9692209233735, 1036.5801850250662, 1053.2995557953875, 1057.984130238047, 1066.5307264803307, 19180.520486987378, 19467.8053219466, 19939.501512462306, 20067.49831254172, 20102.59794804125, 43836.0, 44425.77787111044, 44898.0, 45313.09373812571, 45563.0, 54530.0, 55821.88356232934, 57588.0, 57973.0, 58107.41892581189, 5786.884262314814, 5977.581569290108, 8010.198980101944, 8258.926339575817, 8688.26149777276, 13927.86072139306, 14465.0, 14526.491572794901, 14890.627734306729, 14890.702185956437, 11745.354005529778, 12074.45664945062, 12306.446209920396, 12417.875821242033, 12445.564405246136, 5910.586258961831, 9270.212031977357, 10470.842937355794, 11007.669769906915, 11450.912163344468, 12289.631311060682, 12545.184563003375, 12779.977601791648, 12908.677283067998, 12965.351732413154, 8467.195616416431, 8505.064442911398, 8613.69852055175, 8725.956370218108, 8745.650173992968, 10922.378629128792, 12304.753904921672, 12421.503139874303, 12455.564055258023, 12611.87388126107], "value": 9651.742495374316, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1512.53111535424, 1523.603862995621, 1649.356750867162, 1794.838464538193, 1822.9726554101683, 8753.518556479392, 9303.348765586412, 9386.108319709634, 9409.576569054392, 9418.858717119248, 7256.9637151814295, 8724.825503489943, 8931.41945773526, 8959.686410975617, 9179.678711245107, 2474.6164344526537, 2505.2838805418255, 2506.0727530813533, 2512.6733524641772, 2514.710808257046, 2123.0764617391405, 2461.384653836541, 2548.3374322676145, 2549.0568489658854, 2549.3244290263096, 2405.747396523366, 2442.1330427698176, 2458.483718419134, 2466.5313590417854, 2471.1845091119885, 2422.2248880358206, 2462.2859370782453, 2521.672182616248, 2522.608995605684, 2525.255049760325, 2496.987515062431, 2507.28542365425, 2515.446601747631, 2519.5842685956795, 2520.710118336378, 9285.675001374919, 9314.487703176323, 9329.860052099224, 9333.626654933794, 9342.439453632736, 5539.833804985857, 5546.944530554683, 5595.1886976388605, 5612.438756124396, 5617.21359009739, 3479.0606536235327, 3517.1383011162175, 3581.9104522387147, 3603.963960360415, 3616.2044350242904, 1192.6600918738118, 1216.4525963316455, 1217.7442737025235, 1229.274727910537, 1257.7987521996529, 12981.41583628739, 13024.218546887218, 13035.478580856849, 13044.934775326063, 13103.60689179326, 4787.952120478751, 4941.50584941503, 5128.076946149728, 5134.589232861437, 5141.845744627667, 10711.571537138427, 10842.186835987333, 10868.836967445495, 10892.183086268562, 10904.454777261106, 5796.043652797325, 5804.622699524602, 5807.5063619591965, 5807.5063619591965, 5808.593398462067, 5182.352205974254, 5250.1337279349245, 5295.4969277918535, 5297.231901374279, 5301.151815709545, 4239.130978149472, 4268.146370725867, 4315.244832154361, 4345.717528360647, 4350.129974005212, 1267.797152455621, 1322.312397553267, 1355.966100847467, 1389.3122904162503, 1408.1128888800195, 927.0775578299636, 940.5076547149971, 950.8716323296405, 968.5496244246318, 998.0967224661692, 5976.880462390728, 6028.125921741323, 6046.667433291212, 6232.937670623326, 6235.0, 962.5716556132454, 966.1111777165025, 987.3187500624546, 993.4089216915924, 1019.6889948565611, 4009.6792256619983, 4160.604742549453, 4180.122174343422, 4198.076423186894, 4204.642605378516, 11156.330620162817, 11678.532858685727, 11719.355435450962, 11745.11911606633, 11755.294682318918, 10192.847107293248, 10909.563617455371, 11548.133889958286, 11598.18812683121, 11601.0, 8268.875966860502, 8631.870521942301, 8698.913010869937, 8706.347023973227, 8712.039791046964, 5788.507976822018, 5901.085331773582, 5943.524518038633, 6003.6998150093195, 6067.453929146398, 10538.683839484827, 10572.36565806054, 10731.839022414513, 10781.9460902695, 10855.2401331906, 10972.506237219184, 11010.064144547803, 11028.0, 11107.777844443228, 11112.888871111185, 7432.368248698921, 7436.442266829901, 7519.060117485315, 7588.165301816685, 7602.7339043133225, 8791.340649451444, 8826.161514656098, 8881.467111973303, 8890.911090889009, 8912.643494260157, 7961.40289478303, 8118.0, 8141.00545366389, 8209.876851847108, 8289.626966786389, 7709.691612335668, 7920.643571039433, 7928.286454219148, 8002.799930001796, 8034.799130021796, 7088.113985751781, 7310.52481588695, 7326.157491888288, 7395.630218488946, 7410.555366678017, 5130.307408499804, 5154.587632989427, 5174.6119041072825, 5199.7140157291715, 5269.868253293698, 5197.220416937338, 5200.6879587224885, 5242.790288388422, 5266.605004624592, 5417.160340147283], "value": 4871.51321627602, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.28671077448126, 343.6563436563436, 352.7248745978137, 352.742497976477, 357.16958072481486, 5262.473752624735, 5370.677759334442, 5502.532284755795, 5535.25274087998, 5551.139573366129, 5374.193870919364, 5384.703841288738, 5407.8368652539, 5441.959265275522, 5463.590230732691, 4271.722338048033, 4275.893102672427, 4283.635890949273, 4290.099079193373, 4301.548337424572, 3980.741251818637, 4139.56534563871, 4242.321228603424, 4251.893702657428, 4277.780832462749, 4197.244495990721, 4225.42956700846, 4247.214265360903, 4252.14957008598, 4262.254105531535, 4241.915161696764, 4243.257429949746, 4258.190943720714, 4262.936055959163, 4266.935995960048, 3705.3330400527893, 3815.465834783133, 3824.426336049587, 3848.826802793881, 3853.5183102112237, 5245.370555533323, 5250.291210686547, 5254.264402983586, 5255.921161182585, 5267.947320526784, 4830.88407976853, 4888.633352498541, 4893.290472881448, 4916.459189489154, 4922.1386257405165, 5348.946510534884, 5654.773809047633, 5666.744996475169, 5671.7731290748325, 5696.857578560528, 4094.5700701426517, 4136.379543068534, 4137.358709400048, 4141.192467468844, 4153.273177193979, 5946.405359464062, 5960.701964901781, 5962.910556341659, 5976.64140151588, 5995.880082398371, 4019.8995025124023, 4163.167366526707, 4167.416561681367, 4170.979145104255, 4205.537390887, 4239.682023848224, 4256.659467242675, 4271.359296105609, 4277.550857160016, 4279.079997800425, 4837.298591704183, 4845.563899249085, 4848.151573474628, 4854.247591623304, 4896.290037944478, 5511.338639363302, 5697.658140511582, 5709.628874123168, 5730.77076916927, 5763.164341170591, 1375.5185685010167, 1423.665438621923, 1463.1952426165778, 1472.0946617829957, 1475.7048590281986, 992.7567745902156, 998.1316254858319, 1006.2151521812998, 1014.1835822163082, 1016.6797458800454, 5355.464453554613, 5420.457954204627, 5422.40353561108, 5424.24060631504, 5425.674459532441, 5731.885362292731, 5743.0, 5766.971165144231, 5779.797707080316, 5784.0, 5169.431362550116, 5416.8624588836, 5420.91868621971, 5423.294971653739, 5471.316085489314, 2666.6400035994893, 2674.866256687158, 2698.9595156072673, 2702.162329677806, 2730.5904114383, 5214.765335559909, 5234.241035049897, 5250.159974404153, 5256.0, 5272.753610157841, 5223.268742376071, 5572.665640061609, 6026.6986650667295, 6072.483838873657, 6072.574919755575, 6058.757954619293, 6090.786822461193, 6090.939090609126, 6106.480949119375, 6131.559083615258, 5565.666060036411, 5901.970490147522, 5916.674582897982, 5955.196048533393, 5964.045752679551, 5787.826365209051, 5795.145553422864, 5825.621334613236, 5830.416958304136, 5861.267341582302, 6049.879002420015, 6050.878982420415, 6062.242219722535, 6069.575129740876, 6077.665728384981, 3983.8605648803314, 4206.137741762993, 4221.493420789525, 4238.114039252503, 4248.553901840262, 5678.488935995781, 5760.135979603093, 5885.676287804212, 5887.61730487517, 5914.497267732291, 5673.205751194753, 5675.77296908119, 5677.943220567741, 5690.459406356389, 5781.653100813965, 5646.407127251744, 5646.745896434588, 5658.264425624642, 5660.575456840836, 5680.829575112753, 5441.945580544144, 5568.9939801398705, 5594.944050559442, 5606.6916319602815, 5611.859703507282, 5602.663840169603, 5659.377468478382, 5660.9150862737915, 5678.346990096026, 5700.486956173964, 5405.594580406564, 5532.391436942014, 5580.9441905580425, 5588.441155884379, 5608.10270356741], "value": 4320.639405638997, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.5332027443673, 825.154216927649, 825.607836277768, 854.5043874552753, 871.0810095349403, 13216.074874758771, 13760.793588096161, 13944.79082813756, 14618.26908654567, 14657.780133298009, 13271.20372777634, 13576.389062492186, 13718.931405342959, 13933.233672148028, 13973.580792576238, 820.7373640435078, 838.4969018588858, 839.8026463781007, 847.0174597466939, 847.8770578266148, 669.7990602819135, 794.1383598795285, 822.7161629237934, 828.888100106487, 830.3315830756238, 868.2316150207081, 874.5583480342418, 874.9650013999433, 875.5797217335682, 878.508035500122, 699.464909344352, 861.9181177788131, 862.5385418800911, 862.5773371048203, 863.22741146674, 616.0697347006053, 631.0912286307703, 631.1101347100612, 634.9936500634981, 635.4312889963503, 13183.340832958314, 13192.0, 13220.0, 13307.800382994263, 13348.799768003488, 13957.232352220726, 14625.122492650475, 14644.633884152874, 14689.33897974583, 14766.926165369212, 13865.514706985308, 13868.0, 14042.789358159636, 14194.929025354808, 14271.928640356835, 4494.325851122358, 4560.612347950429, 4574.679772415932, 4590.744851338282, 4743.928841067353, 79136.0, 80686.59656701738, 81534.59232703858, 81941.59029204876, 84003.57998210032, 10623.256372053882, 11108.666739997812, 11168.497417616227, 11203.60787372438, 11367.772644547063, 19755.604887902162, 19765.60468790616, 19825.702614460795, 19843.60312793736, 19846.305379311656, 7818.179091195457, 7864.764057078297, 7966.203379661987, 7982.321502672338, 8143.104258531557, 4418.138462999685, 4633.443986721615, 4683.718976861399, 4861.197902346144, 4863.294822250754, 3673.94489082664, 3803.8858834235016, 3813.6758375537834, 3813.809309534512, 3813.904652383713, 665.012456502094, 665.1851481934591, 668.0513670587777, 692.5948320232619, 699.5592776550842, 726.6330503095903, 766.1993217088157, 769.6267310354474, 796.1004065406054, 799.6961154761153, 9695.757606059764, 10215.336003159771, 10333.173346132291, 10413.791724165474, 10820.729481763019, 577.3475972151442, 615.3754829262988, 678.5826716569275, 714.0717067811823, 769.1155171552647, 4442.8667139985855, 4494.0, 4595.931061034087, 4681.227597446383, 4770.27918223786, 71005.6449717748, 118758.40620796841, 120055.0, 123394.0, 129218.0, 105910.47044764881, 108154.0, 109793.0, 110534.0, 110730.44634776935, 94962.0, 95841.9999999986, 96470.51764741272, 97450.51274743582, 100565.0, 9366.765830854283, 9652.131308182297, 9673.177779888789, 9676.0, 9744.12302892743, 47748.28377574409, 48560.5143948556, 48855.0, 51508.227376590134, 54703.72648136734, 50408.24387634115, 70113.29886701067, 81830.59084704539, 85212.0, 89234.0, 13641.79537306961, 13764.93117534406, 13848.792268115785, 13851.861481385056, 13972.301384930915, 14548.927255364079, 14877.404903803726, 15875.206239687739, 15994.520164395086, 16037.518874433787, 13713.314334283445, 13881.167129972235, 14208.928955355157, 14284.285785710881, 14712.190829504052, 14201.857981420468, 14340.713185736018, 14459.566213013626, 15017.24913754286, 15037.473688420852, 13404.865951340362, 13590.45638174462, 13734.682210235967, 13815.585532434043, 13879.583612491642, 10530.947345263532, 10536.0, 10750.0, 10954.561817527529, 11166.0, 11100.444977751242, 11570.537178512765, 12177.626895909805, 12524.561640342545, 12555.811662824883], "value": 7711.731817507672, "unit": "score"}], "name": "dromaeo_css", "value": 7529.093511454411, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 110.0, 111.0, 110.0, 112.0, 110.0, 111.0, 110.0, 110.0, 109.0], "value": 109.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [156.0, 116.0, 125.0, 176.0, 123.0, 118.0, 147.0, 128.0, 160.0, 115.0], "value": 136.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 160.0, 160.0, 159.0, 161.0, 161.0, 162.0, 162.0], "value": 160.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 74.0, 76.0, 116.0, 77.0, 76.0, 74.0, 75.0, 97.0, 75.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 83.0, 109.0, 84.0, 84.0, 84.0, 119.0, 83.0, 84.0, 129.0], "value": 94.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 116.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 145.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 51.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 52.0, 51.0], "value": 52.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 61.0, 61.0, 60.0, 61.0, 60.0, 62.0, 61.0, 61.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 83.0, 74.0, 75.0, 75.0, 74.0, 74.0, 79.0], "value": 76.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [126.0, 119.0, 117.0, 115.0, 120.0, 118.0, 126.0, 119.0, 155.0, 116.0], "value": 123.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 155.0, 155.0, 154.0, 153.0, 154.0, 153.0, 157.0, 153.0, 156.0], "value": 154.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 69.0, 66.0, 61.0, 66.0, 61.0, 63.0, 68.0, 59.0, 61.0], "value": 63.8, "unit": "score"}], "name": "kraken", "value": 1470.2999999999997, "alertThreshold": 2.0}]} 01:37:08 INFO - Return code: 0 01:37:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:37:08 INFO - # TBPL SUCCESS # 01:37:08 INFO - Running post-action listener: _resource_record_post_action 01:37:08 INFO - ##### 01:37:08 INFO - ##### Finished run-tests step (success) 01:37:08 INFO - ##### 01:37:08 INFO - Running post-run listener: _resource_record_post_run 01:37:08 INFO - Total resource usage - Wall time: 1192s; CPU: 13.0%; Read bytes: 0; Write bytes: 551923712; Read time: 0; Write time: 472936 01:37:08 INFO - TinderboxPrint: CPU usage
12.9% 01:37:08 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 01:37:08 INFO - TinderboxPrint: I/O write bytes / time
551,923,712 / 472,936 01:37:08 INFO - TinderboxPrint: CPU idle
8,280.6 (87.0%) 01:37:08 INFO - TinderboxPrint: CPU user
1,189.3 (12.5%) 01:37:08 INFO - TinderboxPrint: Swap in / out
0 / 0 01:37:08 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256540672; Read time: 0; Write time: 247108 01:37:08 INFO - run-tests - Wall time: 1175s; CPU: 13.0%; Read bytes: 0; Write bytes: 295383040; Read time: 0; Write time: 225828 01:37:08 INFO - Running post-run listener: _upload_blobber_files 01:37:08 INFO - Blob upload gear active. 01:37:08 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:37:08 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 01:37:08 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'] 01:37:08 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 01:37:09 INFO - (blobuploader) - INFO - Open directory for files ... 01:37:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:37:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:37:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:37:09 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:37:09 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:37:09 INFO - (blobuploader) - INFO - Done attempting. 01:37:09 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:37:09 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:37:09 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:37:13 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:37:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:37:13 INFO - (blobuploader) - INFO - Done attempting. 01:37:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:37:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:37:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:37:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:37:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:37:14 INFO - (blobuploader) - INFO - Done attempting. 01:37:14 INFO - (blobuploader) - INFO - Iteration through files over. 01:37:14 INFO - Return code: 0 01:37:14 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:37:14 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:37:14 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a2542e5c636817befa3562838a86857382b473135a9c724080d6284f767a41538e807deb0642c40d07cb242ac6c73fff5b71d191414471a4049ac827f872ad1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/950a8b4f556da6915385ebe15d85e5021c9ee06d5d69e51e7ed9056100545aead0789c11f81279dd1a927f655a4714e1e218ac26dfa19f7cb05d4ad98d4c912b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93ca6551d7e10ccd422dbc5b54f39a6f52e73c314f713bc7e50beb0bbaae9e6453577d1738d18a59709ead46ff68605ecaec21a70c2bc6ec3ec812bb657ac813"} 01:37:14 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:37:14 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:37:14 INFO - Contents: 01:37:14 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/a2542e5c636817befa3562838a86857382b473135a9c724080d6284f767a41538e807deb0642c40d07cb242ac6c73fff5b71d191414471a4049ac827f872ad1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/950a8b4f556da6915385ebe15d85e5021c9ee06d5d69e51e7ed9056100545aead0789c11f81279dd1a927f655a4714e1e218ac26dfa19f7cb05d4ad98d4c912b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93ca6551d7e10ccd422dbc5b54f39a6f52e73c314f713bc7e50beb0bbaae9e6453577d1738d18a59709ead46ff68605ecaec21a70c2bc6ec3ec812bb657ac813"} 01:37:14 INFO - Running post-run listener: copy_logs_to_upload_dir 01:37:14 INFO - Copying logs to upload dir... 01:37:14 INFO - mkdir: /builds/slave/test/build/upload/logs 01:37:14 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.644327 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-06-30 01:37:13.821333) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 01:37:13.828580) ========= 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=00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282 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/a2542e5c636817befa3562838a86857382b473135a9c724080d6284f767a41538e807deb0642c40d07cb242ac6c73fff5b71d191414471a4049ac827f872ad1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/950a8b4f556da6915385ebe15d85e5021c9ee06d5d69e51e7ed9056100545aead0789c11f81279dd1a927f655a4714e1e218ac26dfa19f7cb05d4ad98d4c912b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93ca6551d7e10ccd422dbc5b54f39a6f52e73c314f713bc7e50beb0bbaae9e6453577d1738d18a59709ead46ff68605ecaec21a70c2bc6ec3ec812bb657ac813"} build_url:https://queue.taskcluster.net/v1/task/HdL1wBIWSr6L20EcOLjY2Q/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011129 build_url: 'https://queue.taskcluster.net/v1/task/HdL1wBIWSr6L20EcOLjY2Q/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/a2542e5c636817befa3562838a86857382b473135a9c724080d6284f767a41538e807deb0642c40d07cb242ac6c73fff5b71d191414471a4049ac827f872ad1e", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/950a8b4f556da6915385ebe15d85e5021c9ee06d5d69e51e7ed9056100545aead0789c11f81279dd1a927f655a4714e1e218ac26dfa19f7cb05d4ad98d4c912b", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Inbound/sha512/93ca6551d7e10ccd422dbc5b54f39a6f52e73c314f713bc7e50beb0bbaae9e6453577d1738d18a59709ead46ff68605ecaec21a70c2bc6ec3ec812bb657ac813"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-06-30 01:37:13.858098) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 01:37:13.858525) ========= 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=00204705a9daa57ed339a427000001b9-1467267556.494446-1102040282 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004459 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-06-30 01:37:13.942583) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 01:37:13.942939) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-06-30 01:37:13.943465) ========= ========= Total master_lag: 0.20 =========