builder: autoland_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-051 starttime: 1467707532.01 results: success (0) buildid: 20160704224909 builduid: d281385bb9344942997b165b469411d9 revision: 045e13e67ed4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:12.010846) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:12.011198) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:12.011460) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:12.086567) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:12.086825) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-05 01:32:13-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 219M=0s 2016-07-05 01:32:13 (219 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096603 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:12.210543) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:12.210859) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017737 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:12.262358) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:12.262658) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 045e13e67ed4 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/autoland --rev 045e13e67ed4 --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=5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-05 01:32:13,290 Setting DEBUG logging. 2016-07-05 01:32:13,290 attempt 1/10 2016-07-05 01:32:13,290 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/045e13e67ed4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-05 01:32:13,684 unpacking tar archive at: autoland-045e13e67ed4/testing/mozharness/ program finished with exit code 0 elapsedTime=0.745406 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:13.024618) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:13.024883) ========= script_repo_revision: 045e13e67ed4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:13.025240) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:13.025511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-05 01:32:13.040708) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-07-05 01:32:13.040990) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland'] 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=5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:32:14 INFO - MultiFileLogger online at 20160705 01:32:14 in /builds/slave/test 01:32:14 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Autoland --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland 01:32:14 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:32:14 INFO - {'append_to_log': False, 01:32:14 INFO - 'base_work_dir': '/builds/slave/test', 01:32:14 INFO - 'blob_upload_branch': 'Autoland', 01:32:14 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:32:14 INFO - 'branch': 'Autoland', 01:32:14 INFO - 'buildbot_json_path': 'buildprops.json', 01:32:14 INFO - 'config_files': ('talos/linux_config.py',), 01:32:14 INFO - 'default_actions': ('clobber', 01:32:14 INFO - 'read-buildbot-config', 01:32:14 INFO - 'download-and-extract', 01:32:14 INFO - 'populate-webroot', 01:32:14 INFO - 'create-virtualenv', 01:32:14 INFO - 'install', 01:32:14 INFO - 'run-tests'), 01:32:14 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:32:14 INFO - 'download_minidump_stackwalk': True, 01:32:14 INFO - 'download_symbols': 'ondemand', 01:32:14 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:32:14 INFO - 'tooltool.py': '/tools/tooltool.py', 01:32:14 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:32:14 INFO - '/tools/misc-python/virtualenv.py')}, 01:32:14 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:32:14 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:32:14 INFO - 'installer_path': 'installer.exe', 01:32:14 INFO - 'log_level': 'info', 01:32:14 INFO - 'log_name': 'talos', 01:32:14 INFO - 'log_to_console': True, 01:32:14 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:32:14 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:32:14 INFO - 'opt_config_files': (), 01:32:14 INFO - 'pip_index': False, 01:32:14 INFO - 'sps_profile': False, 01:32:14 INFO - 'sps_profile_interval': 0, 01:32:14 INFO - 'suite': 'dromaeojs-e10s', 01:32:14 INFO - 'system_bits': '32', 01:32:14 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:32:14 INFO - 'title': 'talos-linux64-ix-051', 01:32:14 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:32:14 INFO - 'use_talos_json': True, 01:32:14 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:32:14 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:32:14 INFO - 'work_dir': 'build'} 01:32:14 INFO - ##### 01:32:14 INFO - ##### Running clobber step. 01:32:14 INFO - ##### 01:32:14 INFO - Running pre-action listener: _resource_record_pre_action 01:32:14 INFO - Running main action method: clobber 01:32:14 INFO - rmtree: /builds/slave/test/build 01:32:14 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:32:15 INFO - Running post-action listener: _resource_record_post_action 01:32:15 INFO - ##### 01:32:15 INFO - ##### Finished clobber step (success) 01:32:15 INFO - ##### 01:32:15 INFO - ##### 01:32:15 INFO - ##### Running read-buildbot-config step. 01:32:15 INFO - ##### 01:32:15 INFO - Running pre-action listener: _resource_record_pre_action 01:32:15 INFO - Running main action method: read_buildbot_config 01:32:15 INFO - Using buildbot properties: 01:32:15 INFO - { 01:32:15 INFO - "project": "", 01:32:15 INFO - "product": "firefox", 01:32:15 INFO - "script_repo_revision": "production", 01:32:15 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs-e10s", 01:32:15 INFO - "repository": "", 01:32:15 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland pgo talos dromaeojs-e10s", 01:32:15 INFO - "buildid": "20160704224909", 01:32:15 INFO - "pgo_build": "True", 01:32:15 INFO - "basedir": "/builds/slave/test", 01:32:15 INFO - "buildnumber": 8, 01:32:15 INFO - "slavename": "talos-linux64-ix-051", 01:32:15 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 01:32:15 INFO - "platform": "ubuntu64_hw", 01:32:15 INFO - "scheduler": "tests-autoland-linux64-pgo-talos", 01:32:15 INFO - "branch": "autoland", 01:32:15 INFO - "repo_path": "integration/autoland", 01:32:15 INFO - "revision": "045e13e67ed4", 01:32:15 INFO - "stage_platform": "linux64-pgo", 01:32:15 INFO - "builduid": "d281385bb9344942997b165b469411d9", 01:32:15 INFO - "slavebuilddir": "test" 01:32:15 INFO - } 01:32:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:32:15 INFO - Running post-action listener: _resource_record_post_action 01:32:15 INFO - ##### 01:32:15 INFO - ##### Finished read-buildbot-config step (success) 01:32:15 INFO - ##### 01:32:15 INFO - ##### 01:32:15 INFO - ##### Running download-and-extract step. 01:32:15 INFO - ##### 01:32:15 INFO - Running pre-action listener: _resource_record_pre_action 01:32:15 INFO - Running main action method: download_and_extract 01:32:15 INFO - mkdir: /builds/slave/test/build/tests 01:32: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:32:15 INFO - https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:32:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/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:32:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/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:32:24 INFO - Downloaded 1361 bytes. 01:32:24 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:32:24 INFO - Using the following test package requirements: 01:32:24 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:24 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:32:24 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:32:24 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:24 INFO - u'jsshell-linux-x86_64.zip'], 01:32:24 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:32:24 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:32:24 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:32:24 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:32:24 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:32:24 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:32:24 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:32:24 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:32:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:32:24 INFO - https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:32:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:32:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/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:32:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/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:32:55 WARNING - Socket error when accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip: The read operation timed out 01:32:55 INFO - retry: attempt #1 caught exception: The read operation timed out 01:32:55 INFO - retry: Failed, sleeping 30 seconds before retrying 01:33:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/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 #2 01:33:36 INFO - Downloaded 24275547 bytes. 01:33:36 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:33:36 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:33:37 INFO - Return code: 0 01:33:37 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:33:37 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:33:37 INFO - https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:33:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:33:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:33:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/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:33:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/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:33:43 INFO - Downloaded 24275547 bytes. 01:33:43 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:33:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:33:45 INFO - Return code: 0 01:33:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:45 INFO - https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:33:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:33:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:33:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/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:33:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/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:33:46 INFO - Downloaded 14403333 bytes. 01:33:46 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:33:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:33:46 INFO - Return code: 0 01:33:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:46 INFO - https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:33:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:33:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:33:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/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:33:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/KHsuYUo8Qx20MwR6-WhDuw/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:33:48 INFO - Downloaded 60363713 bytes. 01:33:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:33:48 INFO - mkdir: /builds/slave/test/properties 01:33:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:33:48 INFO - Writing to file /builds/slave/test/properties/build_url 01:33:48 INFO - Contents: 01:33:48 INFO - build_url:https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:33:48 INFO - Running post-action listener: _resource_record_post_action 01:33:48 INFO - Running post-action listener: set_extra_try_arguments 01:33:48 INFO - ##### 01:33:48 INFO - ##### Finished download-and-extract step (success) 01:33:48 INFO - ##### 01:33:48 INFO - ##### 01:33:48 INFO - ##### Running populate-webroot step. 01:33:48 INFO - ##### 01:33:48 INFO - Running pre-action listener: _resource_record_pre_action 01:33:48 INFO - Running main action method: populate_webroot 01:33:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:33:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:33:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:33:48 INFO - '--tppagecycles', 01:33:48 INFO - '7'], 01:33:48 INFO - 'tests': ['tsvgm']}}, 01:33:48 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:33:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:33:48 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:33:48 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:33:48 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:33:48 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:33:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:48 INFO - 'talos_options': ['--disable-e10s'], 01:33:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:33:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:48 INFO - 'talos_options': ['--disable-e10s'], 01:33:48 INFO - 'tests': ['damp', 'tps']}, 01:33:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:48 INFO - 'tests': ['damp', 'tps']}, 01:33:48 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:33:48 INFO - 'tests': ['dromaeo_dom']}, 01:33:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:33:48 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:33:48 INFO - 'tests': ['basic_compositor_video']}, 01:33:48 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:33:48 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:33:48 INFO - 'tests': ['a11yr', 01:33:48 INFO - 'ts_paint', 01:33:48 INFO - 'tpaint', 01:33:48 INFO - 'sessionrestore', 01:33:48 INFO - 'sessionrestore_no_auto_restore', 01:33:48 INFO - 'tabpaint']}, 01:33:48 INFO - 'other-e10s': {'tests': ['a11yr', 01:33:48 INFO - 'ts_paint', 01:33:48 INFO - 'tpaint', 01:33:48 INFO - 'sessionrestore', 01:33:48 INFO - 'sessionrestore_no_auto_restore', 01:33:48 INFO - 'tabpaint']}, 01:33:48 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:33:48 INFO - 'ts_paint', 01:33:48 INFO - 'tpaint', 01:33:48 INFO - 'sessionrestore', 01:33:48 INFO - 'sessionrestore_no_auto_restore', 01:33:48 INFO - 'tabpaint']}, 01:33:48 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:33:48 INFO - 'ts_paint', 01:33:48 INFO - 'tpaint', 01:33:48 INFO - 'sessionrestore', 01:33:48 INFO - 'sessionrestore_no_auto_restore', 01:33:48 INFO - 'tabpaint']}, 01:33:48 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:33:48 INFO - 'tests': ['a11yr', 01:33:48 INFO - 'ts_paint', 01:33:48 INFO - 'tpaint', 01:33:48 INFO - 'sessionrestore', 01:33:48 INFO - 'sessionrestore_no_auto_restore', 01:33:48 INFO - 'tabpaint']}, 01:33:48 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:33:48 INFO - 'tests': ['a11yr', 01:33:48 INFO - 'ts_paint', 01:33:48 INFO - 'tpaint', 01:33:48 INFO - 'sessionrestore', 01:33:48 INFO - 'sessionrestore_no_auto_restore', 01:33:48 INFO - 'tabpaint']}, 01:33:48 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:33:48 INFO - 'tests': ['tsvgx', 01:33:48 INFO - 'tsvgr_opacity', 01:33:48 INFO - 'tart', 01:33:48 INFO - 'tscrollx', 01:33:48 INFO - 'cart']}, 01:33:48 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:33:48 INFO - 'tsvgr_opacity', 01:33:48 INFO - 'tart', 01:33:48 INFO - 'tscrollx', 01:33:48 INFO - 'cart']}, 01:33:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:48 INFO - 'talos_options': ['--disable-e10s'], 01:33:48 INFO - 'tests': ['tp5o']}, 01:33:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:48 INFO - 'tests': ['tp5o']}, 01:33:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:48 INFO - 'talos_options': ['--disable-e10s', 01:33:48 INFO - '--xperf_path', 01:33:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:48 INFO - 'tests': ['tp5n']}, 01:33:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:33:48 INFO - 'talos_options': ['--xperf_path', 01:33:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:33:48 INFO - 'tests': ['tp5n']}}, 01:33:48 INFO - 'talos.zip': {'path': '', 01:33:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:33:48 INFO - Running post-action listener: _resource_record_post_action 01:33:48 INFO - ##### 01:33:48 INFO - ##### Finished populate-webroot step (success) 01:33:48 INFO - ##### 01:33:48 INFO - ##### 01:33:48 INFO - ##### Running create-virtualenv step. 01:33:48 INFO - ##### 01:33:48 INFO - Running pre-action listener: _resource_record_pre_action 01:33:48 INFO - Running main action method: create_virtualenv 01:33:48 INFO - Creating virtualenv /builds/slave/test/build/venv 01:33:48 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:33:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:33:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:33:49 INFO - Using real prefix '/usr' 01:33:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:33:49 INFO - Installing distribute.............................................................................................................................................................................................done. 01:33:51 INFO - Installing pip.................done. 01:33:51 INFO - Return code: 0 01:33:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:33: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:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:51 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 0x28c8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b873b0>, '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 0x2b882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', '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:33:51 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:33:51 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:33:51 INFO - Using env: {'DISPLAY': ':0', 01:33:51 INFO - 'HOME': '/home/cltbld', 01:33:51 INFO - 'LANG': 'en_US.UTF-8', 01:33:51 INFO - 'LANGUAGE': 'en_US:en', 01:33:51 INFO - 'LOGNAME': 'cltbld', 01:33:51 INFO - 'MAIL': '/var/mail/cltbld', 01:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:51 INFO - 'MOZ_NO_REMOTE': '1', 01:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:51 INFO - 'NO_EM_RESTART': '1', 01:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:51 INFO - 'PWD': '/builds/slave/test', 01:33:51 INFO - 'SHELL': '/bin/bash', 01:33:51 INFO - 'SHLVL': '1', 01:33:51 INFO - 'TERM': 'linux', 01:33:51 INFO - 'TMOUT': '86400', 01:33:51 INFO - 'USER': 'cltbld', 01:33:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', 01:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:51 INFO - '_': '/tools/buildbot/bin/python'} 01:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:51 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:33:51 INFO - Cleaning up... 01:33:51 INFO - Return code: 0 01:33:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:33: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:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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:33:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:51 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 0x28c8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b873b0>, '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 0x2b882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', '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:33:51 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:33:51 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:33:51 INFO - Using env: {'DISPLAY': ':0', 01:33:51 INFO - 'HOME': '/home/cltbld', 01:33:51 INFO - 'LANG': 'en_US.UTF-8', 01:33:51 INFO - 'LANGUAGE': 'en_US:en', 01:33:51 INFO - 'LOGNAME': 'cltbld', 01:33:51 INFO - 'MAIL': '/var/mail/cltbld', 01:33:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:51 INFO - 'MOZ_NO_REMOTE': '1', 01:33:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:51 INFO - 'NO_EM_RESTART': '1', 01:33:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:51 INFO - 'PWD': '/builds/slave/test', 01:33:51 INFO - 'SHELL': '/bin/bash', 01:33:51 INFO - 'SHLVL': '1', 01:33:51 INFO - 'TERM': 'linux', 01:33:51 INFO - 'TMOUT': '86400', 01:33:51 INFO - 'USER': 'cltbld', 01:33:51 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', 01:33:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:51 INFO - '_': '/tools/buildbot/bin/python'} 01:33:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:51 INFO - Downloading/unpacking psutil>=3.1.1 01:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:33:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:33:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:33:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:33:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:53 INFO - Installing collected packages: psutil 01:33:53 INFO - Running setup.py install for psutil 01:33:54 INFO - building 'psutil._psutil_linux' extension 01:33:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:33:54 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:33:54 INFO - building 'psutil._psutil_posix' extension 01:33:54 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:33:54 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:33:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:33:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:33:54 INFO - Successfully installed psutil 01:33:54 INFO - Cleaning up... 01:33:54 INFO - Return code: 0 01:33:54 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:33:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b873b0>, '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 0x2b882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', '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:33:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:33:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:33:54 INFO - Using env: {'DISPLAY': ':0', 01:33:54 INFO - 'HOME': '/home/cltbld', 01:33:54 INFO - 'LANG': 'en_US.UTF-8', 01:33:54 INFO - 'LANGUAGE': 'en_US:en', 01:33:54 INFO - 'LOGNAME': 'cltbld', 01:33:54 INFO - 'MAIL': '/var/mail/cltbld', 01:33:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:54 INFO - 'MOZ_NO_REMOTE': '1', 01:33:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:54 INFO - 'NO_EM_RESTART': '1', 01:33:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:54 INFO - 'PWD': '/builds/slave/test', 01:33:54 INFO - 'SHELL': '/bin/bash', 01:33:54 INFO - 'SHLVL': '1', 01:33:54 INFO - 'TERM': 'linux', 01:33:54 INFO - 'TMOUT': '86400', 01:33:54 INFO - 'USER': 'cltbld', 01:33:54 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', 01:33:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:54 INFO - '_': '/tools/buildbot/bin/python'} 01:33:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:54 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:33:54 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:33:54 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:33:54 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:33:54 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:33:54 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:33:54 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:33:56 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:33:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:33:56 INFO - Installing collected packages: mozsystemmonitor 01:33:56 INFO - Running setup.py install for mozsystemmonitor 01:33:56 INFO - Successfully installed mozsystemmonitor 01:33:56 INFO - Cleaning up... 01:33:56 INFO - Return code: 0 01:33:56 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:33: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:33:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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:33:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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', '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 0x28c8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b873b0>, '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 0x2b882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', '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:33: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', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:33: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 jsonschema==2.5.1 01:33:56 INFO - Using env: {'DISPLAY': ':0', 01:33:56 INFO - 'HOME': '/home/cltbld', 01:33:56 INFO - 'LANG': 'en_US.UTF-8', 01:33:56 INFO - 'LANGUAGE': 'en_US:en', 01:33:56 INFO - 'LOGNAME': 'cltbld', 01:33:56 INFO - 'MAIL': '/var/mail/cltbld', 01:33:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:56 INFO - 'MOZ_NO_REMOTE': '1', 01:33:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:56 INFO - 'NO_EM_RESTART': '1', 01:33:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:56 INFO - 'PWD': '/builds/slave/test', 01:33:56 INFO - 'SHELL': '/bin/bash', 01:33:56 INFO - 'SHLVL': '1', 01:33:56 INFO - 'TERM': 'linux', 01:33:56 INFO - 'TMOUT': '86400', 01:33:56 INFO - 'USER': 'cltbld', 01:33:56 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', 01:33:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:56 INFO - '_': '/tools/buildbot/bin/python'} 01:33:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:56 INFO - Downloading/unpacking jsonschema==2.5.1 01:33: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:33: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:33: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:33: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:33: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:33: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:33:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:33:58 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:33:58 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:33:58 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:33:58 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:33:58 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:33:58 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:33:58 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:33:59 INFO - Downloading functools32-3.2.3-2.tar.gz 01:33:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:33:59 INFO - warning: no files found matching '*.txt' 01:33:59 INFO - no previously-included directories found matching 'build' 01:33:59 INFO - no previously-included directories found matching 'dist' 01:33:59 INFO - no previously-included directories found matching '.git*' 01:33:59 INFO - Installing collected packages: jsonschema, functools32 01:33:59 INFO - Running setup.py install for functools32 01:33:59 INFO - warning: no files found matching '*.txt' 01:33:59 INFO - no previously-included directories found matching 'build' 01:33:59 INFO - no previously-included directories found matching 'dist' 01:33:59 INFO - no previously-included directories found matching '.git*' 01:33:59 INFO - Successfully installed jsonschema functools32 01:33:59 INFO - Cleaning up... 01:33:59 INFO - Return code: 0 01:33:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:33: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:33:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:33:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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:33:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:33:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:33: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', '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 0x28c8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b873b0>, '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 0x2b882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', '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:33: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:33: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 blobuploader==1.2.4 01:33:59 INFO - Using env: {'DISPLAY': ':0', 01:33:59 INFO - 'HOME': '/home/cltbld', 01:33:59 INFO - 'LANG': 'en_US.UTF-8', 01:33:59 INFO - 'LANGUAGE': 'en_US:en', 01:33:59 INFO - 'LOGNAME': 'cltbld', 01:33:59 INFO - 'MAIL': '/var/mail/cltbld', 01:33:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:33:59 INFO - 'MOZ_NO_REMOTE': '1', 01:33:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:33:59 INFO - 'NO_EM_RESTART': '1', 01:33:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:33:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:33:59 INFO - 'PWD': '/builds/slave/test', 01:33:59 INFO - 'SHELL': '/bin/bash', 01:33:59 INFO - 'SHLVL': '1', 01:33:59 INFO - 'TERM': 'linux', 01:33:59 INFO - 'TMOUT': '86400', 01:33:59 INFO - 'USER': 'cltbld', 01:33:59 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', 01:33:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:33:59 INFO - '_': '/tools/buildbot/bin/python'} 01:33:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:33:59 INFO - Downloading/unpacking blobuploader==1.2.4 01:33: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:33: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:33: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:33: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:33: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:33: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:34:01 INFO - Downloading blobuploader-1.2.4.tar.gz 01:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:34:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:34:01 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:34:01 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:34:01 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:34:01 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:34:01 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:34:01 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:34:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:34:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:34:01 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:34:01 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:34:01 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:34:01 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:34:01 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:34:01 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:34:02 INFO - Downloading docopt-0.6.1.tar.gz 01:34:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:34:02 INFO - Installing collected packages: blobuploader, requests, docopt 01:34:02 INFO - Running setup.py install for blobuploader 01:34:02 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:34:02 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:34:02 INFO - Running setup.py install for requests 01:34:02 INFO - Running setup.py install for docopt 01:34:02 INFO - Successfully installed blobuploader requests docopt 01:34:02 INFO - Cleaning up... 01:34:02 INFO - Return code: 0 01:34:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:02 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:34:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:02 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:34:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:02 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 0x28c8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b873b0>, '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 0x2b882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', '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:34:02 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:34:02 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:34:02 INFO - Using env: {'DISPLAY': ':0', 01:34:02 INFO - 'HOME': '/home/cltbld', 01:34:02 INFO - 'LANG': 'en_US.UTF-8', 01:34:02 INFO - 'LANGUAGE': 'en_US:en', 01:34:02 INFO - 'LOGNAME': 'cltbld', 01:34:02 INFO - 'MAIL': '/var/mail/cltbld', 01:34:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:02 INFO - 'MOZ_NO_REMOTE': '1', 01:34:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:02 INFO - 'NO_EM_RESTART': '1', 01:34:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:02 INFO - 'PWD': '/builds/slave/test', 01:34:02 INFO - 'SHELL': '/bin/bash', 01:34:02 INFO - 'SHLVL': '1', 01:34:02 INFO - 'TERM': 'linux', 01:34:02 INFO - 'TMOUT': '86400', 01:34:02 INFO - 'USER': 'cltbld', 01:34:02 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', 01:34:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:02 INFO - '_': '/tools/buildbot/bin/python'} 01:34:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:34:02 INFO - Running setup.py (path:/tmp/pip-6f_MDd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:34:03 INFO - Running setup.py (path:/tmp/pip-Rrp92q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:34:03 INFO - Running setup.py (path:/tmp/pip-UF9pmH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:34:03 INFO - Running setup.py (path:/tmp/pip-zdDlrQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:34:03 INFO - Running setup.py (path:/tmp/pip-6sjouh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:34:03 INFO - Running setup.py (path:/tmp/pip-tmCVtl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:34:03 INFO - Running setup.py (path:/tmp/pip-y6s9E9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:34:03 INFO - Running setup.py (path:/tmp/pip-4jf5yI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:34:03 INFO - Running setup.py (path:/tmp/pip-PBFcht-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:34:03 INFO - Running setup.py (path:/tmp/pip-4F2EdF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:34:03 INFO - Running setup.py (path:/tmp/pip-qVwL9T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:34:03 INFO - Running setup.py (path:/tmp/pip-G0TiES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:34:03 INFO - Running setup.py (path:/tmp/pip-nrtmlc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:34:03 INFO - Running setup.py (path:/tmp/pip-NgfOfs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:34:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:03 INFO - Running setup.py (path:/tmp/pip-KV81ly-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:34:04 INFO - Running setup.py (path:/tmp/pip-J6nVk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:34:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:34:04 INFO - Running setup.py (path:/tmp/pip-4mhlXk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:34:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:34:04 INFO - Running setup.py install for manifestparser 01:34:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:34:04 INFO - Running setup.py install for mozcrash 01:34:04 INFO - Running setup.py install for mozdebug 01:34:04 INFO - Running setup.py install for mozdevice 01:34:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:34:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:34:04 INFO - Running setup.py install for mozfile 01:34:04 INFO - Running setup.py install for mozhttpd 01:34:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:34:04 INFO - Running setup.py install for mozinfo 01:34:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:34:04 INFO - Running setup.py install for mozInstall 01:34:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:34:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:34:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:34:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:34:04 INFO - Running setup.py install for mozleak 01:34:05 INFO - Running setup.py install for mozlog 01:34:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:34:05 INFO - Running setup.py install for moznetwork 01:34:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:34:05 INFO - Running setup.py install for mozprocess 01:34:05 INFO - Running setup.py install for mozprofile 01:34:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:34:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:34:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:34:05 INFO - Running setup.py install for mozrunner 01:34:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:34:05 INFO - Running setup.py install for mozscreenshot 01:34:05 INFO - Running setup.py install for moztest 01:34:05 INFO - Running setup.py install for mozversion 01:34:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:34:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:34:05 INFO - Cleaning up... 01:34:05 INFO - Return code: 0 01:34:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:05 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:34:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:05 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:34:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:05 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 0x28c8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b873b0>, '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 0x2b882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', '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:34:05 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:34:05 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:34:05 INFO - Using env: {'DISPLAY': ':0', 01:34:05 INFO - 'HOME': '/home/cltbld', 01:34:05 INFO - 'LANG': 'en_US.UTF-8', 01:34:05 INFO - 'LANGUAGE': 'en_US:en', 01:34:05 INFO - 'LOGNAME': 'cltbld', 01:34:05 INFO - 'MAIL': '/var/mail/cltbld', 01:34:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:05 INFO - 'MOZ_NO_REMOTE': '1', 01:34:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:05 INFO - 'NO_EM_RESTART': '1', 01:34:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:05 INFO - 'PWD': '/builds/slave/test', 01:34:05 INFO - 'SHELL': '/bin/bash', 01:34:05 INFO - 'SHLVL': '1', 01:34:05 INFO - 'TERM': 'linux', 01:34:05 INFO - 'TMOUT': '86400', 01:34:05 INFO - 'USER': 'cltbld', 01:34:05 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', 01:34:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:05 INFO - '_': '/tools/buildbot/bin/python'} 01:34:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:34:06 INFO - Running setup.py (path:/tmp/pip-0X7eeO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:34:06 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:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:34:06 INFO - Running setup.py (path:/tmp/pip-n2VsB2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:34:06 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:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:34:06 INFO - Running setup.py (path:/tmp/pip-5jG9YK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:34:06 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:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:34:06 INFO - Running setup.py (path:/tmp/pip-iv9bNf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:34:06 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:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:34:06 INFO - Running setup.py (path:/tmp/pip-36krcu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:34:06 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:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:34:06 INFO - Running setup.py (path:/tmp/pip-IQFb8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:34:06 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:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:34:06 INFO - Running setup.py (path:/tmp/pip-pZEnQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:34:06 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:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:34:06 INFO - Running setup.py (path:/tmp/pip-Jqd2zy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:34:06 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:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:34:06 INFO - Running setup.py (path:/tmp/pip-N7avS1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:34:06 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:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:34:06 INFO - Running setup.py (path:/tmp/pip-G_OYCM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:34:06 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:34:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:34:06 INFO - Running setup.py (path:/tmp/pip-7NwQ5w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:34:07 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:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:34:07 INFO - Running setup.py (path:/tmp/pip-oKFabl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:34:07 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:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:34:07 INFO - Running setup.py (path:/tmp/pip-nC8mFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:34:07 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:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:34:07 INFO - Running setup.py (path:/tmp/pip-n_AY9P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:34:07 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:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:07 INFO - Running setup.py (path:/tmp/pip-tC35pe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:34:07 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:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:34:07 INFO - Running setup.py (path:/tmp/pip-IozDJw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:34:07 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:34:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:34:07 INFO - Running setup.py (path:/tmp/pip-s7l_LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:34:07 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:34:07 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:34:07 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:34:07 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:34:07 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:34:07 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:34:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:34: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:34: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:34: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:34: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:34: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:34: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:34:09 INFO - Downloading blessings-1.6.tar.gz 01:34:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:34:09 INFO - Installing collected packages: blessings 01:34:09 INFO - Running setup.py install for blessings 01:34:09 INFO - Successfully installed blessings 01:34:09 INFO - Cleaning up... 01:34:09 INFO - Return code: 0 01:34:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:34:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:34:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:34:09 INFO - Reading from file tmpfile_stdout 01:34:09 INFO - Current package versions: 01:34:09 INFO - argparse == 1.2.1 01:34:09 INFO - blessings == 1.6 01:34:09 INFO - blobuploader == 1.2.4 01:34:09 INFO - docopt == 0.6.1 01:34:09 INFO - functools32 == 3.2.3-2 01:34:09 INFO - jsonschema == 2.5.1 01:34:09 INFO - manifestparser == 1.1 01:34:09 INFO - mozInstall == 1.12 01:34:09 INFO - mozcrash == 0.17 01:34:09 INFO - mozdebug == 0.1 01:34:09 INFO - mozdevice == 0.48 01:34:09 INFO - mozfile == 1.2 01:34:09 INFO - mozhttpd == 0.7 01:34:09 INFO - mozinfo == 0.9 01:34:09 INFO - mozleak == 0.1 01:34:09 INFO - mozlog == 3.2 01:34:09 INFO - moznetwork == 0.27 01:34:09 INFO - mozprocess == 0.22 01:34:09 INFO - mozprofile == 0.28 01:34:09 INFO - mozrunner == 6.11 01:34:09 INFO - mozscreenshot == 0.1 01:34:09 INFO - mozsystemmonitor == 0.3 01:34:09 INFO - moztest == 0.7 01:34:09 INFO - mozversion == 1.4 01:34:09 INFO - psutil == 3.1.1 01:34:09 INFO - requests == 1.2.3 01:34:09 INFO - wsgiref == 0.1.2 01:34:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:34:09 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:34:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:09 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:34:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:09 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 0x28c8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b873b0>, '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 0x2b882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', '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:34:09 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:34:09 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:34:09 INFO - Using env: {'DISPLAY': ':0', 01:34:09 INFO - 'HOME': '/home/cltbld', 01:34:09 INFO - 'LANG': 'en_US.UTF-8', 01:34:09 INFO - 'LANGUAGE': 'en_US:en', 01:34:09 INFO - 'LOGNAME': 'cltbld', 01:34:09 INFO - 'MAIL': '/var/mail/cltbld', 01:34:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:09 INFO - 'MOZ_NO_REMOTE': '1', 01:34:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:09 INFO - 'NO_EM_RESTART': '1', 01:34:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:09 INFO - 'PWD': '/builds/slave/test', 01:34:09 INFO - 'SHELL': '/bin/bash', 01:34:09 INFO - 'SHLVL': '1', 01:34:09 INFO - 'TERM': 'linux', 01:34:09 INFO - 'TMOUT': '86400', 01:34:09 INFO - 'USER': 'cltbld', 01:34:09 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', 01:34:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:09 INFO - '_': '/tools/buildbot/bin/python'} 01:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:10 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:34:10 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:34:10 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:34:10 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:34:10 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:34:10 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:34:10 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:34:10 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:34:10 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:34:10 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:34:10 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:34:10 INFO - Cleaning up... 01:34:10 INFO - Return code: 0 01:34:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:34:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:34:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:34:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:34:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:34:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x28c8030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2a2b8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b89180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b873b0>, '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 0x2b882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88740>, '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': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', '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:34:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:34:10 INFO - Using env: {'DISPLAY': ':0', 01:34:10 INFO - 'HOME': '/home/cltbld', 01:34:10 INFO - 'LANG': 'en_US.UTF-8', 01:34:10 INFO - 'LANGUAGE': 'en_US:en', 01:34:10 INFO - 'LOGNAME': 'cltbld', 01:34:10 INFO - 'MAIL': '/var/mail/cltbld', 01:34:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:10 INFO - 'MOZ_NO_REMOTE': '1', 01:34:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:10 INFO - 'NO_EM_RESTART': '1', 01:34:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:10 INFO - 'PWD': '/builds/slave/test', 01:34:10 INFO - 'SHELL': '/bin/bash', 01:34:10 INFO - 'SHLVL': '1', 01:34:10 INFO - 'TERM': 'linux', 01:34:10 INFO - 'TMOUT': '86400', 01:34:10 INFO - 'USER': 'cltbld', 01:34:10 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', 01:34:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:10 INFO - '_': '/tools/buildbot/bin/python'} 01:34:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:34:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:34:10 INFO - Cleaning up... 01:34:10 INFO - Return code: 0 01:34:10 INFO - Running post-action listener: _resource_record_post_action 01:34:10 INFO - Running post-action listener: _start_resource_monitoring 01:34:10 INFO - Starting resource monitoring. 01:34:10 INFO - ##### 01:34:10 INFO - ##### Finished create-virtualenv step (success) 01:34:10 INFO - ##### 01:34:10 INFO - ##### 01:34:10 INFO - ##### Running install step. 01:34:10 INFO - ##### 01:34:10 INFO - Running pre-action listener: _resource_record_pre_action 01:34:10 INFO - Running main action method: install 01:34:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:34:10 INFO - Reading from file tmpfile_stdout 01:34:10 INFO - Detecting whether we're running mozinstall >=1.0... 01:34:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:34:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:34:10 INFO - Reading from file tmpfile_stdout 01:34:10 INFO - Output received: 01:34:10 INFO - Usage: mozinstall [options] installer 01:34:10 INFO - Options: 01:34:10 INFO - -h, --help show this help message and exit 01:34:10 INFO - -d DEST, --destination=DEST 01:34:10 INFO - Directory to install application into. [default: 01:34:10 INFO - "/builds/slave/test"] 01:34:10 INFO - --app=APP Application being installed. [default: firefox] 01:34:10 INFO - mkdir: /builds/slave/test/build/application 01:34:10 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:34:10 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:34:27 INFO - Reading from file tmpfile_stdout 01:34:27 INFO - Output received: 01:34:27 INFO - /builds/slave/test/build/application/firefox/firefox 01:34:27 INFO - Running post-action listener: _resource_record_post_action 01:34:27 INFO - ##### 01:34:27 INFO - ##### Finished install step (success) 01:34:27 INFO - ##### 01:34:27 INFO - ##### 01:34:27 INFO - ##### Running run-tests step. 01:34:27 INFO - ##### 01:34:27 INFO - Running pre-action listener: _resource_record_pre_action 01:34:27 INFO - Running main action method: run_tests 01:34:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:34:27 INFO - Python 2.7.3 01:34:27 INFO - Return code: 0 01:34:27 INFO - grabbing minidump binary from tooltool 01:34:27 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:34:27 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 0x2b873b0>, '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 0x2b882b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2b88740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:34:27 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:34:27 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:34:27 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:34:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:34:27 INFO - Return code: 0 01:34:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:34:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:34:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:34:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:34:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:34:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 01:34:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 01:34:27 INFO - Using env: {'DISPLAY': ':0', 01:34:27 INFO - 'HOME': '/home/cltbld', 01:34:27 INFO - 'LANG': 'en_US.UTF-8', 01:34:27 INFO - 'LANGUAGE': 'en_US:en', 01:34:27 INFO - 'LOGNAME': 'cltbld', 01:34:27 INFO - 'MAIL': '/var/mail/cltbld', 01:34:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:34:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:34:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:34:27 INFO - 'MOZ_NO_REMOTE': '1', 01:34:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:34:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:34:27 INFO - 'NO_EM_RESTART': '1', 01:34:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:34:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:34:27 INFO - 'PWD': '/builds/slave/test', 01:34:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:34:27 INFO - 'SHELL': '/bin/bash', 01:34:27 INFO - 'SHLVL': '1', 01:34:27 INFO - 'TERM': 'linux', 01:34:27 INFO - 'TMOUT': '86400', 01:34:27 INFO - 'USER': 'cltbld', 01:34:27 INFO - 'XDG_SESSION_COOKIE': '5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201', 01:34:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:34:27 INFO - '_': '/tools/buildbot/bin/python'} 01:34:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 01:34:28 INFO - mozversion application_buildid: 20160704224909 01:34:28 INFO - mozversion application_changeset: 045e13e67ed43f96e9639a9fec9f8e8b45fd91ed 01:34:28 INFO - mozversion application_display_name: Nightly 01:34:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:34:28 INFO - mozversion application_name: Firefox 01:34:28 INFO - mozversion application_remotingname: firefox 01:34:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 01:34:28 INFO - mozversion application_vendor: Mozilla 01:34:28 INFO - mozversion application_version: 50.0a1 01:34:28 INFO - mozversion platform_buildid: 20160704224909 01:34:28 INFO - mozversion platform_changeset: 045e13e67ed43f96e9639a9fec9f8e8b45fd91ed 01:34:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 01:34:28 INFO - mozversion platform_version: 50.0a1 01:34:28 INFO - using testdate: 1467707668 01:34:28 INFO - actual date: 1467707668 01:34:28 INFO - starting webserver on 'localhost:51736' 01:34:28 INFO - SUITE-START | Running 2 tests 01:34:28 INFO - TEST-START | dromaeo_css 01:34:28 INFO - operating with platform_type : linux_ 01:34:28 INFO - Initialising browser for dromaeo_css test... 01:34:28 INFO - TEST-INFO | started process 16940 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPJWy2E/profile http://localhost:51736/getInfo.html) 01:34:32 INFO - PROCESS | 16940 | __metrics Screen width/height:1600/1200 01:34:32 INFO - PROCESS | 16940 | colorDepth:24 01:34:32 INFO - PROCESS | 16940 | Browser inner width/height: 1024/697 01:34:32 INFO - PROCESS | 16940 | __metrics 01:34:33 ERROR - PROCESS | 16940 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:34:33 INFO - TEST-INFO | 16940: exit 0 01:34:33 INFO - Browser initialized. 01:34:33 INFO - Running cycle 1/1 for dromaeo_css test... 01:34:33 INFO - TEST-INFO | started process 17059 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpPJWy2E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:34:45 INFO - PROCESS | 17059 | RSS: Main: 168468480 01:34:45 INFO - PROCESS | 17059 | 01:35:35 INFO - PROCESS | 17059 | 1467707735129 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:37:43 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:51736/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51736/tests/dromaeo/cssquery-ext.html) 01:37:44 INFO - PROCESS | 17059 | RSS: Main: 171872256 01:37:44 INFO - PROCESS | 17059 | 01:40:46 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:51736/tests/dromaeo/cssquery-ext.html (next: http://localhost:51736/tests/dromaeo/cssquery-jquery.html) 01:40:47 INFO - PROCESS | 17059 | RSS: Main: 169308160 01:40:47 INFO - PROCESS | 17059 | 01:43:49 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:51736/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51736/tests/dromaeo/cssquery-mootools.html) 01:43:49 INFO - PROCESS | 17059 | RSS: Main: 172199936 01:43:49 INFO - PROCESS | 17059 | 01:46:51 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:51736/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51736/tests/dromaeo/cssquery-prototype.html) 01:46:52 INFO - PROCESS | 17059 | RSS: Main: 168157184 01:46:52 INFO - PROCESS | 17059 | 01:49:54 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:51736/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51736/tests/dromaeo/cssquery-yui.html) 01:49:55 INFO - PROCESS | 17059 | RSS: Main: 169263104 01:49:55 INFO - PROCESS | 17059 | 01:52:57 INFO - PROCESS | 17059 | Cycle 1(1): loaded http://localhost:51736/tests/dromaeo/cssquery-yui.html (next: http://localhost:51736/tests/dromaeo/cssquery-dojo.html) 01:52:57 INFO - PROCESS | 17059 | RSS: Main: 170434560 01:52:57 INFO - PROCESS | 17059 | 01:52:57 INFO - PROCESS | 17059 | __start_tp_report 01:52:57 INFO - PROCESS | 17059 | _x_x_mozilla_page_load 01:52:57 INFO - PROCESS | 17059 | _x_x_mozilla_page_load_details 01:52:57 INFO - PROCESS | 17059 | |i|pagename|runs| 01:52:57 INFO - PROCESS | 17059 | |0;dojo.html;3143.1670607289066;3152.921176970577;3161.6364118126407;3178.332550164464;3208.5026820842772;5493.093639549475;5513.972430137844;5532.778688852446;5625.634333768302;5643.548516118711;5431.103867861808;5556;5595.552355811526;5615.494605485505;5620.4098569650105;4958.652894297401;5010.048090862742;5064.721440320781;5116.820911268106;5151.896962060757;760.0182736634106;4877.219644856824;4967.10592093423;5013.924791128118;5088.211327244265;4976.7013979161;5013.197888337867;5035.295058691768;5035.496450354972;5053.0399224147295;5048.924266136011;5050.090983622947;5059.114654935372;5061.240813877911;5075.873103172414;4872.561469467765;4913.975430122862;4936.481669424695;4953.20748680213;4966.553010229097;5386.730663466811;5470.206820011116;5490.917636235459;5498.697571633558;5559;5729.427057294279;5871.765129394819;5935.52515798735;5967.91048134274;5974.970125149346;5920.230370051909;6004.609700369506;6028.849278768022;6035.78874739382;6078.331383547807;5551.361593416728;5560.2493663355735;5574.442555744393;5579.69311687857;5596.356419011825;5863.442972917566;5895.056790913433;5898.911516327258;6073.817785466443;6095.207623009069;5787.652740835563;5811.506021988178;5821.854453638608;5830.970845145747;5845.006348920694;5912.438318359749;5930.762769489258;6008.759649613967;6021.7591296347655;6025.216721826222;5886.05823068307;5967.343592204854;6015.608985415934;6041.667708276087;6045.425684559959;5896.557758168155;5919.881602367928;5956.910646340309;5964.970175149097;6008.489278411296;4524.185646583646;4526.6152377047665;4529.977350113229;4530.07133537624;4569.748663823455;3975.4633124528395;3979.2837289287627;4005.0387906902715;4017.819198136091;4078.6737061035637;5684.7157642118555;5722.113072473773;5732.254806875163;5746.080627099644;5774.538036957033;6030.793841231771;6037.486813620892;6046.395360463918;6054.848628784315;6062.575619706667;5529.529989950819;5545.445455454423;5579.776808927598;5593.3847276799515;5743.8564035899435;5120.359955005624;5122.8975420492125;5122.92315615266;5125.205593133071;5165.199394093921;6109.389061093855;6113.32753397126;6126.387361263927;6132.41742034506;6132.6627035513475;5783.277090363705;5955.166276721176;5963.254593175853;5999.520038397005;6023.3374328824675;6159.164737788434;6205.844853878689;6205.906911396423;6213.37866213375;6231.657258850625;5831.825045248649;5875.676837773964;5896.815679716418;5912.231409916683;5961.582689211714;5812.883742325214;5929.940700592939;5948.13752005948;5974.40255974399;5999.250093738283;5797.30432348104;5801.448862358069;5803.361630220588;5856.12158176277;5875.177475153397;5638.126090455822;5779.884402312015;5836.678982655825;5838.2702162229725;5838.562107842014;5566.304211973504;5700.885982280248;5707.7716891325545;5709.286339207599;5737.8565535861935;5801.593888427769;5834.978878696296;5837.328707198726;5868.413158684098;5874.706264686834;5575.721213939206;5729.914051289317;5737.483626473638;5750.223719797774;5754.338251101177 01:52:57 INFO - PROCESS | 17059 | |1;ext.html;598.3179175739657;599.1701493431599;623.4887392338279;630.2972186012595;636.0046527184952;32922;42886.785566072205;42953;43139.99999999996;43334.566654333445;45375;45464;45468.31797523032;45730.31404528935;45923;8853.42452740573;9016.59425325862;9021.594028268744;9058.094190580921;9065.501397423139;8839.823203535925;8949.105089491031;8971.46171229725;8974.147455991702;8983;8959.238464730473;8966.282697384193;8968.148025937526;9032.729018129467;9040.728778136667;8877.201051905327;8877.778055548599;8925;8941.552922353889;8948.149925757043;8872.955635221848;8902.821943561092;8924.732258032269;8926.330525210635;8963.55182240892;42240.155196896194;42408;42471.1505769886;42478.57521424777;42521.149577008284;3344.5986481622117;3350.8157051362164;3443.104792753877;3455.7580969332157;3981.3828856527284;33020.33959320824;33213.833930830435;33464.83267583671;33548;34604;4351.9782401088105;4367.475902891641;4420.955790442086;4450.933236001462;4464.441944756905;360716.9999999974;364883;366836;366850;368809;32283.67716322807;61014;61262.69368653128;61369.69315153396;61425.07862382068;33925.32149357048;35241.82379088088;35466.11334716653;35632.28735425277;35842.82078589591;14716.632084197981;14731.779023314659;14783.778243326358;14886.404543818342;14939.477118301025;11520.078393728481;11549.88450115505;11557.653270401901;11572.6528204154;11593.072554195813;8289.95855020721;8310.252077313071;8343.332533397313;8403.789905252295;8409.495430274203;3158.589383380192;3199.936001280008;3203.583534140593;3205.1346136543;3264.42872497312;979.3389462113046;996.5913975270105;1012.8632634594236;1090.5256213547132;1139.3733446604335;31842.681573184436;32076.518852217236;32344.191395215308;32781.67218327834;32879.96384961842;1093.9617113400993;1108.5953626926114;1140.0765380042192;1187.7505723797926;1196.7486827766268;16898.662026759397;17004.149792510325;17063.40278090261;17119.74320385195;17306.48080557585;534959;536141;536183;540995;543267;57152;57503.42496574981;58049.41950580524;58140.12789808156;58209.41790582125;1321.9603411897658;1323.8411390633187;1326.8938484921184;1363.9863601364257;1368.4184221705734;30149.698503015567;31566.210844729067;31869.68130318667;31891.36217275688;33101.503477447375;57451;57585.712071439375;57676;57818;57880;498251;502396;505329;505331;506500;43448.34827477527;43800.56199438092;44053.55946440495;45337;45378.31932521081;48883.26675099947;49361;50010.249846253064;50115.74942125266;50564.74717626388;41741.58258417498;42891;43056.56943430651;43073.7846310779;43115;41739.791301043304;42003.36994945139;42044;42419;42741.35887961745;36021.27957440784;40756.388654170805;40767.38848917328;41146.38280425736;41571.7921410391;36163.638363616024;38170.427443588924;38309;38324.425133623576;39071.6092839068;26913.924918406425;27007.45985080327;27157.456850862476;27168;27315.317117071438 01:52:57 INFO - PROCESS | 17059 | |2;jquery.html;378.76138033039183;382.66450089188737;393.62605524751484;393.90743175353794;417.26769519493286;14291.356888939996;18676.879387236757;20360.389188324338;20385.28651497198;20593.27923522677;18599.44201673952;19200.90399548004;19321.710174347398;19358.90320548395;19371.612567748638;5608.270924779773;5644.74598643062;5747.827565173031;5748.2527271454655;5757.366689664133;5597.44025597439;5627.212190293362;5684.54523638108;5690.2033715279895;5714.799982000631;5510.6969116698565;5595.636283641571;5664.518515926151;5700.629459085167;5706.857328566798;5600.18797274397;5632.605717599769;5638.577106717013;5647.802326918538;5663.377028526858;4845.733484658343;5062.772175252086;5077.213031980049;5086.618503612207;5099.260607211933;22591.322260332217;22703.886480567493;23646.29061128169;23663.645045324334;23677.052917883266;2298.2071185440996;2381.761823817622;2480.454300053985;2924.0642994241853;3047.8628461719054;14372.928135359361;14472;14545.34545945435;14626.707465850623;14719.779203311959;1933.825955663997;1970.0642194957425;1980.2475059477451;2001.7197592336938;2168.111074459464;74249.6287518559;76724.23275767226;84402.15597844005;86340.56829715874;88039.11960880438;10362.585496580203;10510.947445262726;11004.889951100387;11024.393658348868;11186.384748838893;15077;15121.16833574142;15150.772738408932;15210.391584336723;15230.543083707507;7955.641996110189;8143.226393492609;8277.917220827836;8432.45189062709;8509.234168924702;7964.681412743541;8062;8109.270165685117;8139;8266.793330166794;4679.321498382784;4701.177293973541;4707.2468405055715;4711.764411779397;4752.3584316116885;1977.6730339866037;2004.2183548416128;2048.6722124460016;2085.373408741154;2094.6334391481732;952.7570469530364;961.5480624257422;990.5889056041806;1007.7178390050651;1021.6424251511911;19730.40808775739;19869;19952.600947980958;20015;20218.89890550538;963.5952899782109;964.7877466957258;974.9951250243703;987.9160271377013;1046.56567524478;10828.78342433147;11110.500027498781;11116.777664446667;11119.444027798578;11326.603568875214;476650;481153;502210;503952;511105;67962;71454.64272678707;101135.49432252791;101329.49335253277;102721;989.5151375825793;1008.9243306751877;1021.933574317667;1024.666983230453;1044.7179261599326;17540.122993850513;17558;17621.471355858834;17691;17984.550386240448;42910.352620026395;44223;44580;44800.55199447964;46693.76653116713;60859;63163.6841815788;63600.68199658972;63799.36200637934;64126;8471.915280847114;8517.403781735218;8555.230029297392;8620.267277281502;8646.78383040429;12664.240145591293;14247.857521424654;14301;14446.638834029234;14518.709625807636;12090.214136081127;12179.208351457128;12233.755324893631;12478.812817807559;12546.811797822857;11889.346085965355;11960.401979900797;12035.338056406981;12043.939780301393;12257.14200005991;12130.878691213327;12346.197497162655;12368;12469.189502682297;12669.493220271086;8268.958655206685;8559.914400855912;8583.87124193125;8882.911170888208;9082.545872706207;10902.967585907205;12288.016958643466;12323.876761232274;12329.383530823603;12381.566645167375 01:52:57 INFO - PROCESS | 17059 | |3;mootools.html;1496.1397196611947;1518.4685360123956;1639.5163426789095;1799.1454059321816;1809.791873934497;8017.879731804013;8633.438826476275;8726.214640682338;9284.767880802974;9304.95347523263;8735.95632021839;8927.241184499326;9023.323250756202;9073.727788166349;9090.227330676884;2325.813934885205;2383.0825132324007;2383.9284821455385;2384.940376490584;2386.164842305188;2399.8320117591775;2402.5555272274596;2418.7218469875925;2439.1950656283384;2441.3652450362856;2409.5301416223842;2410.5781488239486;2414.6740190074293;2417.395651087228;2420.7579242075826;2335.74306826249;2350.459394339303;2357.328161473989;2365.3377054424786;2385.105585405473;2339.5554844579474;2344.601417758985;2355.234548771639;2357.65813956977;2374.608189648706;9123.908760912373;9152.405093668891;9228.215601673866;9245.30660200481;9249.35254532183;5253.185756207794;5372.2210279509645;5377.784888604451;5388.272583201257;5390.811321603725;3479.234568394949;3529.4882242075014;3560.305740380627;3568.518250036238;3569.089882080079;1038.7091614347994;1060.241927022175;1068.407034096084;1095.6548687163597;1096.1450068946235;12783.424745886457;12811.295378754257;12813.93593032029;12898.613041608767;12907.354632268349;4550.158220729176;4654.627629789608;4708.105459962596;4804.519548045238;4816.95183048172;10902.836457453144;10938.343699378063;11009.779804403866;11017.173711971474;11034.448277586089;5298.152295632757;5343.7060961647485;5355.196720491957;5370.892582148335;5381.434949330264;4426.070525189746;4777.689450185796;4928.802847886116;4934.7285899275885;4940.555350018516;4074.7737894004295;4129.793510324472;4155.293600087993;4196.349565817303;4214.17823524416;1294.50161687749;1315.9276239806711;1323.0936808286162;1332.060897067565;1333.9595115809684;845.2392846438255;894.9910500895038;979.9020097990144;997.586001809241;1000.1948431512702;6236.532260080512;6299.653519056405;6301.212348456443;6364.936350636527;6473.061406096184;425.0924276669333;426.9018125831014;427.1052145754639;431.24316823973726;450.0885706444476;4363.869083927487;4378.146261478981;4390.3414487827085;4408.316710909814;4417.4036505072045;10921.290116142583;11386.146039047104;11397;11398.1451391146;11414.600488982845;10754.462276886125;11138.721531961766;11185.440727963569;11284.717882053013;11364.94317528407;8366.53984030872;8546.658133674708;8556.828863422821;8562.828743425096;8623.180797824196;6119.112728654231;6207.503399728102;6259.467945224525;6337.144485494399;6369.585976911486;10174.186065114922;10221.386716797017;10248.64129755455;10276.743081423025;10315;10135.290529663147;10563.471826408495;10601.363918164934;10851.077658399125;10931.781364372828;7381.11426628808;7797.493162944391;7975.361971042419;8025.5987200638565;8048.919510804817;8968.506732129796;8994.190522852974;9001.099890011208;9023.233025192932;9073.863892041756;7845.764627061198;8002.3198028165925;8003.6798528058225;8021.318187953856;8036.276735093636;7807.18024607408;7906.288434040964;7927.326177274997;7976.840463190588;7998.160193179632;7297.525660832029;7338.376238019828;7381.8154546136775;7386.0767404074495;7569.924300757142;5324.387695414922;5456.399796022355;5610.579206559442;5636.915446268391;5675.432456754292;5315.096433606219;5419.83740487786;5488.9725551371985;5496.835094946998;5514.531264842533 01:52:57 INFO - PROCESS | 17059 | |4;prototype.html;333.4448143840506;336.5120575166009;337.72306708499025;341.9213580876397;343.07027954243995;5697.886042279152;5756.3092428908585;5794.710264486775;5802.65184088955;5859.121131830222;5678;5687.232223649806;5702.857428564277;5711.742971566279;5733.254676892008;4140.950229636334;4294.5490723473895;4362.97818510907;4397;4410.933835992462;4360.847370342039;4391.3193455014525;4416.536263692315;4417.491988421324;4418.116376724652;4368.54130316317;4405.933910991338;4409.206342858284;4415.8233670653135;4429.977850110745;4300.655947524207;4346.826126954918;4366.912661746747;4386.122775444924;4404.647628189737;3841.7118716096124;3845.5769865315074;3855.055511399697;3859.710521710883;3879.689624830007;5596.58025648078;5605.803796867131;5615.550755939515;5616.887662246773;5623.325200975868;4834.613230941516;5045.798168073309;5048.217526283432;5051.116054690451;5091.465396133427;5993.910091348634;6015.879682406327;6054.155611186884;6062.151298818169;6062.3022754873655;4184.100418410057;4232.735486514731;4242.448481697391;4242.893927651802;4243.8090285937205;6063.605865618765;6267.905981410283;6267.99712046075;6274.654893980829;6324.462420694246;4266.914661706811;4281.7645029523055;4301.526832048472;4304.375865499485;4312.37470566766;4379.299312110047;4381.978090109529;4391.012022294958;4393.472783266028;4394.692786287224;4903.215485522371;5068.847934561969;5081.517255860687;5089.236614507853;5110.591152707774;6048.243969503812;6074.149619053248;6094.35452427842;6120.051392034242;6162.845928851725;1376.160542069357;1491.2171110167033;1514.4169494744604;1518.4533567915541;1520.277868012685;935.653808090997;946.7017889364965;959.2853324273322;989.351974456732;1004.457592899826;5740.483356497935;5747.798827041033;5771.7114144293455;5803.9419605803405;5822.650640961556;6110;6110.7555697771595;6148.815535533941;6157.876842463125;6169.321374648785;5607.831765047055;5683.346415162227;5717;5744.913826292609;5792.855178620568;3241.692039256267;3248.0418276608457;3315.287213249163;3329.966700333014;3333.949990750141;6124.785632502841;6308.495320374359;6361.840953976095;6387;6389.105525226472;6259.843503912348;6267.091271765659;6276.309605943343;6290.433860952445;6296.803607314596;6042;6274.435300822948;6344.936550634527;6351.96824015877;6379.776707815204;6034.185384972972;6059.969700151471;6127.325994140552;6132.846678833065;6138.618810767542;5984.042553191469;6037.939620603914;6047.153398524122;6059.151718759289;6102.359252278447;6003.699815009145;6201.534884883562;6290.716917738621;6304.89664308735;6313.526485513697;4228.725132866354;4270.871873843789;4275.978620106879;4276.12339470414;4278.443802305805;5915.615484993462;6143.262808463013;6148.415900489446;6164.291106522807;6172.382761723971;5802.767889284381;5804.767809287581;5819.970900145472;5884.882302354014;5924.496417804535;5919.378465261258;5924.496417804535;5931.673757943182;5932.49573786233;5932.991391463375;5701.971490142523;5777.711114444177;5799.985002624609;5949.137375080676;5963.373845746134;6060.848478788065;6076.817695469143;6127.754889804358;6144.293406258337;6158.353372895782;5699.772009119589;5984.491318237999;6003.90994135097;6024.698765061642;6030.819075427744 01:52:57 INFO - PROCESS | 17059 | |5;yui.html;740.655595148256;772.2856357868969;813.6094674556209;815.4006804998326;873.3100850328238;14133.222672753007;15208.69582608347;15505.922470387646;15646.608834779136;15696.293666784994;15284.694306113899;15353.078815271063;15461.458848940289;15483.380664773396;15652;785.5561607691665;790.2532107158723;794.4954953604474;817.1501638296165;821.5070957425527;817.8282560662238;818.0510607695074;818.6888982186761;819.3035919468464;819.3445243804962;861.4357595774746;861.7414775567336;861.9870701939444;863.115306810518;863.5897948474455;848.2196379331031;853.5305581929975;855.5636625321068;857.9227869491745;859.4456575508824;615.3262177915176;617.416541368407;619.8233503451539;620.3827191943999;620.7082671144555;14399.424023039066;14424.134551926918;14425.350859211361;14473.42106315746;14529.200893950934;14963.775543366859;15328.770068448983;15410.152441615706;15558.533244002585;15603.531894043197;12128.57549985755;12722.74554508914;12825.743485130339;12910.483580656763;13021.088523803337;3958.7030972677167;4029.5164580250557;4044.69664775143;4060.4518390017265;4100.34394496879;86936.13063869407;87791;88001.99999999936;91065.54467227688;91512;11833;12031.338276394707;12335.568255111028;12438;12462.875371246353;20351.185952561733;21974.121035158736;22245.22141725032;22248.443788905406;22342.21802236914;8776.122387761172;9259;9293.67472138472;9346.672866449777;9444.055594440639;5005.574526165244;5033.874153146127;5056.6207534434325;5143.717095559706;5166.638335316567;3651.3245049665898;3732.3841566141828;3753.7184711146774;3770.811459427018;4078.755274683469;769.3229957637355;775.8099265679945;776.3245976000916;784.2902173532962;784.8861915022289;573.9540836733051;624.3787431505681;628.9591176573599;695.704325661602;726.625787719325;10108.949455252676;10324.72855971685;10437.530311136017;10706.839397409045;10876.18428617841;695.523566357047;698.9440844732409;703.9859202815915;707.6921539130494;710.5061981922618;5031.572316353077;5120;5180.663256888291;5215.374155101412;5357.812476563302;117373;121926;122431;122874.38562807307;124788;102244.48877755713;107144.46427767967;108485.45757271163;111454;112423;61836.69081654653;95645;96722.51638741902;97168.51415742876;97654.51172744232;9958.352707074017;10304.587816487257;10496.68509944703;10538;11111.499947506984;50797;51820.481795181564;52535.73732131315;53322;55431.44568554424;75845;79773.2022679789;79840.60079699564;80214;80794;13699.726005479635;13709.45162193541;13796.862031379558;13857.168569885838;14034.719305614035;15120.39518419251;15344.693106138038;15859.365625375318;16016.119113448405;16268.674626507167;14185.148891066568;14411.639709007359;14626.341814618581;15282.694346113238;15683.529494115195;13897.861021390061;14683;14684.118952862862;14766.48317308889;15305.387784488496;13586.796198057235;13750.724985500034;13967.930160349133;14026.688650618866;14219.928900355431;11403;11641.59254426091;11805.291682499077;12344.4444999977;12779.297138657092;11157.49791259379;11840.585579504675;12495.875041249472;12646.24122552613;12691.428885699981 01:52:57 INFO - PROCESS | 17059 | __end_tp_report 01:52:57 INFO - PROCESS | 17059 | __start_cc_report 01:52:57 INFO - PROCESS | 17059 | _x_x_mozilla_cycle_collect,357 01:52:57 INFO - PROCESS | 17059 | __end_cc_report 01:52:57 INFO - PROCESS | 17059 | __startTimestamp1467708777804__endTimestamp 01:52:57 INFO - PROCESS | 17059 | 01:52:57 INFO - PROCESS | 17059 | ------- Summary: start ------- 01:52:57 INFO - PROCESS | 17059 | Number of tests: 6 01:52:57 INFO - PROCESS | 17059 | 01:52:57 INFO - PROCESS | 17059 | [#0] dojo.html Cycles:165 Average:5490.30 Median:5746.08 stddev:741.75 (12.9%) stddev-sans-first:720.81 01:52:57 INFO - PROCESS | 17059 | Values: 3143.2 3152.9 3161.6 3178.3 3208.5 5493.1 5514.0 5532.8 5625.6 5643.5 5431.1 5556.0 5595.6 5615.5 5620.4 4958.7 5010.0 5064.7 5116.8 5151.9 760.0 4877.2 4967.1 5013.9 5088.2 4976.7 5013.2 5035.3 5035.5 5053.0 5048.9 5050.1 5059.1 5061.2 5075.9 4872.6 4914.0 4936.5 4953.2 4966.6 5386.7 5470.2 5490.9 5498.7 5559.0 5729.4 5871.8 5935.5 5967.9 5975.0 5920.2 6004.6 6028.8 6035.8 6078.3 5551.4 5560.2 5574.4 5579.7 5596.4 5863.4 5895.1 5898.9 6073.8 6095.2 5787.7 5811.5 5821.9 5831.0 5845.0 5912.4 5930.8 6008.8 6021.8 6025.2 5886.1 5967.3 6015.6 6041.7 6045.4 5896.6 5919.9 5956.9 5965.0 6008.5 4524.2 4526.6 4530.0 4530.1 4569.7 3975.5 3979.3 4005.0 4017.8 4078.7 5684.7 5722.1 5732.3 5746.1 5774.5 6030.8 6037.5 6046.4 6054.8 6062.6 5529.5 5545.4 5579.8 5593.4 5743.9 5120.4 5122.9 5122.9 5125.2 5165.2 6109.4 6113.3 6126.4 6132.4 6132.7 5783.3 5955.2 5963.3 5999.5 6023.3 6159.2 6205.8 6205.9 6213.4 6231.7 5831.8 5875.7 5896.8 5912.2 5961.6 5812.9 5929.9 5948.1 5974.4 5999.3 5797.3 5801.4 5803.4 5856.1 5875.2 5638.1 5779.9 5836.7 5838.3 5838.6 5566.3 5700.9 5707.8 5709.3 5737.9 5801.6 5835.0 5837.3 5868.4 5874.7 5575.7 5729.9 5737.5 5750.2 5754.3 01:52:57 INFO - PROCESS | 17059 | 01:52:57 INFO - PROCESS | 17059 | [#1] ext.html Cycles:180 Average:62127.50 Median:42814.07 stddev:126292.04 (295.0%) stddev-sans-first:126561.83 01:52:57 INFO - PROCESS | 17059 | Values: 598.3 599.2 623.5 630.3 636.0 32922.0 42886.8 42953.0 43140.0 43334.6 45375.0 45464.0 45468.3 45730.3 45923.0 8853.4 9016.6 9021.6 9058.1 9065.5 8839.8 8949.1 8971.5 8974.1 8983.0 8959.2 8966.3 8968.1 9032.7 9040.7 8877.2 8877.8 8925.0 8941.6 8948.1 8873.0 8902.8 8924.7 8926.3 8963.6 42240.2 42408.0 42471.2 42478.6 42521.1 3344.6 3350.8 3443.1 3455.8 3981.4 33020.3 33213.8 33464.8 33548.0 34604.0 4352.0 4367.5 4421.0 4450.9 4464.4 360717.0 364883.0 366836.0 366850.0 368809.0 32283.7 61014.0 61262.7 61369.7 61425.1 33925.3 35241.8 35466.1 35632.3 35842.8 14716.6 14731.8 14783.8 14886.4 14939.5 11520.1 11549.9 11557.7 11572.7 11593.1 8290.0 8310.3 8343.3 8403.8 8409.5 3158.6 3199.9 3203.6 3205.1 3264.4 979.3 996.6 1012.9 1090.5 1139.4 31842.7 32076.5 32344.2 32781.7 32880.0 1094.0 1108.6 1140.1 1187.8 1196.7 16898.7 17004.1 17063.4 17119.7 17306.5 534959.0 536141.0 536183.0 540995.0 543267.0 57152.0 57503.4 58049.4 58140.1 58209.4 1322.0 1323.8 1326.9 1364.0 1368.4 30149.7 31566.2 31869.7 31891.4 33101.5 57451.0 57585.7 57676.0 57818.0 57880.0 498251.0 502396.0 505329.0 505331.0 506500.0 43448.3 43800.6 44053.6 45337.0 45378.3 48883.3 49361.0 50010.2 50115.7 50564.7 41741.6 42891.0 43056.6 43073.8 43115.0 41739.8 42003.4 42044.0 42419.0 42741.4 36021.3 40756.4 40767.4 41146.4 41571.8 36163.6 38170.4 38309.0 38324.4 39071.6 26913.9 27007.5 27157.5 27168.0 27315.3 01:52:57 INFO - PROCESS | 17059 | 01:52:57 INFO - PROCESS | 17059 | [#2] jquery.html Cycles:180 Average:29529.49 Median:13029.41 stddev:81645.53 (626.6%) stddev-sans-first:81845.23 01:52:57 INFO - PROCESS | 17059 | Values: 378.8 382.7 393.6 393.9 417.3 14291.4 18676.9 20360.4 20385.3 20593.3 18599.4 19200.9 19321.7 19358.9 19371.6 5608.3 5644.7 5747.8 5748.3 5757.4 5597.4 5627.2 5684.5 5690.2 5714.8 5510.7 5595.6 5664.5 5700.6 5706.9 5600.2 5632.6 5638.6 5647.8 5663.4 4845.7 5062.8 5077.2 5086.6 5099.3 22591.3 22703.9 23646.3 23663.6 23677.1 2298.2 2381.8 2480.5 2924.1 3047.9 14372.9 14472.0 14545.3 14626.7 14719.8 1933.8 1970.1 1980.2 2001.7 2168.1 74249.6 76724.2 84402.2 86340.6 88039.1 10362.6 10510.9 11004.9 11024.4 11186.4 15077.0 15121.2 15150.8 15210.4 15230.5 7955.6 8143.2 8277.9 8432.5 8509.2 7964.7 8062.0 8109.3 8139.0 8266.8 4679.3 4701.2 4707.2 4711.8 4752.4 1977.7 2004.2 2048.7 2085.4 2094.6 952.8 961.5 990.6 1007.7 1021.6 19730.4 19869.0 19952.6 20015.0 20218.9 963.6 964.8 975.0 987.9 1046.6 10828.8 11110.5 11116.8 11119.4 11326.6 476650.0 481153.0 502210.0 503952.0 511105.0 67962.0 71454.6 101135.5 101329.5 102721.0 989.5 1008.9 1021.9 1024.7 1044.7 17540.1 17558.0 17621.5 17691.0 17984.6 42910.4 44223.0 44580.0 44800.6 46693.8 60859.0 63163.7 63600.7 63799.4 64126.0 8471.9 8517.4 8555.2 8620.3 8646.8 12664.2 14247.9 14301.0 14446.6 14518.7 12090.2 12179.2 12233.8 12478.8 12546.8 11889.3 11960.4 12035.3 12043.9 12257.1 12130.9 12346.2 12368.0 12469.2 12669.5 8269.0 8559.9 8583.9 8882.9 9082.5 10903.0 12288.0 12323.9 12329.4 12381.6 01:52:57 INFO - PROCESS | 17059 | 01:52:57 INFO - PROCESS | 17059 | [#3] mootools.html Cycles:180 Average:6000.35 Median:2438.08 stddev:3446.49 (141.4%) stddev-sans-first:3439.53 01:52:57 INFO - PROCESS | 17059 | Values: 1496.1 1518.5 1639.5 1799.1 1809.8 8017.9 8633.4 8726.2 9284.8 9305.0 8736.0 8927.2 9023.3 9073.7 9090.2 2325.8 2383.1 2383.9 2384.9 2386.2 2399.8 2402.6 2418.7 2439.2 2441.4 2409.5 2410.6 2414.7 2417.4 2420.8 2335.7 2350.5 2357.3 2365.3 2385.1 2339.6 2344.6 2355.2 2357.7 2374.6 9123.9 9152.4 9228.2 9245.3 9249.4 5253.2 5372.2 5377.8 5388.3 5390.8 3479.2 3529.5 3560.3 3568.5 3569.1 1038.7 1060.2 1068.4 1095.7 1096.1 12783.4 12811.3 12813.9 12898.6 12907.4 4550.2 4654.6 4708.1 4804.5 4817.0 10902.8 10938.3 11009.8 11017.2 11034.4 5298.2 5343.7 5355.2 5370.9 5381.4 4426.1 4777.7 4928.8 4934.7 4940.6 4074.8 4129.8 4155.3 4196.3 4214.2 1294.5 1315.9 1323.1 1332.1 1334.0 845.2 895.0 979.9 997.6 1000.2 6236.5 6299.7 6301.2 6364.9 6473.1 425.1 426.9 427.1 431.2 450.1 4363.9 4378.1 4390.3 4408.3 4417.4 10921.3 11386.1 11397.0 11398.1 11414.6 10754.5 11138.7 11185.4 11284.7 11364.9 8366.5 8546.7 8556.8 8562.8 8623.2 6119.1 6207.5 6259.5 6337.1 6369.6 10174.2 10221.4 10248.6 10276.7 10315.0 10135.3 10563.5 10601.4 10851.1 10931.8 7381.1 7797.5 7975.4 8025.6 8048.9 8968.5 8994.2 9001.1 9023.2 9073.9 7845.8 8002.3 8003.7 8021.3 8036.3 7807.2 7906.3 7927.3 7976.8 7998.2 7297.5 7338.4 7381.8 7386.1 7569.9 5324.4 5456.4 5610.6 5636.9 5675.4 5315.1 5419.8 5489.0 5496.8 5514.5 01:52:57 INFO - PROCESS | 17059 | 01:52:57 INFO - PROCESS | 17059 | [#4] prototype.html Cycles:180 Average:5022.05 Median:5764.01 stddev:1498.91 (26.0%) stddev-sans-first:1461.22 01:52:57 INFO - PROCESS | 17059 | Values: 333.4 336.5 337.7 341.9 343.1 5697.9 5756.3 5794.7 5802.7 5859.1 5678.0 5687.2 5702.9 5711.7 5733.3 4141.0 4294.5 4363.0 4397.0 4410.9 4360.8 4391.3 4416.5 4417.5 4418.1 4368.5 4405.9 4409.2 4415.8 4430.0 4300.7 4346.8 4366.9 4386.1 4404.6 3841.7 3845.6 3855.1 3859.7 3879.7 5596.6 5605.8 5615.6 5616.9 5623.3 4834.6 5045.8 5048.2 5051.1 5091.5 5993.9 6015.9 6054.2 6062.2 6062.3 4184.1 4232.7 4242.4 4242.9 4243.8 6063.6 6267.9 6268.0 6274.7 6324.5 4266.9 4281.8 4301.5 4304.4 4312.4 4379.3 4382.0 4391.0 4393.5 4394.7 4903.2 5068.8 5081.5 5089.2 5110.6 6048.2 6074.1 6094.4 6120.1 6162.8 1376.2 1491.2 1514.4 1518.5 1520.3 935.7 946.7 959.3 989.4 1004.5 5740.5 5747.8 5771.7 5803.9 5822.7 6110.0 6110.8 6148.8 6157.9 6169.3 5607.8 5683.3 5717.0 5744.9 5792.9 3241.7 3248.0 3315.3 3330.0 3333.9 6124.8 6308.5 6361.8 6387.0 6389.1 6259.8 6267.1 6276.3 6290.4 6296.8 6042.0 6274.4 6344.9 6352.0 6379.8 6034.2 6060.0 6127.3 6132.8 6138.6 5984.0 6037.9 6047.2 6059.2 6102.4 6003.7 6201.5 6290.7 6304.9 6313.5 4228.7 4270.9 4276.0 4276.1 4278.4 5915.6 6143.3 6148.4 6164.3 6172.4 5802.8 5804.8 5820.0 5884.9 5924.5 5919.4 5924.5 5931.7 5932.5 5933.0 5702.0 5777.7 5800.0 5949.1 5963.4 6060.8 6076.8 6127.8 6144.3 6158.4 5699.8 5984.5 6003.9 6024.7 6030.8 01:52:57 INFO - PROCESS | 17059 | 01:52:57 INFO - PROCESS | 17059 | [#5] yui.html Cycles:180 Average:22243.25 Median:3743.05 stddev:32380.48 (865.1%) stddev-sans-first:32431.06 01:52:57 INFO - PROCESS | 17059 | Values: 740.7 772.3 813.6 815.4 873.3 14133.2 15208.7 15505.9 15646.6 15696.3 15284.7 15353.1 15461.5 15483.4 15652.0 785.6 790.3 794.5 817.2 821.5 817.8 818.1 818.7 819.3 819.3 861.4 861.7 862.0 863.1 863.6 848.2 853.5 855.6 857.9 859.4 615.3 617.4 619.8 620.4 620.7 14399.4 14424.1 14425.4 14473.4 14529.2 14963.8 15328.8 15410.2 15558.5 15603.5 12128.6 12722.7 12825.7 12910.5 13021.1 3958.7 4029.5 4044.7 4060.5 4100.3 86936.1 87791.0 88002.0 91065.5 91512.0 11833.0 12031.3 12335.6 12438.0 12462.9 20351.2 21974.1 22245.2 22248.4 22342.2 8776.1 9259.0 9293.7 9346.7 9444.1 5005.6 5033.9 5056.6 5143.7 5166.6 3651.3 3732.4 3753.7 3770.8 4078.8 769.3 775.8 776.3 784.3 784.9 574.0 624.4 629.0 695.7 726.6 10108.9 10324.7 10437.5 10706.8 10876.2 695.5 698.9 704.0 707.7 710.5 5031.6 5120.0 5180.7 5215.4 5357.8 117373.0 121926.0 122431.0 122874.4 124788.0 102244.5 107144.5 108485.5 111454.0 112423.0 61836.7 95645.0 96722.5 97168.5 97654.5 9958.4 10304.6 10496.7 10538.0 11111.5 50797.0 51820.5 52535.7 53322.0 55431.4 75845.0 79773.2 79840.6 80214.0 80794.0 13699.7 13709.5 13796.9 13857.2 14034.7 15120.4 15344.7 15859.4 16016.1 16268.7 14185.1 14411.6 14626.3 15282.7 15683.5 13897.9 14683.0 14684.1 14766.5 15305.4 13586.8 13750.7 13967.9 14026.7 14219.9 11403.0 11641.6 11805.3 12344.4 12779.3 11157.5 11840.6 12495.9 12646.2 12691.4 01:52:57 INFO - PROCESS | 17059 | -------- Summary: end -------- 01:52:57 INFO - PROCESS | 17059 | 01:52:58 INFO - TEST-INFO | 17059: exit 0 01:52:58 INFO - TEST-OK | dromaeo_css | took 1110538ms 01:52:58 INFO - TEST-START | kraken 01:52:58 INFO - operating with platform_type : linux_ 01:52:58 INFO - Initialising browser for kraken test... 01:52:58 INFO - TEST-INFO | started process 17309 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgtwP9E/profile http://localhost:51736/getInfo.html) 01:53:02 INFO - PROCESS | 17309 | __metrics Screen width/height:1600/1200 01:53:02 INFO - PROCESS | 17309 | colorDepth:24 01:53:02 INFO - PROCESS | 17309 | Browser inner width/height: 1024/697 01:53:02 INFO - PROCESS | 17309 | __metrics 01:53:03 ERROR - PROCESS | 17309 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 01:53:04 INFO - TEST-INFO | 17309: exit 0 01:53:04 INFO - Browser initialized. 01:53:04 INFO - Running cycle 1/1 for kraken test... 01:53:04 INFO - TEST-INFO | started process 17428 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpgtwP9E/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:53:16 INFO - PROCESS | 17428 | RSS: Main: 169074688 01:53:16 INFO - PROCESS | 17428 | 01:53:18 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51736/tests/kraken/driver.html?testName=audio-beat-detection) 01:53:19 INFO - PROCESS | 17428 | RSS: Main: 173916160 01:53:19 INFO - PROCESS | 17428 | 01:53:22 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51736/tests/kraken/driver.html?testName=audio-dft) 01:53:22 INFO - PROCESS | 17428 | RSS: Main: 174256128 01:53:22 INFO - PROCESS | 17428 | 01:53:25 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51736/tests/kraken/driver.html?testName=audio-fft) 01:53:26 INFO - PROCESS | 17428 | RSS: Main: 168103936 01:53:26 INFO - PROCESS | 17428 | 01:53:28 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51736/tests/kraken/driver.html?testName=audio-oscillator) 01:53:28 INFO - PROCESS | 17428 | RSS: Main: 168783872 01:53:28 INFO - PROCESS | 17428 | 01:53:31 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51736/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:53:31 INFO - PROCESS | 17428 | RSS: Main: 169672704 01:53:31 INFO - PROCESS | 17428 | 01:53:34 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51736/tests/kraken/driver.html?testName=imaging-darkroom) 01:53:35 INFO - PROCESS | 17428 | RSS: Main: 169074688 01:53:35 INFO - PROCESS | 17428 | 01:53:38 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51736/tests/kraken/driver.html?testName=imaging-desaturate) 01:53:39 INFO - PROCESS | 17428 | RSS: Main: 167227392 01:53:39 INFO - PROCESS | 17428 | 01:53:42 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51736/tests/kraken/driver.html?testName=json-parse-financial) 01:53:43 INFO - PROCESS | 17428 | RSS: Main: 168386560 01:53:43 INFO - PROCESS | 17428 | 01:53:44 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51736/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:53:45 INFO - PROCESS | 17428 | RSS: Main: 168243200 01:53:45 INFO - PROCESS | 17428 | 01:53:46 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51736/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:53:47 INFO - PROCESS | 17428 | RSS: Main: 168476672 01:53:47 INFO - PROCESS | 17428 | 01:53:49 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51736/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:53:50 INFO - PROCESS | 17428 | RSS: Main: 169717760 01:53:50 INFO - PROCESS | 17428 | 01:53:52 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:53:53 INFO - PROCESS | 17428 | RSS: Main: 169984000 01:53:53 INFO - PROCESS | 17428 | 01:53:56 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:53:56 INFO - PROCESS | 17428 | RSS: Main: 169652224 01:53:56 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | Cycle 1(1): loaded http://localhost:51736/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51736/tests/kraken/driver.html?testName=ai-astar) 01:53:58 INFO - PROCESS | 17428 | RSS: Main: 170700800 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | __start_tp_report 01:53:58 INFO - PROCESS | 17428 | _x_x_mozilla_page_load 01:53:58 INFO - PROCESS | 17428 | _x_x_mozilla_page_load_details 01:53:58 INFO - PROCESS | 17428 | |i|pagename|runs| 01:53:58 INFO - PROCESS | 17428 | |0;ai-astar;105;113;109;111;112;115;112;111;112;110 01:53:58 INFO - PROCESS | 17428 | |1;audio-beat-detection;152;121;140;167;118;148;149;118;173;119 01:53:58 INFO - PROCESS | 17428 | |2;audio-dft;160;161;162;162;162;162;167;167;161;161 01:53:58 INFO - PROCESS | 17428 | |3;audio-fft;75;75;76;155;76;74;75;75;173;75 01:53:58 INFO - PROCESS | 17428 | |4;audio-oscillator;85;83;142;84;84;85;139;84;84;150 01:53:58 INFO - PROCESS | 17428 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;120;117 01:53:58 INFO - PROCESS | 17428 | |6;imaging-darkroom;146;147;147;147;147;148;147;148;146;147 01:53:58 INFO - PROCESS | 17428 | |7;imaging-desaturate;96;96;97;96;96;97;96;96;95;95 01:53:58 INFO - PROCESS | 17428 | |8;json-parse-financial;53;53;58;53;55;53;54;54;54;54 01:53:58 INFO - PROCESS | 17428 | |9;json-stringify-tinderbox;61;60;60;60;61;61;61;61;63;60 01:53:58 INFO - PROCESS | 17428 | |10;stanford-crypto-aes;79;75;75;75;75;75;76;76;80;80 01:53:58 INFO - PROCESS | 17428 | |11;stanford-crypto-ccm;122;126;120;119;134;123;122;129;162;126 01:53:58 INFO - PROCESS | 17428 | |12;stanford-crypto-pbkdf2;158;157;160;160;158;159;158;158;159;155 01:53:58 INFO - PROCESS | 17428 | |13;stanford-crypto-sha256-iterative;62;65;72;62;63;69;67;62;65;63 01:53:58 INFO - PROCESS | 17428 | __end_tp_report 01:53:58 INFO - PROCESS | 17428 | __start_cc_report 01:53:58 INFO - PROCESS | 17428 | _x_x_mozilla_cycle_collect,898 01:53:58 INFO - PROCESS | 17428 | __end_cc_report 01:53:58 INFO - PROCESS | 17428 | __startTimestamp1467708838792__endTimestamp 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | ------- Summary: start ------- 01:53:58 INFO - PROCESS | 17428 | Number of tests: 14 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#0] ai-astar Cycles:10 Average:111.00 Median:112.00 stddev:2.67 (2.4%) stddev-sans-first:1.73 01:53:58 INFO - PROCESS | 17428 | Values: 105.0 113.0 109.0 111.0 112.0 115.0 112.0 111.0 112.0 110.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#1] audio-beat-detection Cycles:10 Average:140.50 Median:148.50 stddev:20.75 (14.0%) stddev-sans-first:21.59 01:53:58 INFO - PROCESS | 17428 | Values: 152.0 121.0 140.0 167.0 118.0 148.0 149.0 118.0 173.0 119.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#2] audio-dft Cycles:10 Average:162.50 Median:162.00 stddev:2.46 (1.5%) stddev-sans-first:2.44 01:53:58 INFO - PROCESS | 17428 | Values: 160.0 161.0 162.0 162.0 162.0 162.0 167.0 167.0 161.0 161.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#3] audio-fft Cycles:10 Average:92.90 Median:75.00 stddev:37.72 (50.3%) stddev-sans-first:39.44 01:53:58 INFO - PROCESS | 17428 | Values: 75.0 75.0 76.0 155.0 76.0 74.0 75.0 75.0 173.0 75.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#4] audio-oscillator Cycles:10 Average:102.00 Median:84.00 stddev:28.88 (34.4%) stddev-sans-first:29.97 01:53:58 INFO - PROCESS | 17428 | Values: 85.0 83.0 142.0 84.0 84.0 85.0 139.0 84.0 84.0 150.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#5] imaging-gaussian-blur Cycles:10 Average:117.50 Median:117.00 stddev:0.97 (0.8%) stddev-sans-first:1.01 01:53:58 INFO - PROCESS | 17428 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 120.0 117.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.60 01:53:58 INFO - PROCESS | 17428 | Values: 146.0 147.0 147.0 147.0 147.0 148.0 147.0 148.0 146.0 147.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 01:53:58 INFO - PROCESS | 17428 | Values: 96.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 95.0 95.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#8] json-parse-financial Cycles:10 Average:54.10 Median:54.00 stddev:1.52 (2.8%) stddev-sans-first:1.56 01:53:58 INFO - PROCESS | 17428 | Values: 53.0 53.0 58.0 53.0 55.0 53.0 54.0 54.0 54.0 54.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#9] json-stringify-tinderbox Cycles:10 Average:60.80 Median:61.00 stddev:0.92 (1.5%) stddev-sans-first:0.97 01:53:58 INFO - PROCESS | 17428 | Values: 61.0 60.0 60.0 60.0 61.0 61.0 61.0 61.0 63.0 60.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#10] stanford-crypto-aes Cycles:10 Average:76.60 Median:76.00 stddev:2.17 (2.9%) stddev-sans-first:2.12 01:53:58 INFO - PROCESS | 17428 | Values: 79.0 75.0 75.0 75.0 75.0 75.0 76.0 76.0 80.0 80.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#11] stanford-crypto-ccm Cycles:10 Average:128.30 Median:126.00 stddev:12.66 (10.0%) stddev-sans-first:13.22 01:53:58 INFO - PROCESS | 17428 | Values: 122.0 126.0 120.0 119.0 134.0 123.0 122.0 129.0 162.0 126.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.20 Median:158.50 stddev:1.48 (0.9%) stddev-sans-first:1.56 01:53:58 INFO - PROCESS | 17428 | Values: 158.0 157.0 160.0 160.0 158.0 159.0 158.0 158.0 159.0 155.0 01:53:58 INFO - PROCESS | 17428 | 01:53:58 INFO - PROCESS | 17428 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.00 Median:65.00 stddev:3.40 (5.2%) stddev-sans-first:3.43 01:53:58 INFO - PROCESS | 17428 | Values: 62.0 65.0 72.0 62.0 63.0 69.0 67.0 62.0 65.0 63.0 01:53:58 INFO - PROCESS | 17428 | -------- Summary: end -------- 01:53:58 INFO - PROCESS | 17428 | 01:53:59 INFO - TEST-INFO | 17428: exit 0 01:53:59 INFO - TEST-OK | kraken | took 61177ms 01:53:59 INFO - SUITE-END | took 1171s 01:53:59 INFO - Completed test suite (00:19:31) 01:53:59 INFO - javascript benchmark 01:54:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7428.715773117362, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3143.1670607289066, 3152.921176970577, 3161.6364118126407, 3178.332550164464, 3208.5026820842772, 5493.093639549475, 5513.972430137844, 5532.778688852446, 5625.634333768302, 5643.548516118711, 5431.103867861808, 5556.0, 5595.552355811526, 5615.494605485505, 5620.4098569650105, 4958.652894297401, 5010.048090862742, 5064.721440320781, 5116.820911268106, 5151.896962060757, 760.0182736634106, 4877.219644856824, 4967.10592093423, 5013.924791128118, 5088.211327244265, 4976.7013979161, 5013.197888337867, 5035.295058691768, 5035.496450354972, 5053.0399224147295, 5048.924266136011, 5050.090983622947, 5059.114654935372, 5061.240813877911, 5075.873103172414, 4872.561469467765, 4913.975430122862, 4936.481669424695, 4953.20748680213, 4966.553010229097, 5386.730663466811, 5470.206820011116, 5490.917636235459, 5498.697571633558, 5559.0, 5729.427057294279, 5871.765129394819, 5935.52515798735, 5967.91048134274, 5974.970125149346, 5920.230370051909, 6004.609700369506, 6028.849278768022, 6035.78874739382, 6078.331383547807, 5551.361593416728, 5560.2493663355735, 5574.442555744393, 5579.69311687857, 5596.356419011825, 5863.442972917566, 5895.056790913433, 5898.911516327258, 6073.817785466443, 6095.207623009069, 5787.652740835563, 5811.506021988178, 5821.854453638608, 5830.970845145747, 5845.006348920694, 5912.438318359749, 5930.762769489258, 6008.759649613967, 6021.7591296347655, 6025.216721826222, 5886.05823068307, 5967.343592204854, 6015.608985415934, 6041.667708276087, 6045.425684559959, 5896.557758168155, 5919.881602367928, 5956.910646340309, 5964.970175149097, 6008.489278411296, 4524.185646583646, 4526.6152377047665, 4529.977350113229, 4530.07133537624, 4569.748663823455, 3975.4633124528395, 3979.2837289287627, 4005.0387906902715, 4017.819198136091, 4078.6737061035637, 5684.7157642118555, 5722.113072473773, 5732.254806875163, 5746.080627099644, 5774.538036957033, 6030.793841231771, 6037.486813620892, 6046.395360463918, 6054.848628784315, 6062.575619706667, 5529.529989950819, 5545.445455454423, 5579.776808927598, 5593.3847276799515, 5743.8564035899435, 5120.359955005624, 5122.8975420492125, 5122.92315615266, 5125.205593133071, 5165.199394093921, 6109.389061093855, 6113.32753397126, 6126.387361263927, 6132.41742034506, 6132.6627035513475, 5783.277090363705, 5955.166276721176, 5963.254593175853, 5999.520038397005, 6023.3374328824675, 6159.164737788434, 6205.844853878689, 6205.906911396423, 6213.37866213375, 6231.657258850625, 5831.825045248649, 5875.676837773964, 5896.815679716418, 5912.231409916683, 5961.582689211714, 5812.883742325214, 5929.940700592939, 5948.13752005948, 5974.40255974399, 5999.250093738283, 5797.30432348104, 5801.448862358069, 5803.361630220588, 5856.12158176277, 5875.177475153397, 5638.126090455822, 5779.884402312015, 5836.678982655825, 5838.2702162229725, 5838.562107842014, 5566.304211973504, 5700.885982280248, 5707.7716891325545, 5709.286339207599, 5737.8565535861935, 5801.593888427769, 5834.978878696296, 5837.328707198726, 5868.413158684098, 5874.706264686834, 5575.721213939206, 5729.914051289317, 5737.483626473638, 5750.223719797774, 5754.338251101177], "value": 5440.353588849566, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [598.3179175739657, 599.1701493431599, 623.4887392338279, 630.2972186012595, 636.0046527184952, 32922.0, 42886.785566072205, 42953.0, 43139.99999999996, 43334.566654333445, 45375.0, 45464.0, 45468.31797523032, 45730.31404528935, 45923.0, 8853.42452740573, 9016.59425325862, 9021.594028268744, 9058.094190580921, 9065.501397423139, 8839.823203535925, 8949.105089491031, 8971.46171229725, 8974.147455991702, 8983.0, 8959.238464730473, 8966.282697384193, 8968.148025937526, 9032.729018129467, 9040.728778136667, 8877.201051905327, 8877.778055548599, 8925.0, 8941.552922353889, 8948.149925757043, 8872.955635221848, 8902.821943561092, 8924.732258032269, 8926.330525210635, 8963.55182240892, 42240.155196896194, 42408.0, 42471.1505769886, 42478.57521424777, 42521.149577008284, 3344.5986481622117, 3350.8157051362164, 3443.104792753877, 3455.7580969332157, 3981.3828856527284, 33020.33959320824, 33213.833930830435, 33464.83267583671, 33548.0, 34604.0, 4351.9782401088105, 4367.475902891641, 4420.955790442086, 4450.933236001462, 4464.441944756905, 360716.9999999974, 364883.0, 366836.0, 366850.0, 368809.0, 32283.67716322807, 61014.0, 61262.69368653128, 61369.69315153396, 61425.07862382068, 33925.32149357048, 35241.82379088088, 35466.11334716653, 35632.28735425277, 35842.82078589591, 14716.632084197981, 14731.779023314659, 14783.778243326358, 14886.404543818342, 14939.477118301025, 11520.078393728481, 11549.88450115505, 11557.653270401901, 11572.6528204154, 11593.072554195813, 8289.95855020721, 8310.252077313071, 8343.332533397313, 8403.789905252295, 8409.495430274203, 3158.589383380192, 3199.936001280008, 3203.583534140593, 3205.1346136543, 3264.42872497312, 979.3389462113046, 996.5913975270105, 1012.8632634594236, 1090.5256213547132, 1139.3733446604335, 31842.681573184436, 32076.518852217236, 32344.191395215308, 32781.67218327834, 32879.96384961842, 1093.9617113400993, 1108.5953626926114, 1140.0765380042192, 1187.7505723797926, 1196.7486827766268, 16898.662026759397, 17004.149792510325, 17063.40278090261, 17119.74320385195, 17306.48080557585, 534959.0, 536141.0, 536183.0, 540995.0, 543267.0, 57152.0, 57503.42496574981, 58049.41950580524, 58140.12789808156, 58209.41790582125, 1321.9603411897658, 1323.8411390633187, 1326.8938484921184, 1363.9863601364257, 1368.4184221705734, 30149.698503015567, 31566.210844729067, 31869.68130318667, 31891.36217275688, 33101.503477447375, 57451.0, 57585.712071439375, 57676.0, 57818.0, 57880.0, 498251.0, 502396.0, 505329.0, 505331.0, 506500.0, 43448.34827477527, 43800.56199438092, 44053.55946440495, 45337.0, 45378.31932521081, 48883.26675099947, 49361.0, 50010.249846253064, 50115.74942125266, 50564.74717626388, 41741.58258417498, 42891.0, 43056.56943430651, 43073.7846310779, 43115.0, 41739.791301043304, 42003.36994945139, 42044.0, 42419.0, 42741.35887961745, 36021.27957440784, 40756.388654170805, 40767.38848917328, 41146.38280425736, 41571.7921410391, 36163.638363616024, 38170.427443588924, 38309.0, 38324.425133623576, 39071.6092839068, 26913.924918406425, 27007.45985080327, 27157.456850862476, 27168.0, 27315.317117071438], "value": 19331.955666769136, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.76138033039183, 382.66450089188737, 393.62605524751484, 393.90743175353794, 417.26769519493286, 14291.356888939996, 18676.879387236757, 20360.389188324338, 20385.28651497198, 20593.27923522677, 18599.44201673952, 19200.90399548004, 19321.710174347398, 19358.90320548395, 19371.612567748638, 5608.270924779773, 5644.74598643062, 5747.827565173031, 5748.2527271454655, 5757.366689664133, 5597.44025597439, 5627.212190293362, 5684.54523638108, 5690.2033715279895, 5714.799982000631, 5510.6969116698565, 5595.636283641571, 5664.518515926151, 5700.629459085167, 5706.857328566798, 5600.18797274397, 5632.605717599769, 5638.577106717013, 5647.802326918538, 5663.377028526858, 4845.733484658343, 5062.772175252086, 5077.213031980049, 5086.618503612207, 5099.260607211933, 22591.322260332217, 22703.886480567493, 23646.29061128169, 23663.645045324334, 23677.052917883266, 2298.2071185440996, 2381.761823817622, 2480.454300053985, 2924.0642994241853, 3047.8628461719054, 14372.928135359361, 14472.0, 14545.34545945435, 14626.707465850623, 14719.779203311959, 1933.825955663997, 1970.0642194957425, 1980.2475059477451, 2001.7197592336938, 2168.111074459464, 74249.6287518559, 76724.23275767226, 84402.15597844005, 86340.56829715874, 88039.11960880438, 10362.585496580203, 10510.947445262726, 11004.889951100387, 11024.393658348868, 11186.384748838893, 15077.0, 15121.16833574142, 15150.772738408932, 15210.391584336723, 15230.543083707507, 7955.641996110189, 8143.226393492609, 8277.917220827836, 8432.45189062709, 8509.234168924702, 7964.681412743541, 8062.0, 8109.270165685117, 8139.0, 8266.793330166794, 4679.321498382784, 4701.177293973541, 4707.2468405055715, 4711.764411779397, 4752.3584316116885, 1977.6730339866037, 2004.2183548416128, 2048.6722124460016, 2085.373408741154, 2094.6334391481732, 952.7570469530364, 961.5480624257422, 990.5889056041806, 1007.7178390050651, 1021.6424251511911, 19730.40808775739, 19869.0, 19952.600947980958, 20015.0, 20218.89890550538, 963.5952899782109, 964.7877466957258, 974.9951250243703, 987.9160271377013, 1046.56567524478, 10828.78342433147, 11110.500027498781, 11116.777664446667, 11119.444027798578, 11326.603568875214, 476650.0, 481153.0, 502210.0, 503952.0, 511105.0, 67962.0, 71454.64272678707, 101135.49432252791, 101329.49335253277, 102721.0, 989.5151375825793, 1008.9243306751877, 1021.933574317667, 1024.666983230453, 1044.7179261599326, 17540.122993850513, 17558.0, 17621.471355858834, 17691.0, 17984.550386240448, 42910.352620026395, 44223.0, 44580.0, 44800.55199447964, 46693.76653116713, 60859.0, 63163.6841815788, 63600.68199658972, 63799.36200637934, 64126.0, 8471.915280847114, 8517.403781735218, 8555.230029297392, 8620.267277281502, 8646.78383040429, 12664.240145591293, 14247.857521424654, 14301.0, 14446.638834029234, 14518.709625807636, 12090.214136081127, 12179.208351457128, 12233.755324893631, 12478.812817807559, 12546.811797822857, 11889.346085965355, 11960.401979900797, 12035.338056406981, 12043.939780301393, 12257.14200005991, 12130.878691213327, 12346.197497162655, 12368.0, 12469.189502682297, 12669.493220271086, 8268.958655206685, 8559.914400855912, 8583.87124193125, 8882.911170888208, 9082.545872706207, 10902.967585907205, 12288.016958643466, 12323.876761232274, 12329.383530823603, 12381.566645167375], "value": 9442.839032878404, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1496.1397196611947, 1518.4685360123956, 1639.5163426789095, 1799.1454059321816, 1809.791873934497, 8017.879731804013, 8633.438826476275, 8726.214640682338, 9284.767880802974, 9304.95347523263, 8735.95632021839, 8927.241184499326, 9023.323250756202, 9073.727788166349, 9090.227330676884, 2325.813934885205, 2383.0825132324007, 2383.9284821455385, 2384.940376490584, 2386.164842305188, 2399.8320117591775, 2402.5555272274596, 2418.7218469875925, 2439.1950656283384, 2441.3652450362856, 2409.5301416223842, 2410.5781488239486, 2414.6740190074293, 2417.395651087228, 2420.7579242075826, 2335.74306826249, 2350.459394339303, 2357.328161473989, 2365.3377054424786, 2385.105585405473, 2339.5554844579474, 2344.601417758985, 2355.234548771639, 2357.65813956977, 2374.608189648706, 9123.908760912373, 9152.405093668891, 9228.215601673866, 9245.30660200481, 9249.35254532183, 5253.185756207794, 5372.2210279509645, 5377.784888604451, 5388.272583201257, 5390.811321603725, 3479.234568394949, 3529.4882242075014, 3560.305740380627, 3568.518250036238, 3569.089882080079, 1038.7091614347994, 1060.241927022175, 1068.407034096084, 1095.6548687163597, 1096.1450068946235, 12783.424745886457, 12811.295378754257, 12813.93593032029, 12898.613041608767, 12907.354632268349, 4550.158220729176, 4654.627629789608, 4708.105459962596, 4804.519548045238, 4816.95183048172, 10902.836457453144, 10938.343699378063, 11009.779804403866, 11017.173711971474, 11034.448277586089, 5298.152295632757, 5343.7060961647485, 5355.196720491957, 5370.892582148335, 5381.434949330264, 4426.070525189746, 4777.689450185796, 4928.802847886116, 4934.7285899275885, 4940.555350018516, 4074.7737894004295, 4129.793510324472, 4155.293600087993, 4196.349565817303, 4214.17823524416, 1294.50161687749, 1315.9276239806711, 1323.0936808286162, 1332.060897067565, 1333.9595115809684, 845.2392846438255, 894.9910500895038, 979.9020097990144, 997.586001809241, 1000.1948431512702, 6236.532260080512, 6299.653519056405, 6301.212348456443, 6364.936350636527, 6473.061406096184, 425.0924276669333, 426.9018125831014, 427.1052145754639, 431.24316823973726, 450.0885706444476, 4363.869083927487, 4378.146261478981, 4390.3414487827085, 4408.316710909814, 4417.4036505072045, 10921.290116142583, 11386.146039047104, 11397.0, 11398.1451391146, 11414.600488982845, 10754.462276886125, 11138.721531961766, 11185.440727963569, 11284.717882053013, 11364.94317528407, 8366.53984030872, 8546.658133674708, 8556.828863422821, 8562.828743425096, 8623.180797824196, 6119.112728654231, 6207.503399728102, 6259.467945224525, 6337.144485494399, 6369.585976911486, 10174.186065114922, 10221.386716797017, 10248.64129755455, 10276.743081423025, 10315.0, 10135.290529663147, 10563.471826408495, 10601.363918164934, 10851.077658399125, 10931.781364372828, 7381.11426628808, 7797.493162944391, 7975.361971042419, 8025.5987200638565, 8048.919510804817, 8968.506732129796, 8994.190522852974, 9001.099890011208, 9023.233025192932, 9073.863892041756, 7845.764627061198, 8002.3198028165925, 8003.6798528058225, 8021.318187953856, 8036.276735093636, 7807.18024607408, 7906.288434040964, 7927.326177274997, 7976.840463190588, 7998.160193179632, 7297.525660832029, 7338.376238019828, 7381.8154546136775, 7386.0767404074495, 7569.924300757142, 5324.387695414922, 5456.399796022355, 5610.579206559442, 5636.915446268391, 5675.432456754292, 5315.096433606219, 5419.83740487786, 5488.9725551371985, 5496.835094946998, 5514.531264842533], "value": 4690.629072445796, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [333.4448143840506, 336.5120575166009, 337.72306708499025, 341.9213580876397, 343.07027954243995, 5697.886042279152, 5756.3092428908585, 5794.710264486775, 5802.65184088955, 5859.121131830222, 5678.0, 5687.232223649806, 5702.857428564277, 5711.742971566279, 5733.254676892008, 4140.950229636334, 4294.5490723473895, 4362.97818510907, 4397.0, 4410.933835992462, 4360.847370342039, 4391.3193455014525, 4416.536263692315, 4417.491988421324, 4418.116376724652, 4368.54130316317, 4405.933910991338, 4409.206342858284, 4415.8233670653135, 4429.977850110745, 4300.655947524207, 4346.826126954918, 4366.912661746747, 4386.122775444924, 4404.647628189737, 3841.7118716096124, 3845.5769865315074, 3855.055511399697, 3859.710521710883, 3879.689624830007, 5596.58025648078, 5605.803796867131, 5615.550755939515, 5616.887662246773, 5623.325200975868, 4834.613230941516, 5045.798168073309, 5048.217526283432, 5051.116054690451, 5091.465396133427, 5993.910091348634, 6015.879682406327, 6054.155611186884, 6062.151298818169, 6062.3022754873655, 4184.100418410057, 4232.735486514731, 4242.448481697391, 4242.893927651802, 4243.8090285937205, 6063.605865618765, 6267.905981410283, 6267.99712046075, 6274.654893980829, 6324.462420694246, 4266.914661706811, 4281.7645029523055, 4301.526832048472, 4304.375865499485, 4312.37470566766, 4379.299312110047, 4381.978090109529, 4391.012022294958, 4393.472783266028, 4394.692786287224, 4903.215485522371, 5068.847934561969, 5081.517255860687, 5089.236614507853, 5110.591152707774, 6048.243969503812, 6074.149619053248, 6094.35452427842, 6120.051392034242, 6162.845928851725, 1376.160542069357, 1491.2171110167033, 1514.4169494744604, 1518.4533567915541, 1520.277868012685, 935.653808090997, 946.7017889364965, 959.2853324273322, 989.351974456732, 1004.457592899826, 5740.483356497935, 5747.798827041033, 5771.7114144293455, 5803.9419605803405, 5822.650640961556, 6110.0, 6110.7555697771595, 6148.815535533941, 6157.876842463125, 6169.321374648785, 5607.831765047055, 5683.346415162227, 5717.0, 5744.913826292609, 5792.855178620568, 3241.692039256267, 3248.0418276608457, 3315.287213249163, 3329.966700333014, 3333.949990750141, 6124.785632502841, 6308.495320374359, 6361.840953976095, 6387.0, 6389.105525226472, 6259.843503912348, 6267.091271765659, 6276.309605943343, 6290.433860952445, 6296.803607314596, 6042.0, 6274.435300822948, 6344.936550634527, 6351.96824015877, 6379.776707815204, 6034.185384972972, 6059.969700151471, 6127.325994140552, 6132.846678833065, 6138.618810767542, 5984.042553191469, 6037.939620603914, 6047.153398524122, 6059.151718759289, 6102.359252278447, 6003.699815009145, 6201.534884883562, 6290.716917738621, 6304.89664308735, 6313.526485513697, 4228.725132866354, 4270.871873843789, 4275.978620106879, 4276.12339470414, 4278.443802305805, 5915.615484993462, 6143.262808463013, 6148.415900489446, 6164.291106522807, 6172.382761723971, 5802.767889284381, 5804.767809287581, 5819.970900145472, 5884.882302354014, 5924.496417804535, 5919.378465261258, 5924.496417804535, 5931.673757943182, 5932.49573786233, 5932.991391463375, 5701.971490142523, 5777.711114444177, 5799.985002624609, 5949.137375080676, 5963.373845746134, 6060.848478788065, 6076.817695469143, 6127.754889804358, 6144.293406258337, 6158.353372895782, 5699.772009119589, 5984.491318237999, 6003.90994135097, 6024.698765061642, 6030.819075427744], "value": 4534.19684877474, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [740.655595148256, 772.2856357868969, 813.6094674556209, 815.4006804998326, 873.3100850328238, 14133.222672753007, 15208.69582608347, 15505.922470387646, 15646.608834779136, 15696.293666784994, 15284.694306113899, 15353.078815271063, 15461.458848940289, 15483.380664773396, 15652.0, 785.5561607691665, 790.2532107158723, 794.4954953604474, 817.1501638296165, 821.5070957425527, 817.8282560662238, 818.0510607695074, 818.6888982186761, 819.3035919468464, 819.3445243804962, 861.4357595774746, 861.7414775567336, 861.9870701939444, 863.115306810518, 863.5897948474455, 848.2196379331031, 853.5305581929975, 855.5636625321068, 857.9227869491745, 859.4456575508824, 615.3262177915176, 617.416541368407, 619.8233503451539, 620.3827191943999, 620.7082671144555, 14399.424023039066, 14424.134551926918, 14425.350859211361, 14473.42106315746, 14529.200893950934, 14963.775543366859, 15328.770068448983, 15410.152441615706, 15558.533244002585, 15603.531894043197, 12128.57549985755, 12722.74554508914, 12825.743485130339, 12910.483580656763, 13021.088523803337, 3958.7030972677167, 4029.5164580250557, 4044.69664775143, 4060.4518390017265, 4100.34394496879, 86936.13063869407, 87791.0, 88001.99999999936, 91065.54467227688, 91512.0, 11833.0, 12031.338276394707, 12335.568255111028, 12438.0, 12462.875371246353, 20351.185952561733, 21974.121035158736, 22245.22141725032, 22248.443788905406, 22342.21802236914, 8776.122387761172, 9259.0, 9293.67472138472, 9346.672866449777, 9444.055594440639, 5005.574526165244, 5033.874153146127, 5056.6207534434325, 5143.717095559706, 5166.638335316567, 3651.3245049665898, 3732.3841566141828, 3753.7184711146774, 3770.811459427018, 4078.755274683469, 769.3229957637355, 775.8099265679945, 776.3245976000916, 784.2902173532962, 784.8861915022289, 573.9540836733051, 624.3787431505681, 628.9591176573599, 695.704325661602, 726.625787719325, 10108.949455252676, 10324.72855971685, 10437.530311136017, 10706.839397409045, 10876.18428617841, 695.523566357047, 698.9440844732409, 703.9859202815915, 707.6921539130494, 710.5061981922618, 5031.572316353077, 5120.0, 5180.663256888291, 5215.374155101412, 5357.812476563302, 117373.0, 121926.0, 122431.0, 122874.38562807307, 124788.0, 102244.48877755713, 107144.46427767967, 108485.45757271163, 111454.0, 112423.0, 61836.69081654653, 95645.0, 96722.51638741902, 97168.51415742876, 97654.51172744232, 9958.352707074017, 10304.587816487257, 10496.68509944703, 10538.0, 11111.499947506984, 50797.0, 51820.481795181564, 52535.73732131315, 53322.0, 55431.44568554424, 75845.0, 79773.2022679789, 79840.60079699564, 80214.0, 80794.0, 13699.726005479635, 13709.45162193541, 13796.862031379558, 13857.168569885838, 14034.719305614035, 15120.39518419251, 15344.693106138038, 15859.365625375318, 16016.119113448405, 16268.674626507167, 14185.148891066568, 14411.639709007359, 14626.341814618581, 15282.694346113238, 15683.529494115195, 13897.861021390061, 14683.0, 14684.118952862862, 14766.48317308889, 15305.387784488496, 13586.796198057235, 13750.724985500034, 13967.930160349133, 14026.688650618866, 14219.928900355431, 11403.0, 11641.59254426091, 11805.291682499077, 12344.4444999977, 12779.297138657092, 11157.49791259379, 11840.585579504675, 12495.875041249472, 12646.24122552613, 12691.428885699981], "value": 7956.187827372743, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1512.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 109.0, 111.0, 112.0, 115.0, 112.0, 111.0, 112.0, 110.0], "value": 111.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 121.0, 140.0, 167.0, 118.0, 148.0, 149.0, 118.0, 173.0, 119.0], "value": 140.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 161.0, 162.0, 162.0, 162.0, 162.0, 167.0, 167.0, 161.0, 161.0], "value": 162.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 76.0, 155.0, 76.0, 74.0, 75.0, 75.0, 173.0, 75.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 83.0, 142.0, 84.0, 84.0, 85.0, 139.0, 84.0, 84.0, 150.0], "value": 102.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 120.0, 117.0], "value": 117.5, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 148.0, 147.0, 148.0, 146.0, 147.0], "value": 147.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 58.0, 53.0, 55.0, 53.0, 54.0, 54.0, 54.0, 54.0], "value": 54.1, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 60.0, 60.0, 60.0, 61.0, 61.0, 61.0, 61.0, 63.0, 60.0], "value": 60.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 75.0, 75.0, 75.0, 75.0, 75.0, 76.0, 76.0, 80.0, 80.0], "value": 76.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [122.0, 126.0, 120.0, 119.0, 134.0, 123.0, 122.0, 129.0, 162.0, 126.0], "value": 128.3, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 157.0, 160.0, 160.0, 158.0, 159.0, 158.0, 158.0, 159.0, 155.0], "value": 158.2, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 65.0, 72.0, 62.0, 63.0, 69.0, 67.0, 62.0, 65.0, 63.0], "value": 65.0, "unit": "score"}]}]} 01:54:00 INFO - Return code: 0 01:54:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:54:00 ERROR - # TBPL SUCCESS # 01:54:00 INFO - Running post-action listener: _resource_record_post_action 01:54:00 INFO - ##### 01:54:00 INFO - ##### Finished run-tests step (success) 01:54:00 INFO - ##### 01:54:00 INFO - Running post-run listener: _resource_record_post_run 01:54:00 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 0; Write bytes: 554655744; Read time: 0; Write time: 409720 01:54:00 INFO - TinderboxPrint: CPU usage
13.2% 01:54:00 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 01:54:00 INFO - TinderboxPrint: I/O write bytes / time
554,655,744 / 409,720 01:54:00 INFO - TinderboxPrint: CPU idle
8,229.1 (86.7%) 01:54:00 INFO - TinderboxPrint: CPU user
1,205.3 (12.7%) 01:54:00 INFO - TinderboxPrint: Swap in / out
0 / 0 01:54:00 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 256610304; Read time: 0; Write time: 213952 01:54:00 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 297840640; Read time: 0; Write time: 195768 01:54:00 INFO - Running post-run listener: _upload_blobber_files 01:54:00 INFO - Blob upload gear active. 01:54:00 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:54:00 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:54:00 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', 'Autoland', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 01:54:00 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 Autoland -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 01:54:01 INFO - (blobuploader) - INFO - Open directory for files ... 01:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 01:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 01:54:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:01 INFO - (blobuploader) - INFO - Done attempting. 01:54:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:54:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:54:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:06 INFO - (blobuploader) - INFO - Done attempting. 01:54:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 01:54:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:54:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:54:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 01:54:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:54:07 INFO - (blobuploader) - INFO - Done attempting. 01:54:07 INFO - (blobuploader) - INFO - Iteration through files over. 01:54:07 INFO - Return code: 0 01:54:07 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:54:07 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:54:07 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/27ba503ff6f65a58c13a1155b039e34e375d0b479d058ddfe99a15e3ae8a26713b0b8d1d77bb81c4ea77cb765a14e29144e38c98bcc0d6628af13d09e4a6fd46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22f3536af280b2905de95fda1a141062b62f663e73ad03e7ffdd605579a873fbd109bfdb0e85e9498b100632693fe596c14dc46875c34e1f7763466658262b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0e46d87ba7d5a907597ebdc81600cdce7188aa2c8eae7850c59fa3ccd0420b571c385a45dbe72f944e62651bf1e6b832fd02954c6923c4ef9509287ba82978e7"} 01:54:07 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:54:07 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:54:07 INFO - Contents: 01:54:07 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/27ba503ff6f65a58c13a1155b039e34e375d0b479d058ddfe99a15e3ae8a26713b0b8d1d77bb81c4ea77cb765a14e29144e38c98bcc0d6628af13d09e4a6fd46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22f3536af280b2905de95fda1a141062b62f663e73ad03e7ffdd605579a873fbd109bfdb0e85e9498b100632693fe596c14dc46875c34e1f7763466658262b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0e46d87ba7d5a907597ebdc81600cdce7188aa2c8eae7850c59fa3ccd0420b571c385a45dbe72f944e62651bf1e6b832fd02954c6923c4ef9509287ba82978e7"} 01:54:07 INFO - Running post-run listener: copy_logs_to_upload_dir 01:54:07 INFO - Copying logs to upload dir... 01:54:07 INFO - mkdir: /builds/slave/test/build/upload/logs 01:54:07 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1313.100189 ========= master_lag: 0.17 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 53 secs) (at 2016-07-05 01:54:06.309348) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 01:54:06.312370) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/27ba503ff6f65a58c13a1155b039e34e375d0b479d058ddfe99a15e3ae8a26713b0b8d1d77bb81c4ea77cb765a14e29144e38c98bcc0d6628af13d09e4a6fd46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22f3536af280b2905de95fda1a141062b62f663e73ad03e7ffdd605579a873fbd109bfdb0e85e9498b100632693fe596c14dc46875c34e1f7763466658262b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0e46d87ba7d5a907597ebdc81600cdce7188aa2c8eae7850c59fa3ccd0420b571c385a45dbe72f944e62651bf1e6b832fd02954c6923c4ef9509287ba82978e7"} build_url:https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011153 build_url: 'https://queue.taskcluster.net/v1/task/KHsuYUo8Qx20MwR6-WhDuw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/27ba503ff6f65a58c13a1155b039e34e375d0b479d058ddfe99a15e3ae8a26713b0b8d1d77bb81c4ea77cb765a14e29144e38c98bcc0d6628af13d09e4a6fd46", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/22f3536af280b2905de95fda1a141062b62f663e73ad03e7ffdd605579a873fbd109bfdb0e85e9498b100632693fe596c14dc46875c34e1f7763466658262b46", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland/sha512/0e46d87ba7d5a907597ebdc81600cdce7188aa2c8eae7850c59fa3ccd0420b571c385a45dbe72f944e62651bf1e6b832fd02954c6923c4ef9509287ba82978e7"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-05 01:54:06.336887) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:54:06.337196) ========= 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=5ac5dba3e01a12f1ff77ab15000001b1-1467702118.601962-1541694201 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004471 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-05 01:54:06.386572) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 01:54:06.386864) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-05 01:54:06.387133) ========= ========= Total master_lag: 0.30 =========