builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-001 starttime: 1468508298.19 results: success (0) buildid: 20160714064643 builduid: 123b01757d454db894ef18fc7ba6dd81 revision: 4d4c09eae59ca000cb7a8be79c516527223e306c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:18.191137) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:18.191611) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:18.191920) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:18.226455) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:18.226790) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-14 07:58:18-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 68.3M=0s 2016-07-14 07:58:18 (68.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.089159 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:18.348392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:18.349009) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019346 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:18.403148) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 07:58:18.403531) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 4d4c09eae59ca000cb7a8be79c516527223e306c --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 4d4c09eae59ca000cb7a8be79c516527223e306c --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=8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-14 07:58:18,960 truncating revision to first 12 chars 2016-07-14 07:58:18,960 Setting DEBUG logging. 2016-07-14 07:58:18,960 attempt 1/10 2016-07-14 07:58:18,960 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/4d4c09eae59c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-14 07:58:20,125 unpacking tar archive at: autoland-4d4c09eae59c/testing/mozharness/ program finished with exit code 0 elapsedTime=1.598946 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-14 07:58:20.015917) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:20.016190) ========= script_repo_revision: 4d4c09eae59ca000cb7a8be79c516527223e306c ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:20.016600) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:20.016871) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-14 07:58:20.026994) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-14 07:58:20.027335) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Autoland-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Autoland-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:58:20 INFO - MultiFileLogger online at 20160714 07:58:20 in /builds/slave/test 07:58:20 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Autoland-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Autoland-Non-PGO 07:58:20 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:58:20 INFO - {'append_to_log': False, 07:58:20 INFO - 'base_work_dir': '/builds/slave/test', 07:58:20 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 07:58:20 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:58:20 INFO - 'branch': 'Autoland-Non-PGO', 07:58:20 INFO - 'buildbot_json_path': 'buildprops.json', 07:58:20 INFO - 'config_files': ('talos/linux_config.py',), 07:58:20 INFO - 'default_actions': ('clobber', 07:58:20 INFO - 'read-buildbot-config', 07:58:20 INFO - 'download-and-extract', 07:58:20 INFO - 'populate-webroot', 07:58:20 INFO - 'create-virtualenv', 07:58:20 INFO - 'install', 07:58:20 INFO - 'run-tests'), 07:58:20 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:58:20 INFO - 'download_minidump_stackwalk': True, 07:58:20 INFO - 'download_symbols': 'ondemand', 07:58:20 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:58:20 INFO - 'tooltool.py': '/tools/tooltool.py', 07:58:20 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:58:20 INFO - '/tools/misc-python/virtualenv.py')}, 07:58:20 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:58:20 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:58:20 INFO - 'installer_path': 'installer.exe', 07:58:20 INFO - 'log_level': 'info', 07:58:20 INFO - 'log_name': 'talos', 07:58:20 INFO - 'log_to_console': True, 07:58:20 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:58:20 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:58:20 INFO - 'opt_config_files': (), 07:58:20 INFO - 'pip_index': False, 07:58:20 INFO - 'sps_profile': False, 07:58:20 INFO - 'sps_profile_interval': 0, 07:58:20 INFO - 'suite': 'dromaeojs', 07:58:20 INFO - 'system_bits': '32', 07:58:20 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:58:20 INFO - 'title': 'talos-linux64-ix-001', 07:58:20 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:58:20 INFO - 'use_talos_json': True, 07:58:20 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:58:20 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:58:20 INFO - 'work_dir': 'build'} 07:58:20 INFO - ##### 07:58:20 INFO - ##### Running clobber step. 07:58:20 INFO - ##### 07:58:20 INFO - Running pre-action listener: _resource_record_pre_action 07:58:20 INFO - Running main action method: clobber 07:58:20 INFO - rmtree: /builds/slave/test/build 07:58:20 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:58:21 INFO - Running post-action listener: _resource_record_post_action 07:58:21 INFO - ##### 07:58:21 INFO - ##### Finished clobber step (success) 07:58:21 INFO - ##### 07:58:21 INFO - ##### 07:58:21 INFO - ##### Running read-buildbot-config step. 07:58:21 INFO - ##### 07:58:21 INFO - Running pre-action listener: _resource_record_pre_action 07:58:21 INFO - Running main action method: read_buildbot_config 07:58:21 INFO - Using buildbot properties: 07:58:21 INFO - { 07:58:21 INFO - "project": "", 07:58:21 INFO - "product": "firefox", 07:58:21 INFO - "script_repo_revision": "production", 07:58:21 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 07:58:21 INFO - "repository": "", 07:58:21 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 07:58:21 INFO - "buildid": "20160714064643", 07:58:21 INFO - "pgo_build": "False", 07:58:21 INFO - "basedir": "/builds/slave/test", 07:58:21 INFO - "buildnumber": 144, 07:58:21 INFO - "slavename": "talos-linux64-ix-001", 07:58:21 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 07:58:21 INFO - "platform": "ubuntu64_hw", 07:58:21 INFO - "scheduler": "tests-autoland-linux64-talos", 07:58:21 INFO - "branch": "autoland", 07:58:21 INFO - "repo_path": "integration/autoland", 07:58:21 INFO - "revision": "4d4c09eae59ca000cb7a8be79c516527223e306c", 07:58:21 INFO - "stage_platform": "linux64", 07:58:21 INFO - "builduid": "123b01757d454db894ef18fc7ba6dd81", 07:58:21 INFO - "slavebuilddir": "test" 07:58:21 INFO - } 07:58:21 INFO - Found installer url https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 07:58:21 INFO - Running post-action listener: _resource_record_post_action 07:58:21 INFO - ##### 07:58:21 INFO - ##### Finished read-buildbot-config step (success) 07:58:21 INFO - ##### 07:58:21 INFO - ##### 07:58:21 INFO - ##### Running download-and-extract step. 07:58:21 INFO - ##### 07:58:21 INFO - Running pre-action listener: _resource_record_pre_action 07:58:21 INFO - Running main action method: download_and_extract 07:58:21 INFO - mkdir: /builds/slave/test/build/tests 07:58:21 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')]} 07:58:21 INFO - https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 07:58:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:58:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:58:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/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 07:58:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/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 07:58:29 INFO - Downloaded 1361 bytes. 07:58:29 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 07:58:29 INFO - Using the following test package requirements: 07:58:29 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:58:29 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:58:29 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 07:58:29 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:29 INFO - u'jsshell-linux-x86_64.zip'], 07:58:29 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:58:29 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 07:58:29 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:58:29 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:58:29 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:58:29 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 07:58:29 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:58:29 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:58:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:29 INFO - https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:58:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:58:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:58:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/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 07:58:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/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 07:58:36 INFO - Downloaded 22756264 bytes. 07:58: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'] 07:58: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 07:58:38 INFO - Return code: 0 07:58:38 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 07:58:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:38 INFO - https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:58:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:58:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 07:58:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/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 07:58:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/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 07:58:39 INFO - Downloaded 22756264 bytes. 07:58:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 07:58:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 07:58:40 INFO - Return code: 0 07:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:40 INFO - https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:58:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:58:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 07:58:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/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 07:58:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/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 07:58:41 INFO - Downloaded 14403317 bytes. 07:58:41 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'] 07:58:41 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 07:58:42 INFO - Return code: 0 07:58:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:42 INFO - https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:58:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/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 07:58:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ArYii_oYRoCXDVal5T-VJA/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 07:58:43 INFO - Downloaded 57045987 bytes. 07:58:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:43 INFO - mkdir: /builds/slave/test/properties 07:58:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:58:43 INFO - Writing to file /builds/slave/test/properties/build_url 07:58:43 INFO - Contents: 07:58:43 INFO - build_url:https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 07:58:44 INFO - Running post-action listener: _resource_record_post_action 07:58:44 INFO - Running post-action listener: set_extra_try_arguments 07:58:44 INFO - ##### 07:58:44 INFO - ##### Finished download-and-extract step (success) 07:58:44 INFO - ##### 07:58:44 INFO - ##### 07:58:44 INFO - ##### Running populate-webroot step. 07:58:44 INFO - ##### 07:58:44 INFO - Running pre-action listener: _resource_record_pre_action 07:58:44 INFO - Running main action method: populate_webroot 07:58:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:58:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:58:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:58:44 INFO - '--tppagecycles', 07:58:44 INFO - '7'], 07:58:44 INFO - 'tests': ['tsvgm']}}, 07:58:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:58:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:58:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:58:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:58:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:58:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:58:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:44 INFO - 'talos_options': ['--disable-e10s'], 07:58:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:58:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:44 INFO - 'talos_options': ['--disable-e10s'], 07:58:44 INFO - 'tests': ['damp', 'tps']}, 07:58:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:44 INFO - 'tests': ['damp', 'tps']}, 07:58:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:58:44 INFO - 'tests': ['dromaeo_dom']}, 07:58:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:58:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:58:44 INFO - 'tests': ['basic_compositor_video']}, 07:58:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 07:58:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:58:44 INFO - 'tests': ['a11yr', 07:58:44 INFO - 'ts_paint', 07:58:44 INFO - 'tpaint', 07:58:44 INFO - 'sessionrestore', 07:58:44 INFO - 'sessionrestore_no_auto_restore', 07:58:44 INFO - 'tabpaint']}, 07:58:44 INFO - 'other-e10s': {'tests': ['a11yr', 07:58:44 INFO - 'ts_paint', 07:58:44 INFO - 'tpaint', 07:58:44 INFO - 'sessionrestore', 07:58:44 INFO - 'sessionrestore_no_auto_restore', 07:58:44 INFO - 'tabpaint']}, 07:58:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:58:44 INFO - 'ts_paint', 07:58:44 INFO - 'tpaint', 07:58:44 INFO - 'sessionrestore', 07:58:44 INFO - 'sessionrestore_no_auto_restore', 07:58:44 INFO - 'tabpaint']}, 07:58:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:58:44 INFO - 'ts_paint', 07:58:44 INFO - 'tpaint', 07:58:44 INFO - 'sessionrestore', 07:58:44 INFO - 'sessionrestore_no_auto_restore', 07:58:44 INFO - 'tabpaint']}, 07:58:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:58:44 INFO - 'tests': ['a11yr', 07:58:44 INFO - 'ts_paint', 07:58:44 INFO - 'tpaint', 07:58:44 INFO - 'sessionrestore', 07:58:44 INFO - 'sessionrestore_no_auto_restore', 07:58:44 INFO - 'tabpaint']}, 07:58:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:58:44 INFO - 'tests': ['a11yr', 07:58:44 INFO - 'ts_paint', 07:58:44 INFO - 'tpaint', 07:58:44 INFO - 'sessionrestore', 07:58:44 INFO - 'sessionrestore_no_auto_restore', 07:58:44 INFO - 'tabpaint']}, 07:58:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:58:44 INFO - 'tests': ['tsvgx', 07:58:44 INFO - 'tsvgr_opacity', 07:58:44 INFO - 'tart', 07:58:44 INFO - 'tscrollx', 07:58:44 INFO - 'cart']}, 07:58:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:58:44 INFO - 'tsvgr_opacity', 07:58:44 INFO - 'tart', 07:58:44 INFO - 'tscrollx', 07:58:44 INFO - 'cart']}, 07:58:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:44 INFO - 'talos_options': ['--disable-e10s'], 07:58:44 INFO - 'tests': ['tp5o']}, 07:58:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:44 INFO - 'tests': ['tp5o']}, 07:58:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:44 INFO - 'talos_options': ['--disable-e10s', 07:58:44 INFO - '--xperf_path', 07:58:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:44 INFO - 'tests': ['tp5n']}, 07:58:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:58:44 INFO - 'talos_options': ['--xperf_path', 07:58:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:58:44 INFO - 'tests': ['tp5n']}}, 07:58:44 INFO - 'talos.zip': {'path': '', 07:58:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:58:44 INFO - Running post-action listener: _resource_record_post_action 07:58:44 INFO - ##### 07:58:44 INFO - ##### Finished populate-webroot step (success) 07:58:44 INFO - ##### 07:58:44 INFO - ##### 07:58:44 INFO - ##### Running create-virtualenv step. 07:58:44 INFO - ##### 07:58:44 INFO - Running pre-action listener: _resource_record_pre_action 07:58:44 INFO - Running main action method: create_virtualenv 07:58:44 INFO - Creating virtualenv /builds/slave/test/build/venv 07:58:44 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 07:58:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:58:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:58:44 INFO - Using real prefix '/usr' 07:58:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:58:44 INFO - Installing distribute.............................................................................................................................................................................................done. 07:58:46 INFO - Installing pip.................done. 07:58:46 INFO - Return code: 0 07:58:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:58: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')]} 07:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58: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')]} 07:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:46 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 0x23b6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26753b0>, '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 0x26762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', '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 07:58:46 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 07:58:46 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 07:58:46 INFO - Using env: {'DISPLAY': ':0', 07:58:46 INFO - 'HOME': '/home/cltbld', 07:58:46 INFO - 'LANG': 'en_US.UTF-8', 07:58:46 INFO - 'LANGUAGE': 'en_US:en', 07:58:46 INFO - 'LOGNAME': 'cltbld', 07:58:46 INFO - 'MAIL': '/var/mail/cltbld', 07:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:46 INFO - 'MOZ_NO_REMOTE': '1', 07:58:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:46 INFO - 'NO_EM_RESTART': '1', 07:58:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:46 INFO - 'PWD': '/builds/slave/test', 07:58:46 INFO - 'SHELL': '/bin/bash', 07:58:46 INFO - 'SHLVL': '1', 07:58:46 INFO - 'TERM': 'linux', 07:58:46 INFO - 'TMOUT': '86400', 07:58:46 INFO - 'USER': 'cltbld', 07:58:46 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', 07:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:46 INFO - '_': '/tools/buildbot/bin/python'} 07:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:47 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 07:58:47 INFO - Cleaning up... 07:58:47 INFO - Return code: 0 07:58:47 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:58:47 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')]} 07:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:47 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')]} 07:58:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:47 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 0x23b6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26753b0>, '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 0x26762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', '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 07:58:47 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 07:58:47 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 07:58:47 INFO - Using env: {'DISPLAY': ':0', 07:58:47 INFO - 'HOME': '/home/cltbld', 07:58:47 INFO - 'LANG': 'en_US.UTF-8', 07:58:47 INFO - 'LANGUAGE': 'en_US:en', 07:58:47 INFO - 'LOGNAME': 'cltbld', 07:58:47 INFO - 'MAIL': '/var/mail/cltbld', 07:58:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:47 INFO - 'MOZ_NO_REMOTE': '1', 07:58:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:47 INFO - 'NO_EM_RESTART': '1', 07:58:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:47 INFO - 'PWD': '/builds/slave/test', 07:58:47 INFO - 'SHELL': '/bin/bash', 07:58:47 INFO - 'SHLVL': '1', 07:58:47 INFO - 'TERM': 'linux', 07:58:47 INFO - 'TMOUT': '86400', 07:58:47 INFO - 'USER': 'cltbld', 07:58:47 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', 07:58:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:47 INFO - '_': '/tools/buildbot/bin/python'} 07:58:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:47 INFO - Downloading/unpacking psutil>=3.1.1 07:58:47 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 07:58:47 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 07:58:47 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 07:58:47 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 07:58:47 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 07:58:47 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 07:58:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:58:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:49 INFO - Installing collected packages: psutil 07:58:49 INFO - Running setup.py install for psutil 07:58:49 INFO - building 'psutil._psutil_linux' extension 07:58:49 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 07:58:49 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 07:58:49 INFO - building 'psutil._psutil_posix' extension 07:58:49 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 07:58:49 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 07:58:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:58:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:58:49 INFO - Successfully installed psutil 07:58:49 INFO - Cleaning up... 07:58:50 INFO - Return code: 0 07:58:50 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:58:50 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')]} 07:58:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:50 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')]} 07:58:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:50 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 0x23b6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26753b0>, '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 0x26762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', '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 07:58:50 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 07:58:50 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 07:58:50 INFO - Using env: {'DISPLAY': ':0', 07:58:50 INFO - 'HOME': '/home/cltbld', 07:58:50 INFO - 'LANG': 'en_US.UTF-8', 07:58:50 INFO - 'LANGUAGE': 'en_US:en', 07:58:50 INFO - 'LOGNAME': 'cltbld', 07:58:50 INFO - 'MAIL': '/var/mail/cltbld', 07:58:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:50 INFO - 'MOZ_NO_REMOTE': '1', 07:58:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:50 INFO - 'NO_EM_RESTART': '1', 07:58:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:50 INFO - 'PWD': '/builds/slave/test', 07:58:50 INFO - 'SHELL': '/bin/bash', 07:58:50 INFO - 'SHLVL': '1', 07:58:50 INFO - 'TERM': 'linux', 07:58:50 INFO - 'TMOUT': '86400', 07:58:50 INFO - 'USER': 'cltbld', 07:58:50 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', 07:58:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:50 INFO - '_': '/tools/buildbot/bin/python'} 07:58:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:50 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:58:50 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 07:58:50 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 07:58:50 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 07:58:50 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 07:58:50 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 07:58:50 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 07:58:52 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:58:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:58:52 INFO - Installing collected packages: mozsystemmonitor 07:58:52 INFO - Running setup.py install for mozsystemmonitor 07:58:52 INFO - Successfully installed mozsystemmonitor 07:58:52 INFO - Cleaning up... 07:58:52 INFO - Return code: 0 07:58:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23b6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26753b0>, '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 0x26762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', '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 07:58:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 07:58:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 07:58:52 INFO - Using env: {'DISPLAY': ':0', 07:58:52 INFO - 'HOME': '/home/cltbld', 07:58:52 INFO - 'LANG': 'en_US.UTF-8', 07:58:52 INFO - 'LANGUAGE': 'en_US:en', 07:58:52 INFO - 'LOGNAME': 'cltbld', 07:58:52 INFO - 'MAIL': '/var/mail/cltbld', 07:58:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:52 INFO - 'MOZ_NO_REMOTE': '1', 07:58:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:52 INFO - 'NO_EM_RESTART': '1', 07:58:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:52 INFO - 'PWD': '/builds/slave/test', 07:58:52 INFO - 'SHELL': '/bin/bash', 07:58:52 INFO - 'SHLVL': '1', 07:58:52 INFO - 'TERM': 'linux', 07:58:52 INFO - 'TMOUT': '86400', 07:58:52 INFO - 'USER': 'cltbld', 07:58:52 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', 07:58:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:52 INFO - '_': '/tools/buildbot/bin/python'} 07:58:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:52 INFO - Downloading/unpacking jsonschema==2.5.1 07:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:58:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58: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 07:58:54 INFO - Downloading functools32-3.2.3-2.tar.gz 07:58:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:58:54 INFO - warning: no files found matching '*.txt' 07:58:54 INFO - no previously-included directories found matching 'build' 07:58:54 INFO - no previously-included directories found matching 'dist' 07:58:54 INFO - no previously-included directories found matching '.git*' 07:58:54 INFO - Installing collected packages: jsonschema, functools32 07:58:54 INFO - Running setup.py install for functools32 07:58:54 INFO - warning: no files found matching '*.txt' 07:58:54 INFO - no previously-included directories found matching 'build' 07:58:54 INFO - no previously-included directories found matching 'dist' 07:58:54 INFO - no previously-included directories found matching '.git*' 07:58:54 INFO - Successfully installed jsonschema functools32 07:58:54 INFO - Cleaning up... 07:58:55 INFO - Return code: 0 07:58:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:58:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x23b6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26753b0>, '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 0x26762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', '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 07:58:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 07:58:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 07:58:55 INFO - Using env: {'DISPLAY': ':0', 07:58:55 INFO - 'HOME': '/home/cltbld', 07:58:55 INFO - 'LANG': 'en_US.UTF-8', 07:58:55 INFO - 'LANGUAGE': 'en_US:en', 07:58:55 INFO - 'LOGNAME': 'cltbld', 07:58:55 INFO - 'MAIL': '/var/mail/cltbld', 07:58:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:55 INFO - 'MOZ_NO_REMOTE': '1', 07:58:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:55 INFO - 'NO_EM_RESTART': '1', 07:58:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:55 INFO - 'PWD': '/builds/slave/test', 07:58:55 INFO - 'SHELL': '/bin/bash', 07:58:55 INFO - 'SHLVL': '1', 07:58:55 INFO - 'TERM': 'linux', 07:58:55 INFO - 'TMOUT': '86400', 07:58:55 INFO - 'USER': 'cltbld', 07:58:55 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', 07:58:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:55 INFO - '_': '/tools/buildbot/bin/python'} 07:58:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:55 INFO - Downloading/unpacking blobuploader==1.2.4 07:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:57 INFO - Downloading blobuploader-1.2.4.tar.gz 07:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:58:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:58:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:58:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:58:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:58:57 INFO - Downloading docopt-0.6.1.tar.gz 07:58:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:58:57 INFO - Installing collected packages: blobuploader, requests, docopt 07:58:57 INFO - Running setup.py install for blobuploader 07:58:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:58:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:58:58 INFO - Running setup.py install for requests 07:58:58 INFO - Running setup.py install for docopt 07:58:58 INFO - Successfully installed blobuploader requests docopt 07:58:58 INFO - Cleaning up... 07:58:58 INFO - Return code: 0 07:58:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:58:58 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')]} 07:58:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:58:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:58 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')]} 07:58:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:58:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:58:58 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 0x23b6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26753b0>, '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 0x26762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', '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 07:58:58 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 07:58:58 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 07:58:58 INFO - Using env: {'DISPLAY': ':0', 07:58:58 INFO - 'HOME': '/home/cltbld', 07:58:58 INFO - 'LANG': 'en_US.UTF-8', 07:58:58 INFO - 'LANGUAGE': 'en_US:en', 07:58:58 INFO - 'LOGNAME': 'cltbld', 07:58:58 INFO - 'MAIL': '/var/mail/cltbld', 07:58:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:58 INFO - 'MOZ_NO_REMOTE': '1', 07:58:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:58:58 INFO - 'NO_EM_RESTART': '1', 07:58:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:58:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:58 INFO - 'PWD': '/builds/slave/test', 07:58:58 INFO - 'SHELL': '/bin/bash', 07:58:58 INFO - 'SHLVL': '1', 07:58:58 INFO - 'TERM': 'linux', 07:58:58 INFO - 'TMOUT': '86400', 07:58:58 INFO - 'USER': 'cltbld', 07:58:58 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', 07:58:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:58 INFO - '_': '/tools/buildbot/bin/python'} 07:58:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:58:58 INFO - Running setup.py (path:/tmp/pip-zlxOGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:58:58 INFO - Running setup.py (path:/tmp/pip-B8iZto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:58:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:58:58 INFO - Running setup.py (path:/tmp/pip-Bq4H7h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:58:59 INFO - Running setup.py (path:/tmp/pip-ZwEI9S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:58:59 INFO - Running setup.py (path:/tmp/pip-wERBnl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:58:59 INFO - Running setup.py (path:/tmp/pip-Oc_2nL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:58:59 INFO - Running setup.py (path:/tmp/pip-BqtKOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:58:59 INFO - Running setup.py (path:/tmp/pip-4dVIeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:58:59 INFO - Running setup.py (path:/tmp/pip-6za0NS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:58:59 INFO - Running setup.py (path:/tmp/pip-ellTb6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:58:59 INFO - Running setup.py (path:/tmp/pip-coCnkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:58:59 INFO - Running setup.py (path:/tmp/pip-yIVmUo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:58:59 INFO - Running setup.py (path:/tmp/pip-iNL3XB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:58:59 INFO - Running setup.py (path:/tmp/pip-PcRX3L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:59 INFO - Running setup.py (path:/tmp/pip-M4y4AO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:58:59 INFO - Running setup.py (path:/tmp/pip-ke7VVw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:58:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:58:59 INFO - Running setup.py (path:/tmp/pip-CbSoH2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:59:00 INFO - Running setup.py install for manifestparser 07:59:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:59:00 INFO - Running setup.py install for mozcrash 07:59:00 INFO - Running setup.py install for mozdebug 07:59:00 INFO - Running setup.py install for mozdevice 07:59:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:59:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:59:00 INFO - Running setup.py install for mozfile 07:59:00 INFO - Running setup.py install for mozhttpd 07:59:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:59:00 INFO - Running setup.py install for mozinfo 07:59:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:59:00 INFO - Running setup.py install for mozInstall 07:59:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:59:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:59:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:59:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:59:00 INFO - Running setup.py install for mozleak 07:59:00 INFO - Running setup.py install for mozlog 07:59:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:59:01 INFO - Running setup.py install for moznetwork 07:59:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:59:01 INFO - Running setup.py install for mozprocess 07:59:01 INFO - Running setup.py install for mozprofile 07:59:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:59:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:59:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:59:01 INFO - Running setup.py install for mozrunner 07:59:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:59:01 INFO - Running setup.py install for mozscreenshot 07:59:01 INFO - Running setup.py install for moztest 07:59:01 INFO - Running setup.py install for mozversion 07:59:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:59:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:59:01 INFO - Cleaning up... 07:59:01 INFO - Return code: 0 07:59:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:01 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 0x23b6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26753b0>, '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 0x26762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', '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 07:59:01 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 07:59:01 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 07:59:01 INFO - Using env: {'DISPLAY': ':0', 07:59:01 INFO - 'HOME': '/home/cltbld', 07:59:01 INFO - 'LANG': 'en_US.UTF-8', 07:59:01 INFO - 'LANGUAGE': 'en_US:en', 07:59:01 INFO - 'LOGNAME': 'cltbld', 07:59:01 INFO - 'MAIL': '/var/mail/cltbld', 07:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:01 INFO - 'MOZ_NO_REMOTE': '1', 07:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:01 INFO - 'NO_EM_RESTART': '1', 07:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:01 INFO - 'PWD': '/builds/slave/test', 07:59:01 INFO - 'SHELL': '/bin/bash', 07:59:01 INFO - 'SHLVL': '1', 07:59:01 INFO - 'TERM': 'linux', 07:59:01 INFO - 'TMOUT': '86400', 07:59:01 INFO - 'USER': 'cltbld', 07:59:01 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', 07:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:01 INFO - '_': '/tools/buildbot/bin/python'} 07:59:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:59:02 INFO - Running setup.py (path:/tmp/pip-H4n5M5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:59:02 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)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:59:02 INFO - Running setup.py (path:/tmp/pip-GdJAtb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:59:02 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)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:59:02 INFO - Running setup.py (path:/tmp/pip-zS4yzk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:59:02 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)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:59:02 INFO - Running setup.py (path:/tmp/pip-K1KcfO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:59:02 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)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:59:02 INFO - Running setup.py (path:/tmp/pip-9wrZzM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:59:02 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)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:59:02 INFO - Running setup.py (path:/tmp/pip-T4LdJi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:59:02 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)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:59:02 INFO - Running setup.py (path:/tmp/pip-69bdOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:59:02 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)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:59:02 INFO - Running setup.py (path:/tmp/pip-oGItqG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:59:02 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)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:59:02 INFO - Running setup.py (path:/tmp/pip-pgV9xK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:59:02 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)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:59:02 INFO - Running setup.py (path:/tmp/pip-VP7J0E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:59:02 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)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:59:02 INFO - Running setup.py (path:/tmp/pip-DSkkVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:59:02 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)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:59:02 INFO - Running setup.py (path:/tmp/pip-7X2LPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:59:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 07:59:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:59:02 INFO - Running setup.py (path:/tmp/pip-rjJ7vu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:59:03 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)) 07:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:59:03 INFO - Running setup.py (path:/tmp/pip-x7G_9c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:59:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 07:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:03 INFO - Running setup.py (path:/tmp/pip-1zmDtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:59:03 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)) 07:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:59:03 INFO - Running setup.py (path:/tmp/pip-scSbn1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:59:03 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)) 07:59:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:59:03 INFO - Running setup.py (path:/tmp/pip-uo2Nfm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:59:03 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)) 07:59:03 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)) 07:59:03 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)) 07:59:03 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)) 07:59:03 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)) 07:59:03 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)) 07:59:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:59:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:59:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:59:05 INFO - Downloading blessings-1.6.tar.gz 07:59:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:59:05 INFO - Installing collected packages: blessings 07:59:05 INFO - Running setup.py install for blessings 07:59:05 INFO - Successfully installed blessings 07:59:05 INFO - Cleaning up... 07:59:05 INFO - Return code: 0 07:59:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:59:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:05 INFO - Reading from file tmpfile_stdout 07:59:05 INFO - Current package versions: 07:59:05 INFO - argparse == 1.2.1 07:59:05 INFO - blessings == 1.6 07:59:05 INFO - blobuploader == 1.2.4 07:59:05 INFO - docopt == 0.6.1 07:59:05 INFO - functools32 == 3.2.3-2 07:59:05 INFO - jsonschema == 2.5.1 07:59:05 INFO - manifestparser == 1.1 07:59:05 INFO - mozInstall == 1.12 07:59:05 INFO - mozcrash == 0.17 07:59:05 INFO - mozdebug == 0.1 07:59:05 INFO - mozdevice == 0.48 07:59:05 INFO - mozfile == 1.2 07:59:05 INFO - mozhttpd == 0.7 07:59:05 INFO - mozinfo == 0.9 07:59:05 INFO - mozleak == 0.1 07:59:05 INFO - mozlog == 3.2 07:59:05 INFO - moznetwork == 0.27 07:59:05 INFO - mozprocess == 0.23 07:59:05 INFO - mozprofile == 0.28 07:59:05 INFO - mozrunner == 6.12 07:59:05 INFO - mozscreenshot == 0.1 07:59:05 INFO - mozsystemmonitor == 0.3 07:59:05 INFO - moztest == 0.7 07:59:05 INFO - mozversion == 1.4 07:59:05 INFO - psutil == 3.1.1 07:59:05 INFO - requests == 1.2.3 07:59:05 INFO - wsgiref == 0.1.2 07:59:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:59: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')]} 07:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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')]} 07:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:05 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 0x23b6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26753b0>, '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 0x26762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', '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 07:59:05 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 07:59:05 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 07:59:05 INFO - Using env: {'DISPLAY': ':0', 07:59:05 INFO - 'HOME': '/home/cltbld', 07:59:05 INFO - 'LANG': 'en_US.UTF-8', 07:59:05 INFO - 'LANGUAGE': 'en_US:en', 07:59:05 INFO - 'LOGNAME': 'cltbld', 07:59:05 INFO - 'MAIL': '/var/mail/cltbld', 07:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:05 INFO - 'MOZ_NO_REMOTE': '1', 07:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:05 INFO - 'NO_EM_RESTART': '1', 07:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:05 INFO - 'PWD': '/builds/slave/test', 07:59:05 INFO - 'SHELL': '/bin/bash', 07:59:05 INFO - 'SHLVL': '1', 07:59:05 INFO - 'TERM': 'linux', 07:59:05 INFO - 'TMOUT': '86400', 07:59:05 INFO - 'USER': 'cltbld', 07:59:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', 07:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:05 INFO - '_': '/tools/buildbot/bin/python'} 07:59:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:05 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)) 07:59:05 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)) 07:59:05 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)) 07:59:05 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)) 07:59:05 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)) 07:59:05 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)) 07:59:05 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)) 07:59:05 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)) 07:59:05 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)) 07:59:05 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)) 07:59:05 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)) 07:59:05 INFO - Cleaning up... 07:59:05 INFO - Return code: 0 07:59:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:59: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')]} 07:59:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:59:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59: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')]} 07:59:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:59:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:59:05 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 0x23b6030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25198a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2677180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x26753b0>, '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 0x26762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676740>, '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': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', '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 07:59:05 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 07:59:05 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 07:59:05 INFO - Using env: {'DISPLAY': ':0', 07:59:05 INFO - 'HOME': '/home/cltbld', 07:59:05 INFO - 'LANG': 'en_US.UTF-8', 07:59:05 INFO - 'LANGUAGE': 'en_US:en', 07:59:05 INFO - 'LOGNAME': 'cltbld', 07:59:05 INFO - 'MAIL': '/var/mail/cltbld', 07:59:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:05 INFO - 'MOZ_NO_REMOTE': '1', 07:59:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:05 INFO - 'NO_EM_RESTART': '1', 07:59:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:05 INFO - 'PWD': '/builds/slave/test', 07:59:05 INFO - 'SHELL': '/bin/bash', 07:59:05 INFO - 'SHLVL': '1', 07:59:05 INFO - 'TERM': 'linux', 07:59:05 INFO - 'TMOUT': '86400', 07:59:05 INFO - 'USER': 'cltbld', 07:59:05 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', 07:59:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:05 INFO - '_': '/tools/buildbot/bin/python'} 07:59:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:59:06 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:59:06 INFO - Cleaning up... 07:59:06 INFO - Return code: 0 07:59:06 INFO - Running post-action listener: _resource_record_post_action 07:59:06 INFO - Running post-action listener: _start_resource_monitoring 07:59:06 INFO - Starting resource monitoring. 07:59:06 INFO - ##### 07:59:06 INFO - ##### Finished create-virtualenv step (success) 07:59:06 INFO - ##### 07:59:06 INFO - ##### 07:59:06 INFO - ##### Running install step. 07:59:06 INFO - ##### 07:59:06 INFO - Running pre-action listener: _resource_record_pre_action 07:59:06 INFO - Running main action method: install 07:59:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:59:06 INFO - Reading from file tmpfile_stdout 07:59:06 INFO - Detecting whether we're running mozinstall >=1.0... 07:59:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:59:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:59:06 INFO - Reading from file tmpfile_stdout 07:59:06 INFO - Output received: 07:59:06 INFO - Usage: mozinstall [options] installer 07:59:06 INFO - Options: 07:59:06 INFO - -h, --help show this help message and exit 07:59:06 INFO - -d DEST, --destination=DEST 07:59:06 INFO - Directory to install application into. [default: 07:59:06 INFO - "/builds/slave/test"] 07:59:06 INFO - --app=APP Application being installed. [default: firefox] 07:59:06 INFO - mkdir: /builds/slave/test/build/application 07:59:06 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'] 07:59:06 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 07:59:22 INFO - Reading from file tmpfile_stdout 07:59:22 INFO - Output received: 07:59:22 INFO - /builds/slave/test/build/application/firefox/firefox 07:59:22 INFO - Running post-action listener: _resource_record_post_action 07:59:22 INFO - ##### 07:59:22 INFO - ##### Finished install step (success) 07:59:22 INFO - ##### 07:59:22 INFO - ##### 07:59:22 INFO - ##### Running run-tests step. 07:59:22 INFO - ##### 07:59:22 INFO - Running pre-action listener: _resource_record_pre_action 07:59:22 INFO - Running main action method: run_tests 07:59:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:59:22 INFO - Python 2.7.3 07:59:22 INFO - Return code: 0 07:59:22 INFO - grabbing minidump binary from tooltool 07:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:59:22 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 0x26753b0>, '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 0x26762b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2676740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:59:22 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 07:59:22 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 07:59:22 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 07:59:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:59:22 INFO - Return code: 0 07:59:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:59:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:59:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:59:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:59:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:59:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 07:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Autoland-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-001 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 07:59:22 INFO - Using env: {'DISPLAY': ':0', 07:59:22 INFO - 'HOME': '/home/cltbld', 07:59:22 INFO - 'LANG': 'en_US.UTF-8', 07:59:22 INFO - 'LANGUAGE': 'en_US:en', 07:59:22 INFO - 'LOGNAME': 'cltbld', 07:59:22 INFO - 'MAIL': '/var/mail/cltbld', 07:59:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:59:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:59:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:59:22 INFO - 'MOZ_NO_REMOTE': '1', 07:59:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:59:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:59:22 INFO - 'NO_EM_RESTART': '1', 07:59:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:59:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:59:22 INFO - 'PWD': '/builds/slave/test', 07:59:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:59:22 INFO - 'SHELL': '/bin/bash', 07:59:22 INFO - 'SHLVL': '1', 07:59:22 INFO - 'TERM': 'linux', 07:59:22 INFO - 'TMOUT': '86400', 07:59:22 INFO - 'USER': 'cltbld', 07:59:22 INFO - 'XDG_SESSION_COOKIE': '8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099', 07:59:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:59:22 INFO - '_': '/tools/buildbot/bin/python'} 07:59:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Autoland-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-001', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 07:59:23 INFO - mozversion application_buildid: 20160714064643 07:59:23 INFO - mozversion application_changeset: 4d4c09eae59ca000cb7a8be79c516527223e306c 07:59:23 INFO - mozversion application_display_name: Nightly 07:59:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:59:23 INFO - mozversion application_name: Firefox 07:59:23 INFO - mozversion application_remotingname: firefox 07:59:23 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 07:59:23 INFO - mozversion application_vendor: Mozilla 07:59:23 INFO - mozversion application_version: 50.0a1 07:59:23 INFO - mozversion platform_buildid: 20160714064643 07:59:23 INFO - mozversion platform_changeset: 4d4c09eae59ca000cb7a8be79c516527223e306c 07:59:23 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 07:59:23 INFO - mozversion platform_version: 50.0a1 07:59:23 INFO - using testdate: 1468508363 07:59:23 INFO - actual date: 1468508363 07:59:23 INFO - starting webserver on 'localhost:58805' 07:59:23 INFO - SUITE-START | Running 2 tests 07:59:23 INFO - TEST-START | dromaeo_css 07:59:23 INFO - operating with platform_type : linux_ 07:59:23 INFO - Initialising browser for dromaeo_css test... 07:59:23 INFO - TEST-INFO | started process 25315 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2c720H/profile http://localhost:58805/getInfo.html) 07:59:27 INFO - PROCESS | 25315 | __metrics Screen width/height:1600/1200 07:59:27 INFO - PROCESS | 25315 | colorDepth:24 07:59:27 INFO - PROCESS | 25315 | Browser inner width/height: 1024/697 07:59:27 INFO - PROCESS | 25315 | __metrics 07:59:28 INFO - PROCESS | 25315 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 07:59:28 INFO - PROCESS | 25315 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:59:29 INFO - TEST-INFO | 25315: exit 0 07:59:29 INFO - Browser initialized. 07:59:29 INFO - Running cycle 1/1 for dromaeo_css test... 07:59:29 INFO - TEST-INFO | started process 25401 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2c720H/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:59:41 INFO - PROCESS | 25401 | RSS: Main: 159674368 07:59:41 INFO - PROCESS | 25401 | 08:00:32 INFO - PROCESS | 25401 | 1468508432137 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] 08:02:45 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:58805/tests/dromaeo/cssquery-dojo.html (next: http://localhost:58805/tests/dromaeo/cssquery-ext.html) 08:02:46 INFO - PROCESS | 25401 | RSS: Main: 255942656 08:02:46 INFO - PROCESS | 25401 | 08:05:48 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:58805/tests/dromaeo/cssquery-ext.html (next: http://localhost:58805/tests/dromaeo/cssquery-jquery.html) 08:05:49 INFO - PROCESS | 25401 | RSS: Main: 239763456 08:05:49 INFO - PROCESS | 25401 | 08:08:51 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:58805/tests/dromaeo/cssquery-jquery.html (next: http://localhost:58805/tests/dromaeo/cssquery-mootools.html) 08:08:52 INFO - PROCESS | 25401 | RSS: Main: 242978816 08:08:52 INFO - PROCESS | 25401 | 08:11:54 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:58805/tests/dromaeo/cssquery-mootools.html (next: http://localhost:58805/tests/dromaeo/cssquery-prototype.html) 08:11:55 INFO - PROCESS | 25401 | RSS: Main: 239685632 08:11:55 INFO - PROCESS | 25401 | 08:14:58 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:58805/tests/dromaeo/cssquery-prototype.html (next: http://localhost:58805/tests/dromaeo/cssquery-yui.html) 08:14:58 INFO - PROCESS | 25401 | RSS: Main: 218345472 08:14:58 INFO - PROCESS | 25401 | 08:18:01 INFO - PROCESS | 25401 | Cycle 1(1): loaded http://localhost:58805/tests/dromaeo/cssquery-yui.html (next: http://localhost:58805/tests/dromaeo/cssquery-dojo.html) 08:18:01 INFO - PROCESS | 25401 | RSS: Main: 298176512 08:18:01 INFO - PROCESS | 25401 | 08:18:01 INFO - PROCESS | 25401 | __start_tp_report 08:18:01 INFO - PROCESS | 25401 | _x_x_mozilla_page_load 08:18:01 INFO - PROCESS | 25401 | _x_x_mozilla_page_load_details 08:18:01 INFO - PROCESS | 25401 | |i|pagename|runs| 08:18:02 INFO - PROCESS | 25401 | |0;dojo.html;2604.7916166706664;2632.4998250332446;2657.495075935572;2670.8531030793297;2672.091488893776;4678.532146785328;4739.879212741911;4757.238841785315;4836.97581512092;4872.244802055682;4674.929876051862;4699.318598803172;4726.480087190406;4743.051389722061;4769.618430525558;4238.173556156551;4253.680973926952;4348.478182618091;4372.060007098473;4571.634269258468;4473.172463094338;4490.618297444721;4514.413126293577;4525.592696657301;4546.408966834323;4208.3266677331785;4231.597998190167;4242.66058715302;4336.306191009423;4414.381986521874;4348.456442944632;4364.432623758891;4368.279233926399;4378.343248512717;4459.063596644676;4398.208322501949;4405.251107311765;4405.427294451732;4407.228734971399;4442.955570444286;4642.558956899089;4662.836800711959;4668.836590719343;4834.105690447279;4880.048390563841;5012.548870601663;5071.366079240095;5076.873078173076;5078.6698864574055;5084.237364395371;5065.290859279667;5087.211482220262;5096.133657278272;5102.336696229467;5109.795608175668;4535.523770004168;4758.619310455155;4770.570648641639;4788.377510923558;4794.808207671654;5282.524572788468;5287.365516138011;5288.9735551322765;5348;5363.973180134074;5066.46802085783;5077.339945807022;5130.48695130484;5134.050200712805;5136.717480538531;4982.950170498249;5081.212412076134;5110.8466745997675;5134.101532231844;5169.483051694876;5110.872228194325;5147.922781158286;5151.5106064923775;5155.716435596079;5201.843944681666;4925.556699897026;5126.384833819965;5141.177411614124;5147.613928955268;5150;4280.5505421930875;4299.355096735452;4332.588404101605;4334.826606935687;4340.848070317524;3821.9044523887123;3826.4642949987024;3840.251151025579;3870.40008798631;3907.7069219808627;4445.066536027471;4448.888777780581;4456.131054444352;4502.662300327489;4505.932411013838;4976.2038073908;4983.476734942851;5186.066508028591;5194.402643696023;5222.791088356499;4280.957190428118;4287.314029755286;4292.828286868553;4295;4303.827846886152;4454.4654641442585;4460.330950357407;4461.04087621163;4507.121111383249;4513.232750432434;4545.068261006551;4566.223741963808;4686.882827929329;4692.6480513960905;4697.530246975275;5143.8456846294675;5144.228365745019;5159.871003224949;5214.7914083436235;5223.059849227024;4811.422629284508;4824.34871292371;4829.73436460998;4830.106430310404;4878.07316609843;4909.9263511048075;4952.900941981212;5071.290019397361;5080.517350851663;5123.948760512347;5061.31672224245;5086.18621020635;5103.8468845934685;5129.563987060992;5161.432242453402;5021.623378246573;5028.723420211777;5033.471485494117;5037.748112594282;5085.084684756779;4974;4981.153203955264;4981.875453113701;4982.153033984159;4985.43185732655;4822.638302127425;4880.145974454385;4925.975370123127;4932.8520144395725;4949;5027.145385284583;5044.596432285482;5058.367704036996;5060.139776237975;5088.389393272683;4735.195016847213;4781.019890922422;4907.779149938333;4932.21084626458;4959.181735013683 08:18:02 INFO - PROCESS | 25401 | |1;ext.html;580.8780156167205;588.1383772772887;588.1618693361961;596.4989408896528;597.134155474562;27313.726862731368;30239.395212095744;40114.19771604566;41477.7926110369;41872.37191442131;41484.79257603708;42141.78929105358;42213.57786422135;42216;42269.36595951063;7739.419543534215;7858.882116768253;7869.134395216522;7872.685092596318;7877.13351531334;7522.059742532184;9826.312158148932;10110.988901109904;10114.544845481934;10451.529681164327;10223.284370094096;10294.022067903574;10295.433751143684;10300;10306.330088544259;7623.80940476487;9907.108360247541;10102.343347682414;10178.694639160836;10182.083612474877;9811.558479868423;10144.239182061376;10155.28912976092;10158.339707918962;10162.339447935861;38673.22653546913;38820;38920.22159556793;38929.80535097307;39002.60997390018;2972.4055188962293;3017.4719424100695;3062.8774849006013;3108.036508682316;3548.191074683956;29445;29632;29641.851790741122;29981.400371992655;30868.53697194544;3085.953710694341;3087.3516561522106;3103.906882793497;3130.076627394924;3165.3511030238747;247306;247406;247892;247893;249289;32659.836700816344;33779.32441351159;33828.49257261143;53813.192802108;54222;34764.47853282203;34871.4769278461;34913.650863491544;34926.82536587301;34981.30037399289;13980.161190328612;14115.294235288195;14126.50557230492;14127.15237085778;14134.575962721136;10680.092192163753;11495.3677547734;11742;11789.115816313812;11845.052395808314;8007.199280071946;8042.155573664798;8066.798330041678;8100.71647492335;8119.594020298961;3126.515390114536;3156.6054243219596;3156.9052928412184;3181.9522707159413;3213.9839300803346;834.5326617094325;882.6601758322963;903.8915330160423;962.9503840813547;994.0755097759009;27204;28404.8579757104;29004.41991160207;29053.273668158465;29192.270193244913;917.4128557723062;930.7207837648814;966;1037.9636712715019;1079.63292480557;13987.720245595032;14614.926925365306;14777.556673299818;14892.329845156994;14947.775783363259;376563;698677;704425;713019;714029;51856.740716296175;51989.2201616976;52119.73940130351;52412;52459.47540524622;1077.5474300793685;1197.120116714197;1226.969325766863;1230.1880758699215;1232.0820988363548;25734;29382.559261610666;29827;30095.849520752257;30336.241593960327;42862.14275714531;42980.785096074316;43567.782161088995;43629.12741745211;43674.34488482612;249248;249990;250184;251988;252126;22574.661380078982;25003.87498062498;25626.103086391886;25936;25986.61020084738;39720.404193936534;39937.600623993385;40190.39714404345;40598.59401405948;40949.38575921423;34987.65012349844;35049.474257886664;35198.824005879804;35391.46912796362;35398.29203415866;34638.653613463546;34782;34875.825620871736;34951;34952.475712864834;34486.31027379489;34518.65481345255;34751.65248347484;35168;35329.1167720809;30425.391492170475;30943.690563094082;31038;31098.22254443657;31214.37571248608;23937.640935385636;24044.75955240425;24186.274411767674;24382.75617243805;24627.384315392257 08:18:02 INFO - PROCESS | 25401 | |2;jquery.html;350.66161154485917;376.96607305342525;379.9020829801871;386.5573917864046;395.6241570508018;13155.473781048746;16513.42203022893;17089.40187093452;18559.721604175913;18577.907110464428;15525.456609018658;15813.762793558077;15980.920095399535;15995.280212390442;16203.432879849208;4710;5081.64428490005;5306.283651707009;5307.336582927134;5308.150695888658;5126.5898728101665;5167.9224811627855;5172.431032586413;5187.610929180308;5205.713685747282;5028.899422011557;5199;5232.816851410202;5234.816781412651;5241.790328386879;5177.637565370425;5187.48125187482;5192.039472697544;5193.532582067632;5200.427952925175;4677.579017888406;4681.297805329194;4959.479254678243;4969.130402179604;5043.571296439807;11661.6501504955;11765.705857353634;11767.23512971654;13817.723645527034;21236.088752012238;1777.5026088345894;1855.3413538194018;1881.5860510687626;1923.5671973805922;2006.9864718317156;9007.819843603156;9254.583543740548;9423.246140308827;9483.573239204252;9925.65260215889;1729.161356741979;1731.3680506615121;1731.6103876627658;1739.852112570433;1808.6563552924902;65412.672936635485;70557.64721176361;71001.64499177471;71782;73269;8552.57237138153;9180.8622870657;9191.494467804336;9695.854562181574;10430.947845260876;13012.15420997651;13807.17156970565;13857.584272471842;13872.098313609584;14476.420943162155;7344.339009489172;7384.4830861839155;7606.353459955855;7687.500312479671;7714.845703085907;7324.560526368435;7337.633118344062;7502.812429689192;7526.24737526243;7526.736564220226;4394.209042372404;4432.3794668746405;4514.774261286922;4573.725576465423;4632.073585282957;1857.6934805757169;1859.739636450898;1860.9162587683586;1902.7906930237664;1909.5608010157741;798.5089170160426;802.5786462107324;833.9874901876477;837.5979529825718;866.6706651472526;16900.323987040625;17209.311627535008;17504.737428938577;17834.286628534974;17965.910170449326;830.9750707478785;841.87792770048;844.3329769482164;850.8978922529212;861.0872475176333;9751.853722194173;10047.196224302184;10052.59789608422;10073.345232559861;10208;365292;372390;372434;373156;373996;80912;82425;83199.58400208081;84031;84826;888.644542183119;898.5417437107122;902.2376092202079;903.6295119001178;908.1554154636119;15540.766888496908;15663.843361566695;15754.133522656364;15798.76301855496;16056.43802466908;24404.605540328837;37519.62480375161;38006;38794;39381.2123757529;51091;51510;51767;51952.48047519627;52245.7387713059;7373.410127189704;7668.769936901902;7684.231576842271;7707;8007.959960200162;10696.732581685208;11077;11166.553337866395;11306.434678266218;11783.469743861719;8957.328200384867;9233.399829011092;9507.049295070437;10133.575774529758;10382.636607718694;10610.575576977144;10736;10834.67495975122;10980.725481863017;11062.225644205151;9809.509524523603;10261.179105671677;10347.172226222036;10518.368897866152;10727.463626818784;7813.492123011986;7834.412419068707;7936.087349954829;7973.521588704696;7982.401319900914;7631.3131818136635;9198.49408282551;10188;10417.635382761568;10627.149828013895 08:18:02 INFO - PROCESS | 25401 | |3;mootools.html;1343.2209318595217;1382.702718915433;1462.8098347214861;1668.2492878204812;1690.7041267778136;7678.117016543099;8134.105248422668;8199.344052475803;8201.63092660831;8221.876671849912;6761.323867613249;6935.583864968105;6965.965170174142;7178.13862336519;8004.159563245863;1929.0740444586606;2178.2376168341034;2246.618074927266;2256.007356763019;2258.4128126687096;2207.128184367174;2216.7672394398596;2252.2117258959397;2255.086689890597;2270.5685919675207;1908.2271679969565;2208.392692009702;2254.3800454874877;2254.718160229971;2259.2318611672026;2146.6565349544076;2228.1198926424136;2229.6878437018913;2241.237979087118;2243.9102435902546;2175.1299480207886;2213.9778602213933;2235.675827005075;2237.9216727414623;2240.540689158735;8101.797455063612;8145.226203510657;8148.877766833502;8156.714514992006;8159.755207343789;4713.340132381435;4791.6406269529925;4823.397075365579;4827.106985207748;4868.878278043042;2774.902878399246;2858.5997960285576;2890.9710902891125;2903.2306438793735;2904.8983285584904;905.6965916418008;928.6007016982695;942.9952850235774;945.2532499325524;948.2650945517279;10619.78760424795;10853.728656783565;10862.674119776419;10901.563937442494;10928.453577321181;4018.698597605133;4384.079343337871;4402.84590039347;4489.932651010172;4502.977485112553;9418.717438476857;9461.05389461062;9501.097395747393;9504.714858554255;9511.381760185566;4669.2062349400685;4674.976625116853;4678.274867395559;4691.83578574755;4694;4241.936370954438;4254.7021708480725;4258.638015768633;4303.117860838521;4308.870733877989;3711.387621042552;3750.887473375803;3769.3968964965475;3800.049987503124;3827.9617203827606;1217.4825699077855;1228.520876858026;1229.287013532149;1230.655416483386;1246.0716766009382;850.1456036683218;856.1737922904302;858.6436628799104;870.4907629036958;874.4359887872414;5407.810726624549;5573.942343691501;5589.944100558942;5610.607257492018;5710.371859095496;392.268419397821;394.9743266687656;398.94215338776297;399.5884239233594;412.015283472501;3654.8720794772057;3739.794311312904;3896.551896531935;3924.1955399143108;3929.233799409145;9140.314476414163;9906;9923.751906202258;9925.30522863407;9934.254930880214;9724.756881077888;9805.509724513746;9820.803583928282;9859.753506162404;9867.901320986843;7188.137423509108;7422.554646721214;7438.888416673754;7602.1257555381835;7643.388528917673;5584.441555844383;5668.263125793786;5758.366579676149;5786.045302525036;5851.970740146442;9162.770930726785;9166.358354915359;9199.126083022102;9386.342955993015;9429.481378524248;9127.90465144187;9166.22087122602;9319;9568.617255309988;9598.712038638572;6628.436582890508;7413.147488038729;7575.242475752601;7590.0891892973195;7844.725434609762;7885.2114788520685;7940.325072368913;8020;8026.478278911852;8038.598070096355;6623.834404139935;6819.829504262433;6852.451803855779;6852.725890964505;6960.37356637905;6620.404163625297;6665;6876.140482439695;6925.896111558432;6983.790486285419;6273.341299163704;6564.409203171737;6599.868002639824;6772.661366931732;6779.457643388616;4797.18447863857;4942.950570494393;4981.078500477278;5022.799088036584;5085.847424577269;4771.093492236464;4910.6562540623245;4938.802447902043;4970.682769066273;5001.42483614389 08:18:02 INFO - PROCESS | 25401 | |4;prototype.html;297.1175608442924;304.6313960108269;306.09701380926265;312.89205224197644;313.1357453428537;4838.10495058414;4845.3216549683075;4845.660803743739;4865.878353041176;4874.0982918160125;4760.595349395306;4803.63972702047;4815.66290359675;4831.9275210871865;4833.250846118848;3609.368360536902;3738.8504459821575;3757.8308976096005;3858.459815625815;3880.708946828985;3818.2363527294515;3822.9808850955847;3832.080300727833;3842.5004749382542;3848.8845334639864;3625.0393645683916;3793.905152371199;3799.183175617242;3801.9429708554394;3807.2385522895534;3663.120850995755;3760.8119594020327;3778.6410291022307;3791.298609757176;3801.353769859131;3344.5484859543894;3370.713489353408;3377.375185590649;3383.5263063171174;3396.9490457643155;4714.504976977402;4731.083911016044;4742.439082895233;4743.620510359163;4744.715317080986;4248.808803603814;4346.935000924762;4354.651627869763;4375.606195442426;4380.145871555048;5016.620429381913;5028.748562571856;5034.84895453137;5052.595792336604;5059.519345662156;3700.4634328022285;3704.1850792825535;3705.962940370616;3706.8517259309865;3727.8881633551036;5091.134507133796;5248.186531087649;5263.552598029172;5328.147496400557;5340.946590534084;3760.172761992357;3771.6610603236004;3775.754575952554;3779.7165212609166;3781.111438811877;3828.5214348206473;3834.61953696669;3835.6547910687614;3837.6737977271687;3838.2323535293053;4343.261645520269;4362.76004819738;4365.80353884076;4370.606645401929;4374.693771436033;4876.414830220326;5027.924581131286;5037.571806396498;5048.268001139814;5049.84850454487;1304.2500562176785;1323.6690827293178;1323.8146659467682;1327.157255142991;1327.4358397680946;857.9575815384338;858.6307887608264;865.536937738307;890.5191196753681;921.7787730944525;4432.977835110803;4435.844745433894;4437.112577484516;4450.821967121344;4470;5124.282600435942;5131.512506311969;5158.174692049329;5164.767585458663;5174.870628234325;4261.446012018418;4414.3157810539415;4420.877978570305;4423.977880110579;4440.777961101997;2769.3353595137023;2792.46943080814;2803.1310293808983;2812.2406950123354;2819.4220184862056;4933.569264913135;4936.7284799336385;4953;4963.181075122564;4981.950180498221;5127.87180320495;5347.385050719217;5364.409914909357;5374.48942350476;5437.646552974044;4921.212605983097;4953.405591329064;4956.256561515802;4964.280179373971;4970.378702662168;5271.89456210866;5274.815381461631;5279.287296214962;5317.202419637086;5354.598405119709;4932.210846264724;5177.430482646982;5192.948070519246;5231.89536209266;5234.2672025915645;4954.355933728592;4961.801527938842;4979.004199160255;4981.701097934136;4992.176290911959;3711.461838033524;3718.6095459977396;3721.9069523262133;3723.851045958131;3724.478572999728;5058.418281897481;5201.427842937198;5217.399999000164;5278.97360513195;5292.947070529245;5044.679447454212;5076.898462030665;5080.872978175576;5089.211172268304;5090.2364645303505;5051.797928082982;5067.569256613229;5068.3917929847175;5089.821856235014;5091.949080509147;4720.409948756405;5007.148784706682;5024.472430394902;5025.522575355335;5028.622853286091;4874.513273451631;4948.1835497142565;5074.086664400444;5111.642185047011;5112.156494178419;4966.875828104182;4985.576226020684;4988.002399520038;4995.17579599362;4998.525140111684 08:18:02 INFO - PROCESS | 25401 | |5;yui.html;597.0983814440197;639.1148259660371;684.7295318349252;694.6839188169383;759.8176437654964;12386;13044.08691391603;13224.27266500342;13272.800907986388;13496.662583435407;12195.878041219585;12232.082593805455;12309.199902006363;12327.876721232786;12328.075394345415;638.4094712391043;767.3132546370995;793.6388943030936;795.7175202802994;815.1807433529324;805.794522396788;805.8710606302964;807.7011505742854;809.0736107157302;809.7489778168757;836.8410002099612;837.2590257621988;837.7109897085496;837.7235512280963;837.8031162676766;657.7500549791073;797.8204903896577;826.0747962282222;833.5707110837923;835.1022650650575;616.1097214525013;616.6423474384846;616.8334549671564;617.1267656266377;618.916446279751;12838.486460541568;12924.870751292461;12954;12993.610191694264;13035.739285214337;12051.096167787451;12509.249445033327;12695.492180312776;12724.554640587628;12914.741705165938;11383.373914434702;11397.48711307985;11603.303801771921;11647.534098636044;12053.698657533545;4052;4114.033202197481;4209.179210054041;4260.744355338689;4261.403403523478;58135;58386;58549.70725146347;58573.414265857224;58879.705601472146;9865.1121399073;10103.84844227337;10214.489275536194;10261.28171028021;10663.146948244123;18501.90749046246;18610.627787444446;18738.81261187398;18739.812601873808;18767.0616469176;6516.348365163541;6544.770933017321;6586.209654841354;6658.067870498134;6693.069700037773;3414.8804791832167;3440.2947395784304;3445.638207988175;3465.9480107798404;3492.7555071145284;2693.4747724193594;2784.9721502784714;2793.7625301849166;2795.021742390147;2795.2872017635373;427.92511310520536;439.03631528794625;439.7954950947761;455.6901307111196;456.31097043463944;437.87739432958824;513.7148882370245;518.8132272381939;525.7739172155933;552.8009916430082;7393.593352365671;7533;7928.841423171504;7982.84034319322;8034.558099304594;447.5077414843646;450.9932351014737;516.3107251818864;525.4456548341536;531.5269410224903;3679.3193259247123;3776.9244615107546;3778.8677396290996;3819.8854034379015;3900.239453306578;54235.72882135643;54412.727936360854;86701;91811.54094229486;92944;71956;77703.22296777074;78002.60998695083;78113.21886781174;78535.60732196302;58171;68282.31717682858;69587.30412695809;69653.65173174204;70535;7468.439867009887;7481.364084052916;7522.097348318237;7554.471187016856;7574;44124;44274;44480.05254960182;44755;45155.09689806251;59373.703131484064;60124.09813852883;62415;65118.674406627666;65596;9775.706728798148;10025;10043.69868903934;10074.798504030025;10338.896611033793;11131.276467029616;11170.944145279222;11240;11717.882821172021;11828.526858925547;9733.561989710339;10208.795824083625;10293.845592316271;10302.381857088598;10317.638882639072;9716.951415242878;10094.343867648578;10333.689989300334;10599.417032063311;10635.096016838655;8821.426607270507;8891.333150013645;10088.495575221063;10296.433696146783;10630.787384252117;8302.460340077876;8305.626246819029;8398.887326892669;8464.280536154496;8591.742247732578;8609.053004169411;8643.654253829776;8745.169208925143;8770.298376129767;8980.640774368952 08:18:02 INFO - PROCESS | 25401 | __end_tp_report 08:18:02 INFO - PROCESS | 25401 | __start_cc_report 08:18:02 INFO - PROCESS | 25401 | _x_x_mozilla_cycle_collect,944 08:18:02 INFO - PROCESS | 25401 | __end_cc_report 08:18:02 INFO - PROCESS | 25401 | __startTimestamp1468509481997__endTimestamp 08:18:02 INFO - PROCESS | 25401 | 08:18:02 INFO - PROCESS | 25401 | ------- Summary: start ------- 08:18:02 INFO - PROCESS | 25401 | Number of tests: 6 08:18:02 INFO - PROCESS | 25401 | 08:18:02 INFO - PROCESS | 25401 | [#0] dojo.html Cycles:165 Average:4716.56 Median:4830.11 stddev:505.76 (10.5%) stddev-sans-first:479.41 08:18:02 INFO - PROCESS | 25401 | Values: 2604.8 2632.5 2657.5 2670.9 2672.1 4678.5 4739.9 4757.2 4837.0 4872.2 4674.9 4699.3 4726.5 4743.1 4769.6 4238.2 4253.7 4348.5 4372.1 4571.6 4473.2 4490.6 4514.4 4525.6 4546.4 4208.3 4231.6 4242.7 4336.3 4414.4 4348.5 4364.4 4368.3 4378.3 4459.1 4398.2 4405.3 4405.4 4407.2 4443.0 4642.6 4662.8 4668.8 4834.1 4880.0 5012.5 5071.4 5076.9 5078.7 5084.2 5065.3 5087.2 5096.1 5102.3 5109.8 4535.5 4758.6 4770.6 4788.4 4794.8 5282.5 5287.4 5289.0 5348.0 5364.0 5066.5 5077.3 5130.5 5134.1 5136.7 4983.0 5081.2 5110.8 5134.1 5169.5 5110.9 5147.9 5151.5 5155.7 5201.8 4925.6 5126.4 5141.2 5147.6 5150.0 4280.6 4299.4 4332.6 4334.8 4340.8 3821.9 3826.5 3840.3 3870.4 3907.7 4445.1 4448.9 4456.1 4502.7 4505.9 4976.2 4983.5 5186.1 5194.4 5222.8 4281.0 4287.3 4292.8 4295.0 4303.8 4454.5 4460.3 4461.0 4507.1 4513.2 4545.1 4566.2 4686.9 4692.6 4697.5 5143.8 5144.2 5159.9 5214.8 5223.1 4811.4 4824.3 4829.7 4830.1 4878.1 4909.9 4952.9 5071.3 5080.5 5123.9 5061.3 5086.2 5103.8 5129.6 5161.4 5021.6 5028.7 5033.5 5037.7 5085.1 4974.0 4981.2 4981.9 4982.2 4985.4 4822.6 4880.1 4926.0 4932.9 4949.0 5027.1 5044.6 5058.4 5060.1 5088.4 4735.2 4781.0 4907.8 4932.2 4959.2 08:18:02 INFO - PROCESS | 25401 | 08:18:02 INFO - PROCESS | 25401 | [#1] ext.html Cycles:180 Average:51416.46 Median:3173.65 stddev:115967.45 (3654.1%) stddev-sans-first:116229.96 08:18:02 INFO - PROCESS | 25401 | Values: 580.9 588.1 588.2 596.5 597.1 27313.7 30239.4 40114.2 41477.8 41872.4 41484.8 42141.8 42213.6 42216.0 42269.4 7739.4 7858.9 7869.1 7872.7 7877.1 7522.1 9826.3 10111.0 10114.5 10451.5 10223.3 10294.0 10295.4 10300.0 10306.3 7623.8 9907.1 10102.3 10178.7 10182.1 9811.6 10144.2 10155.3 10158.3 10162.3 38673.2 38820.0 38920.2 38929.8 39002.6 2972.4 3017.5 3062.9 3108.0 3548.2 29445.0 29632.0 29641.9 29981.4 30868.5 3086.0 3087.4 3103.9 3130.1 3165.4 247306.0 247406.0 247892.0 247893.0 249289.0 32659.8 33779.3 33828.5 53813.2 54222.0 34764.5 34871.5 34913.7 34926.8 34981.3 13980.2 14115.3 14126.5 14127.2 14134.6 10680.1 11495.4 11742.0 11789.1 11845.1 8007.2 8042.2 8066.8 8100.7 8119.6 3126.5 3156.6 3156.9 3182.0 3214.0 834.5 882.7 903.9 963.0 994.1 27204.0 28404.9 29004.4 29053.3 29192.3 917.4 930.7 966.0 1038.0 1079.6 13987.7 14614.9 14777.6 14892.3 14947.8 376563.0 698677.0 704425.0 713019.0 714029.0 51856.7 51989.2 52119.7 52412.0 52459.5 1077.5 1197.1 1227.0 1230.2 1232.1 25734.0 29382.6 29827.0 30095.8 30336.2 42862.1 42980.8 43567.8 43629.1 43674.3 249248.0 249990.0 250184.0 251988.0 252126.0 22574.7 25003.9 25626.1 25936.0 25986.6 39720.4 39937.6 40190.4 40598.6 40949.4 34987.7 35049.5 35198.8 35391.5 35398.3 34638.7 34782.0 34875.8 34951.0 34952.5 34486.3 34518.7 34751.7 35168.0 35329.1 30425.4 30943.7 31038.0 31098.2 31214.4 23937.6 24044.8 24186.3 24382.8 24627.4 08:18:02 INFO - PROCESS | 25401 | 08:18:02 INFO - PROCESS | 25401 | [#2] jquery.html Cycles:180 Average:23768.67 Median:4695.65 stddev:61680.39 (1313.6%) stddev-sans-first:61828.35 08:18:02 INFO - PROCESS | 25401 | Values: 350.7 377.0 379.9 386.6 395.6 13155.5 16513.4 17089.4 18559.7 18577.9 15525.5 15813.8 15980.9 15995.3 16203.4 4710.0 5081.6 5306.3 5307.3 5308.2 5126.6 5167.9 5172.4 5187.6 5205.7 5028.9 5199.0 5232.8 5234.8 5241.8 5177.6 5187.5 5192.0 5193.5 5200.4 4677.6 4681.3 4959.5 4969.1 5043.6 11661.7 11765.7 11767.2 13817.7 21236.1 1777.5 1855.3 1881.6 1923.6 2007.0 9007.8 9254.6 9423.2 9483.6 9925.7 1729.2 1731.4 1731.6 1739.9 1808.7 65412.7 70557.6 71001.6 71782.0 73269.0 8552.6 9180.9 9191.5 9695.9 10430.9 13012.2 13807.2 13857.6 13872.1 14476.4 7344.3 7384.5 7606.4 7687.5 7714.8 7324.6 7337.6 7502.8 7526.2 7526.7 4394.2 4432.4 4514.8 4573.7 4632.1 1857.7 1859.7 1860.9 1902.8 1909.6 798.5 802.6 834.0 837.6 866.7 16900.3 17209.3 17504.7 17834.3 17965.9 831.0 841.9 844.3 850.9 861.1 9751.9 10047.2 10052.6 10073.3 10208.0 365292.0 372390.0 372434.0 373156.0 373996.0 80912.0 82425.0 83199.6 84031.0 84826.0 888.6 898.5 902.2 903.6 908.2 15540.8 15663.8 15754.1 15798.8 16056.4 24404.6 37519.6 38006.0 38794.0 39381.2 51091.0 51510.0 51767.0 51952.5 52245.7 7373.4 7668.8 7684.2 7707.0 8008.0 10696.7 11077.0 11166.6 11306.4 11783.5 8957.3 9233.4 9507.0 10133.6 10382.6 10610.6 10736.0 10834.7 10980.7 11062.2 9809.5 10261.2 10347.2 10518.4 10727.5 7813.5 7834.4 7936.1 7973.5 7982.4 7631.3 9198.5 10188.0 10417.6 10627.1 08:18:02 INFO - PROCESS | 25401 | 08:18:02 INFO - PROCESS | 25401 | [#3] mootools.html Cycles:180 Average:5298.57 Median:5490.88 stddev:2982.51 (54.3%) stddev-sans-first:2976.07 08:18:02 INFO - PROCESS | 25401 | Values: 1343.2 1382.7 1462.8 1668.2 1690.7 7678.1 8134.1 8199.3 8201.6 8221.9 6761.3 6935.6 6966.0 7178.1 8004.2 1929.1 2178.2 2246.6 2256.0 2258.4 2207.1 2216.8 2252.2 2255.1 2270.6 1908.2 2208.4 2254.4 2254.7 2259.2 2146.7 2228.1 2229.7 2241.2 2243.9 2175.1 2214.0 2235.7 2237.9 2240.5 8101.8 8145.2 8148.9 8156.7 8159.8 4713.3 4791.6 4823.4 4827.1 4868.9 2774.9 2858.6 2891.0 2903.2 2904.9 905.7 928.6 943.0 945.3 948.3 10619.8 10853.7 10862.7 10901.6 10928.5 4018.7 4384.1 4402.8 4489.9 4503.0 9418.7 9461.1 9501.1 9504.7 9511.4 4669.2 4675.0 4678.3 4691.8 4694.0 4241.9 4254.7 4258.6 4303.1 4308.9 3711.4 3750.9 3769.4 3800.0 3828.0 1217.5 1228.5 1229.3 1230.7 1246.1 850.1 856.2 858.6 870.5 874.4 5407.8 5573.9 5589.9 5610.6 5710.4 392.3 395.0 398.9 399.6 412.0 3654.9 3739.8 3896.6 3924.2 3929.2 9140.3 9906.0 9923.8 9925.3 9934.3 9724.8 9805.5 9820.8 9859.8 9867.9 7188.1 7422.6 7438.9 7602.1 7643.4 5584.4 5668.3 5758.4 5786.0 5852.0 9162.8 9166.4 9199.1 9386.3 9429.5 9127.9 9166.2 9319.0 9568.6 9598.7 6628.4 7413.1 7575.2 7590.1 7844.7 7885.2 7940.3 8020.0 8026.5 8038.6 6623.8 6819.8 6852.5 6852.7 6960.4 6620.4 6665.0 6876.1 6925.9 6983.8 6273.3 6564.4 6599.9 6772.7 6779.5 4797.2 4943.0 4981.1 5022.8 5085.8 4771.1 4910.7 4938.8 4970.7 5001.4 08:18:02 INFO - PROCESS | 25401 | 08:18:02 INFO - PROCESS | 25401 | [#4] prototype.html Cycles:180 Average:4228.71 Median:4835.68 stddev:1214.83 (25.1%) stddev-sans-first:1181.85 08:18:02 INFO - PROCESS | 25401 | Values: 297.1 304.6 306.1 312.9 313.1 4838.1 4845.3 4845.7 4865.9 4874.1 4760.6 4803.6 4815.7 4831.9 4833.3 3609.4 3738.9 3757.8 3858.5 3880.7 3818.2 3823.0 3832.1 3842.5 3848.9 3625.0 3793.9 3799.2 3801.9 3807.2 3663.1 3760.8 3778.6 3791.3 3801.4 3344.5 3370.7 3377.4 3383.5 3396.9 4714.5 4731.1 4742.4 4743.6 4744.7 4248.8 4346.9 4354.7 4375.6 4380.1 5016.6 5028.7 5034.8 5052.6 5059.5 3700.5 3704.2 3706.0 3706.9 3727.9 5091.1 5248.2 5263.6 5328.1 5340.9 3760.2 3771.7 3775.8 3779.7 3781.1 3828.5 3834.6 3835.7 3837.7 3838.2 4343.3 4362.8 4365.8 4370.6 4374.7 4876.4 5027.9 5037.6 5048.3 5049.8 1304.3 1323.7 1323.8 1327.2 1327.4 858.0 858.6 865.5 890.5 921.8 4433.0 4435.8 4437.1 4450.8 4470.0 5124.3 5131.5 5158.2 5164.8 5174.9 4261.4 4414.3 4420.9 4424.0 4440.8 2769.3 2792.5 2803.1 2812.2 2819.4 4933.6 4936.7 4953.0 4963.2 4982.0 5127.9 5347.4 5364.4 5374.5 5437.6 4921.2 4953.4 4956.3 4964.3 4970.4 5271.9 5274.8 5279.3 5317.2 5354.6 4932.2 5177.4 5192.9 5231.9 5234.3 4954.4 4961.8 4979.0 4981.7 4992.2 3711.5 3718.6 3721.9 3723.9 3724.5 5058.4 5201.4 5217.4 5279.0 5292.9 5044.7 5076.9 5080.9 5089.2 5090.2 5051.8 5067.6 5068.4 5089.8 5091.9 4720.4 5007.1 5024.5 5025.5 5028.6 4874.5 4948.2 5074.1 5111.6 5112.2 4966.9 4985.6 4988.0 4995.2 4998.5 08:18:02 INFO - PROCESS | 25401 | 08:18:02 INFO - PROCESS | 25401 | [#5] yui.html Cycles:180 Average:16332.50 Median:525.61 stddev:22678.08 (4314.6%) stddev-sans-first:22710.91 08:18:02 INFO - PROCESS | 25401 | Values: 597.1 639.1 684.7 694.7 759.8 12386.0 13044.1 13224.3 13272.8 13496.7 12195.9 12232.1 12309.2 12327.9 12328.1 638.4 767.3 793.6 795.7 815.2 805.8 805.9 807.7 809.1 809.7 836.8 837.3 837.7 837.7 837.8 657.8 797.8 826.1 833.6 835.1 616.1 616.6 616.8 617.1 618.9 12838.5 12924.9 12954.0 12993.6 13035.7 12051.1 12509.2 12695.5 12724.6 12914.7 11383.4 11397.5 11603.3 11647.5 12053.7 4052.0 4114.0 4209.2 4260.7 4261.4 58135.0 58386.0 58549.7 58573.4 58879.7 9865.1 10103.8 10214.5 10261.3 10663.1 18501.9 18610.6 18738.8 18739.8 18767.1 6516.3 6544.8 6586.2 6658.1 6693.1 3414.9 3440.3 3445.6 3465.9 3492.8 2693.5 2785.0 2793.8 2795.0 2795.3 427.9 439.0 439.8 455.7 456.3 437.9 513.7 518.8 525.8 552.8 7393.6 7533.0 7928.8 7982.8 8034.6 447.5 451.0 516.3 525.4 531.5 3679.3 3776.9 3778.9 3819.9 3900.2 54235.7 54412.7 86701.0 91811.5 92944.0 71956.0 77703.2 78002.6 78113.2 78535.6 58171.0 68282.3 69587.3 69653.7 70535.0 7468.4 7481.4 7522.1 7554.5 7574.0 44124.0 44274.0 44480.1 44755.0 45155.1 59373.7 60124.1 62415.0 65118.7 65596.0 9775.7 10025.0 10043.7 10074.8 10338.9 11131.3 11170.9 11240.0 11717.9 11828.5 9733.6 10208.8 10293.8 10302.4 10317.6 9717.0 10094.3 10333.7 10599.4 10635.1 8821.4 8891.3 10088.5 10296.4 10630.8 8302.5 8305.6 8398.9 8464.3 8591.7 8609.1 8643.7 8745.2 8770.3 8980.6 08:18:02 INFO - PROCESS | 25401 | -------- Summary: end -------- 08:18:02 INFO - PROCESS | 25401 | 08:18:02 INFO - TEST-INFO | 25401: exit 0 08:18:02 INFO - TEST-OK | dromaeo_css | took 1119663ms 08:18:02 INFO - TEST-START | kraken 08:18:02 INFO - operating with platform_type : linux_ 08:18:02 INFO - Initialising browser for kraken test... 08:18:02 INFO - TEST-INFO | started process 25592 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5WIcO0/profile http://localhost:58805/getInfo.html) 08:18:07 INFO - PROCESS | 25592 | __metrics Screen width/height:1600/1200 08:18:07 INFO - PROCESS | 25592 | colorDepth:24 08:18:07 INFO - PROCESS | 25592 | Browser inner width/height: 1024/697 08:18:07 INFO - PROCESS | 25592 | __metrics 08:18:07 INFO - PROCESS | 25592 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:18:07 INFO - PROCESS | 25592 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:18:09 INFO - TEST-INFO | 25592: exit 0 08:18:09 INFO - Browser initialized. 08:18:09 INFO - Running cycle 1/1 for kraken test... 08:18:09 INFO - TEST-INFO | started process 25675 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp5WIcO0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:18:21 INFO - PROCESS | 25675 | RSS: Main: 159125504 08:18:21 INFO - PROCESS | 25675 | 08:18:23 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:58805/tests/kraken/driver.html?testName=audio-beat-detection) 08:18:24 INFO - PROCESS | 25675 | RSS: Main: 216719360 08:18:24 INFO - PROCESS | 25675 | 08:18:27 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:58805/tests/kraken/driver.html?testName=audio-dft) 08:18:27 INFO - PROCESS | 25675 | RSS: Main: 204144640 08:18:27 INFO - PROCESS | 25675 | 08:18:31 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:58805/tests/kraken/driver.html?testName=audio-fft) 08:18:31 INFO - PROCESS | 25675 | RSS: Main: 271089664 08:18:31 INFO - PROCESS | 25675 | 08:18:33 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:58805/tests/kraken/driver.html?testName=audio-oscillator) 08:18:34 INFO - PROCESS | 25675 | RSS: Main: 181805056 08:18:34 INFO - PROCESS | 25675 | 08:18:36 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:58805/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:18:37 INFO - PROCESS | 25675 | RSS: Main: 186036224 08:18:37 INFO - PROCESS | 25675 | 08:18:40 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:58805/tests/kraken/driver.html?testName=imaging-darkroom) 08:18:41 INFO - PROCESS | 25675 | RSS: Main: 222048256 08:18:41 INFO - PROCESS | 25675 | 08:18:44 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:58805/tests/kraken/driver.html?testName=imaging-desaturate) 08:18:45 INFO - PROCESS | 25675 | RSS: Main: 217436160 08:18:45 INFO - PROCESS | 25675 | 08:18:48 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:58805/tests/kraken/driver.html?testName=json-parse-financial) 08:18:48 INFO - PROCESS | 25675 | RSS: Main: 220753920 08:18:48 INFO - PROCESS | 25675 | 08:18:50 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:58805/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:18:51 INFO - PROCESS | 25675 | RSS: Main: 207831040 08:18:51 INFO - PROCESS | 25675 | 08:18:53 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:58805/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:18:53 INFO - PROCESS | 25675 | RSS: Main: 213020672 08:18:53 INFO - PROCESS | 25675 | 08:18:55 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:58805/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:18:56 INFO - PROCESS | 25675 | RSS: Main: 209870848 08:18:56 INFO - PROCESS | 25675 | 08:18:59 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:58805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:18:59 INFO - PROCESS | 25675 | RSS: Main: 222662656 08:18:59 INFO - PROCESS | 25675 | 08:19:02 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:58805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:19:03 INFO - PROCESS | 25675 | RSS: Main: 223629312 08:19:03 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | Cycle 1(1): loaded http://localhost:58805/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:58805/tests/kraken/driver.html?testName=ai-astar) 08:19:05 INFO - PROCESS | 25675 | RSS: Main: 267071488 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | __start_tp_report 08:19:05 INFO - PROCESS | 25675 | _x_x_mozilla_page_load 08:19:05 INFO - PROCESS | 25675 | _x_x_mozilla_page_load_details 08:19:05 INFO - PROCESS | 25675 | |i|pagename|runs| 08:19:05 INFO - PROCESS | 25675 | |0;ai-astar;103;116;113;113;113;114;114;112;115;113 08:19:05 INFO - PROCESS | 25675 | |1;audio-beat-detection;151;127;129;179;123;125;148;128;163;125 08:19:05 INFO - PROCESS | 25675 | |2;audio-dft;161;160;159;161;163;161;161;161;162;161 08:19:05 INFO - PROCESS | 25675 | |3;audio-fft;76;76;77;117;76;76;77;76;97;76 08:19:05 INFO - PROCESS | 25675 | |4;audio-oscillator;85;85;117;85;85;85;120;85;85;127 08:19:05 INFO - PROCESS | 25675 | |5;imaging-gaussian-blur;116;117;117;117;116;118;118;118;118;117 08:19:05 INFO - PROCESS | 25675 | |6;imaging-darkroom;147;146;146;146;147;146;146;146;146;147 08:19:05 INFO - PROCESS | 25675 | |7;imaging-desaturate;94;95;95;95;94;95;95;95;95;95 08:19:05 INFO - PROCESS | 25675 | |8;json-parse-financial;66;64;66;66;67;66;66;66;65;64 08:19:05 INFO - PROCESS | 25675 | |9;json-stringify-tinderbox;64;65;65;65;65;64;66;70;72;65 08:19:05 INFO - PROCESS | 25675 | |10;stanford-crypto-aes;79;87;81;78;78;80;79;78;80;78 08:19:05 INFO - PROCESS | 25675 | |11;stanford-crypto-ccm;129;131;143;126;136;127;132;129;181;128 08:19:05 INFO - PROCESS | 25675 | |12;stanford-crypto-pbkdf2;170;163;166;164;164;164;166;165;170;163 08:19:05 INFO - PROCESS | 25675 | |13;stanford-crypto-sha256-iterative;67;68;66;66;65;69;65;66;67;65 08:19:05 INFO - PROCESS | 25675 | __end_tp_report 08:19:05 INFO - PROCESS | 25675 | __start_cc_report 08:19:05 INFO - PROCESS | 25675 | _x_x_mozilla_cycle_collect,1925 08:19:05 INFO - PROCESS | 25675 | __end_cc_report 08:19:05 INFO - PROCESS | 25675 | __startTimestamp1468509545323__endTimestamp 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | ------- Summary: start ------- 08:19:05 INFO - PROCESS | 25675 | Number of tests: 14 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#0] ai-astar Cycles:10 Average:112.60 Median:113.50 stddev:3.57 (3.1%) stddev-sans-first:1.22 08:19:05 INFO - PROCESS | 25675 | Values: 103.0 116.0 113.0 113.0 113.0 114.0 114.0 112.0 115.0 113.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#1] audio-beat-detection Cycles:10 Average:139.80 Median:138.50 stddev:19.46 (14.0%) stddev-sans-first:20.21 08:19:05 INFO - PROCESS | 25675 | Values: 151.0 127.0 129.0 179.0 123.0 125.0 148.0 128.0 163.0 125.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.05 (0.7%) stddev-sans-first:1.12 08:19:05 INFO - PROCESS | 25675 | Values: 161.0 160.0 159.0 161.0 163.0 161.0 161.0 161.0 162.0 161.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#3] audio-fft Cycles:10 Average:82.40 Median:76.00 stddev:13.80 (18.2%) stddev-sans-first:14.44 08:19:05 INFO - PROCESS | 25675 | Values: 76.0 76.0 77.0 117.0 76.0 76.0 77.0 76.0 97.0 76.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#4] audio-oscillator Cycles:10 Average:95.90 Median:85.00 stddev:17.72 (20.8%) stddev-sans-first:18.35 08:19:05 INFO - PROCESS | 25675 | Values: 85.0 85.0 117.0 85.0 85.0 85.0 120.0 85.0 85.0 127.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.50 stddev:0.79 (0.7%) stddev-sans-first:0.71 08:19:05 INFO - PROCESS | 25675 | Values: 116.0 117.0 117.0 117.0 116.0 118.0 118.0 118.0 118.0 117.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.44 08:19:05 INFO - PROCESS | 25675 | Values: 147.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 146.0 147.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#7] imaging-desaturate Cycles:10 Average:94.80 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 08:19:05 INFO - PROCESS | 25675 | Values: 94.0 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#8] json-parse-financial Cycles:10 Average:65.60 Median:66.00 stddev:0.97 (1.5%) stddev-sans-first:1.01 08:19:05 INFO - PROCESS | 25675 | Values: 66.0 64.0 66.0 66.0 67.0 66.0 66.0 66.0 65.0 64.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#9] json-stringify-tinderbox Cycles:10 Average:66.10 Median:65.00 stddev:2.69 (4.1%) stddev-sans-first:2.74 08:19:05 INFO - PROCESS | 25675 | Values: 64.0 65.0 65.0 65.0 65.0 64.0 66.0 70.0 72.0 65.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#10] stanford-crypto-aes Cycles:10 Average:79.80 Median:79.50 stddev:2.74 (3.4%) stddev-sans-first:2.89 08:19:05 INFO - PROCESS | 25675 | Values: 79.0 87.0 81.0 78.0 78.0 80.0 79.0 78.0 80.0 78.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#11] stanford-crypto-ccm Cycles:10 Average:136.20 Median:131.50 stddev:16.52 (12.6%) stddev-sans-first:17.32 08:19:05 INFO - PROCESS | 25675 | Values: 129.0 131.0 143.0 126.0 136.0 127.0 132.0 129.0 181.0 128.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:165.50 stddev:2.59 (1.6%) stddev-sans-first:2.18 08:19:05 INFO - PROCESS | 25675 | Values: 170.0 163.0 166.0 164.0 164.0 164.0 166.0 165.0 170.0 163.0 08:19:05 INFO - PROCESS | 25675 | 08:19:05 INFO - PROCESS | 25675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.40 Median:66.50 stddev:1.35 (2.0%) stddev-sans-first:1.41 08:19:05 INFO - PROCESS | 25675 | Values: 67.0 68.0 66.0 66.0 65.0 69.0 65.0 66.0 67.0 65.0 08:19:05 INFO - PROCESS | 25675 | -------- Summary: end -------- 08:19:05 INFO - PROCESS | 25675 | 08:19:06 INFO - TEST-INFO | 25675: exit 0 08:19:06 INFO - TEST-OK | kraken | took 63659ms 08:19:06 INFO - SUITE-END | took 1183s 08:19:06 INFO - Completed test suite (00:19:43) 08:19:06 INFO - javascript benchmark 08:19:06 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2604.7916166706664, 2632.4998250332446, 2657.495075935572, 2670.8531030793297, 2672.091488893776, 4678.532146785328, 4739.879212741911, 4757.238841785315, 4836.97581512092, 4872.244802055682, 4674.929876051862, 4699.318598803172, 4726.480087190406, 4743.051389722061, 4769.618430525558, 4238.173556156551, 4253.680973926952, 4348.478182618091, 4372.060007098473, 4571.634269258468, 4473.172463094338, 4490.618297444721, 4514.413126293577, 4525.592696657301, 4546.408966834323, 4208.3266677331785, 4231.597998190167, 4242.66058715302, 4336.306191009423, 4414.381986521874, 4348.456442944632, 4364.432623758891, 4368.279233926399, 4378.343248512717, 4459.063596644676, 4398.208322501949, 4405.251107311765, 4405.427294451732, 4407.228734971399, 4442.955570444286, 4642.558956899089, 4662.836800711959, 4668.836590719343, 4834.105690447279, 4880.048390563841, 5012.548870601663, 5071.366079240095, 5076.873078173076, 5078.6698864574055, 5084.237364395371, 5065.290859279667, 5087.211482220262, 5096.133657278272, 5102.336696229467, 5109.795608175668, 4535.523770004168, 4758.619310455155, 4770.570648641639, 4788.377510923558, 4794.808207671654, 5282.524572788468, 5287.365516138011, 5288.9735551322765, 5348.0, 5363.973180134074, 5066.46802085783, 5077.339945807022, 5130.48695130484, 5134.050200712805, 5136.717480538531, 4982.950170498249, 5081.212412076134, 5110.8466745997675, 5134.101532231844, 5169.483051694876, 5110.872228194325, 5147.922781158286, 5151.5106064923775, 5155.716435596079, 5201.843944681666, 4925.556699897026, 5126.384833819965, 5141.177411614124, 5147.613928955268, 5150.0, 4280.5505421930875, 4299.355096735452, 4332.588404101605, 4334.826606935687, 4340.848070317524, 3821.9044523887123, 3826.4642949987024, 3840.251151025579, 3870.40008798631, 3907.7069219808627, 4445.066536027471, 4448.888777780581, 4456.131054444352, 4502.662300327489, 4505.932411013838, 4976.2038073908, 4983.476734942851, 5186.066508028591, 5194.402643696023, 5222.791088356499, 4280.957190428118, 4287.314029755286, 4292.828286868553, 4295.0, 4303.827846886152, 4454.4654641442585, 4460.330950357407, 4461.04087621163, 4507.121111383249, 4513.232750432434, 4545.068261006551, 4566.223741963808, 4686.882827929329, 4692.6480513960905, 4697.530246975275, 5143.8456846294675, 5144.228365745019, 5159.871003224949, 5214.7914083436235, 5223.059849227024, 4811.422629284508, 4824.34871292371, 4829.73436460998, 4830.106430310404, 4878.07316609843, 4909.9263511048075, 4952.900941981212, 5071.290019397361, 5080.517350851663, 5123.948760512347, 5061.31672224245, 5086.18621020635, 5103.8468845934685, 5129.563987060992, 5161.432242453402, 5021.623378246573, 5028.723420211777, 5033.471485494117, 5037.748112594282, 5085.084684756779, 4974.0, 4981.153203955264, 4981.875453113701, 4982.153033984159, 4985.43185732655, 4822.638302127425, 4880.145974454385, 4925.975370123127, 4932.8520144395725, 4949.0, 5027.145385284583, 5044.596432285482, 5058.367704036996, 5060.139776237975, 5088.389393272683, 4735.195016847213, 4781.019890922422, 4907.779149938333, 4932.21084626458, 4959.181735013683], "value": 4683.852785552777, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.8780156167205, 588.1383772772887, 588.1618693361961, 596.4989408896528, 597.134155474562, 27313.726862731368, 30239.395212095744, 40114.19771604566, 41477.7926110369, 41872.37191442131, 41484.79257603708, 42141.78929105358, 42213.57786422135, 42216.0, 42269.36595951063, 7739.419543534215, 7858.882116768253, 7869.134395216522, 7872.685092596318, 7877.13351531334, 7522.059742532184, 9826.312158148932, 10110.988901109904, 10114.544845481934, 10451.529681164327, 10223.284370094096, 10294.022067903574, 10295.433751143684, 10300.0, 10306.330088544259, 7623.80940476487, 9907.108360247541, 10102.343347682414, 10178.694639160836, 10182.083612474877, 9811.558479868423, 10144.239182061376, 10155.28912976092, 10158.339707918962, 10162.339447935861, 38673.22653546913, 38820.0, 38920.22159556793, 38929.80535097307, 39002.60997390018, 2972.4055188962293, 3017.4719424100695, 3062.8774849006013, 3108.036508682316, 3548.191074683956, 29445.0, 29632.0, 29641.851790741122, 29981.400371992655, 30868.53697194544, 3085.953710694341, 3087.3516561522106, 3103.906882793497, 3130.076627394924, 3165.3511030238747, 247306.0, 247406.0, 247892.0, 247893.0, 249289.0, 32659.836700816344, 33779.32441351159, 33828.49257261143, 53813.192802108, 54222.0, 34764.47853282203, 34871.4769278461, 34913.650863491544, 34926.82536587301, 34981.30037399289, 13980.161190328612, 14115.294235288195, 14126.50557230492, 14127.15237085778, 14134.575962721136, 10680.092192163753, 11495.3677547734, 11742.0, 11789.115816313812, 11845.052395808314, 8007.199280071946, 8042.155573664798, 8066.798330041678, 8100.71647492335, 8119.594020298961, 3126.515390114536, 3156.6054243219596, 3156.9052928412184, 3181.9522707159413, 3213.9839300803346, 834.5326617094325, 882.6601758322963, 903.8915330160423, 962.9503840813547, 994.0755097759009, 27204.0, 28404.8579757104, 29004.41991160207, 29053.273668158465, 29192.270193244913, 917.4128557723062, 930.7207837648814, 966.0, 1037.9636712715019, 1079.63292480557, 13987.720245595032, 14614.926925365306, 14777.556673299818, 14892.329845156994, 14947.775783363259, 376563.0, 698677.0, 704425.0, 713019.0, 714029.0, 51856.740716296175, 51989.2201616976, 52119.73940130351, 52412.0, 52459.47540524622, 1077.5474300793685, 1197.120116714197, 1226.969325766863, 1230.1880758699215, 1232.0820988363548, 25734.0, 29382.559261610666, 29827.0, 30095.849520752257, 30336.241593960327, 42862.14275714531, 42980.785096074316, 43567.782161088995, 43629.12741745211, 43674.34488482612, 249248.0, 249990.0, 250184.0, 251988.0, 252126.0, 22574.661380078982, 25003.87498062498, 25626.103086391886, 25936.0, 25986.61020084738, 39720.404193936534, 39937.600623993385, 40190.39714404345, 40598.59401405948, 40949.38575921423, 34987.65012349844, 35049.474257886664, 35198.824005879804, 35391.46912796362, 35398.29203415866, 34638.653613463546, 34782.0, 34875.825620871736, 34951.0, 34952.475712864834, 34486.31027379489, 34518.65481345255, 34751.65248347484, 35168.0, 35329.1167720809, 30425.391492170475, 30943.690563094082, 31038.0, 31098.22254443657, 31214.37571248608, 23937.640935385636, 24044.75955240425, 24186.274411767674, 24382.75617243805, 24627.384315392257], "value": 16948.51275715255, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [350.66161154485917, 376.96607305342525, 379.9020829801871, 386.5573917864046, 395.6241570508018, 13155.473781048746, 16513.42203022893, 17089.40187093452, 18559.721604175913, 18577.907110464428, 15525.456609018658, 15813.762793558077, 15980.920095399535, 15995.280212390442, 16203.432879849208, 4710.0, 5081.64428490005, 5306.283651707009, 5307.336582927134, 5308.150695888658, 5126.5898728101665, 5167.9224811627855, 5172.431032586413, 5187.610929180308, 5205.713685747282, 5028.899422011557, 5199.0, 5232.816851410202, 5234.816781412651, 5241.790328386879, 5177.637565370425, 5187.48125187482, 5192.039472697544, 5193.532582067632, 5200.427952925175, 4677.579017888406, 4681.297805329194, 4959.479254678243, 4969.130402179604, 5043.571296439807, 11661.6501504955, 11765.705857353634, 11767.23512971654, 13817.723645527034, 21236.088752012238, 1777.5026088345894, 1855.3413538194018, 1881.5860510687626, 1923.5671973805922, 2006.9864718317156, 9007.819843603156, 9254.583543740548, 9423.246140308827, 9483.573239204252, 9925.65260215889, 1729.161356741979, 1731.3680506615121, 1731.6103876627658, 1739.852112570433, 1808.6563552924902, 65412.672936635485, 70557.64721176361, 71001.64499177471, 71782.0, 73269.0, 8552.57237138153, 9180.8622870657, 9191.494467804336, 9695.854562181574, 10430.947845260876, 13012.15420997651, 13807.17156970565, 13857.584272471842, 13872.098313609584, 14476.420943162155, 7344.339009489172, 7384.4830861839155, 7606.353459955855, 7687.500312479671, 7714.845703085907, 7324.560526368435, 7337.633118344062, 7502.812429689192, 7526.24737526243, 7526.736564220226, 4394.209042372404, 4432.3794668746405, 4514.774261286922, 4573.725576465423, 4632.073585282957, 1857.6934805757169, 1859.739636450898, 1860.9162587683586, 1902.7906930237664, 1909.5608010157741, 798.5089170160426, 802.5786462107324, 833.9874901876477, 837.5979529825718, 866.6706651472526, 16900.323987040625, 17209.311627535008, 17504.737428938577, 17834.286628534974, 17965.910170449326, 830.9750707478785, 841.87792770048, 844.3329769482164, 850.8978922529212, 861.0872475176333, 9751.853722194173, 10047.196224302184, 10052.59789608422, 10073.345232559861, 10208.0, 365292.0, 372390.0, 372434.0, 373156.0, 373996.0, 80912.0, 82425.0, 83199.58400208081, 84031.0, 84826.0, 888.644542183119, 898.5417437107122, 902.2376092202079, 903.6295119001178, 908.1554154636119, 15540.766888496908, 15663.843361566695, 15754.133522656364, 15798.76301855496, 16056.43802466908, 24404.605540328837, 37519.62480375161, 38006.0, 38794.0, 39381.2123757529, 51091.0, 51510.0, 51767.0, 51952.48047519627, 52245.7387713059, 7373.410127189704, 7668.769936901902, 7684.231576842271, 7707.0, 8007.959960200162, 10696.732581685208, 11077.0, 11166.553337866395, 11306.434678266218, 11783.469743861719, 8957.328200384867, 9233.399829011092, 9507.049295070437, 10133.575774529758, 10382.636607718694, 10610.575576977144, 10736.0, 10834.67495975122, 10980.725481863017, 11062.225644205151, 9809.509524523603, 10261.179105671677, 10347.172226222036, 10518.368897866152, 10727.463626818784, 7813.492123011986, 7834.412419068707, 7936.087349954829, 7973.521588704696, 7982.401319900914, 7631.3131818136635, 9198.49408282551, 10188.0, 10417.635382761568, 10627.149828013895], "value": 8083.36163782264, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1343.2209318595217, 1382.702718915433, 1462.8098347214861, 1668.2492878204812, 1690.7041267778136, 7678.117016543099, 8134.105248422668, 8199.344052475803, 8201.63092660831, 8221.876671849912, 6761.323867613249, 6935.583864968105, 6965.965170174142, 7178.13862336519, 8004.159563245863, 1929.0740444586606, 2178.2376168341034, 2246.618074927266, 2256.007356763019, 2258.4128126687096, 2207.128184367174, 2216.7672394398596, 2252.2117258959397, 2255.086689890597, 2270.5685919675207, 1908.2271679969565, 2208.392692009702, 2254.3800454874877, 2254.718160229971, 2259.2318611672026, 2146.6565349544076, 2228.1198926424136, 2229.6878437018913, 2241.237979087118, 2243.9102435902546, 2175.1299480207886, 2213.9778602213933, 2235.675827005075, 2237.9216727414623, 2240.540689158735, 8101.797455063612, 8145.226203510657, 8148.877766833502, 8156.714514992006, 8159.755207343789, 4713.340132381435, 4791.6406269529925, 4823.397075365579, 4827.106985207748, 4868.878278043042, 2774.902878399246, 2858.5997960285576, 2890.9710902891125, 2903.2306438793735, 2904.8983285584904, 905.6965916418008, 928.6007016982695, 942.9952850235774, 945.2532499325524, 948.2650945517279, 10619.78760424795, 10853.728656783565, 10862.674119776419, 10901.563937442494, 10928.453577321181, 4018.698597605133, 4384.079343337871, 4402.84590039347, 4489.932651010172, 4502.977485112553, 9418.717438476857, 9461.05389461062, 9501.097395747393, 9504.714858554255, 9511.381760185566, 4669.2062349400685, 4674.976625116853, 4678.274867395559, 4691.83578574755, 4694.0, 4241.936370954438, 4254.7021708480725, 4258.638015768633, 4303.117860838521, 4308.870733877989, 3711.387621042552, 3750.887473375803, 3769.3968964965475, 3800.049987503124, 3827.9617203827606, 1217.4825699077855, 1228.520876858026, 1229.287013532149, 1230.655416483386, 1246.0716766009382, 850.1456036683218, 856.1737922904302, 858.6436628799104, 870.4907629036958, 874.4359887872414, 5407.810726624549, 5573.942343691501, 5589.944100558942, 5610.607257492018, 5710.371859095496, 392.268419397821, 394.9743266687656, 398.94215338776297, 399.5884239233594, 412.015283472501, 3654.8720794772057, 3739.794311312904, 3896.551896531935, 3924.1955399143108, 3929.233799409145, 9140.314476414163, 9906.0, 9923.751906202258, 9925.30522863407, 9934.254930880214, 9724.756881077888, 9805.509724513746, 9820.803583928282, 9859.753506162404, 9867.901320986843, 7188.137423509108, 7422.554646721214, 7438.888416673754, 7602.1257555381835, 7643.388528917673, 5584.441555844383, 5668.263125793786, 5758.366579676149, 5786.045302525036, 5851.970740146442, 9162.770930726785, 9166.358354915359, 9199.126083022102, 9386.342955993015, 9429.481378524248, 9127.90465144187, 9166.22087122602, 9319.0, 9568.617255309988, 9598.712038638572, 6628.436582890508, 7413.147488038729, 7575.242475752601, 7590.0891892973195, 7844.725434609762, 7885.2114788520685, 7940.325072368913, 8020.0, 8026.478278911852, 8038.598070096355, 6623.834404139935, 6819.829504262433, 6852.451803855779, 6852.725890964505, 6960.37356637905, 6620.404163625297, 6665.0, 6876.140482439695, 6925.896111558432, 6983.790486285419, 6273.341299163704, 6564.409203171737, 6599.868002639824, 6772.661366931732, 6779.457643388616, 4797.18447863857, 4942.950570494393, 4981.078500477278, 5022.799088036584, 5085.847424577269, 4771.093492236464, 4910.6562540623245, 4938.802447902043, 4970.682769066273, 5001.42483614389], "value": 4180.574781551905, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [297.1175608442924, 304.6313960108269, 306.09701380926265, 312.89205224197644, 313.1357453428537, 4838.10495058414, 4845.3216549683075, 4845.660803743739, 4865.878353041176, 4874.0982918160125, 4760.595349395306, 4803.63972702047, 4815.66290359675, 4831.9275210871865, 4833.250846118848, 3609.368360536902, 3738.8504459821575, 3757.8308976096005, 3858.459815625815, 3880.708946828985, 3818.2363527294515, 3822.9808850955847, 3832.080300727833, 3842.5004749382542, 3848.8845334639864, 3625.0393645683916, 3793.905152371199, 3799.183175617242, 3801.9429708554394, 3807.2385522895534, 3663.120850995755, 3760.8119594020327, 3778.6410291022307, 3791.298609757176, 3801.353769859131, 3344.5484859543894, 3370.713489353408, 3377.375185590649, 3383.5263063171174, 3396.9490457643155, 4714.504976977402, 4731.083911016044, 4742.439082895233, 4743.620510359163, 4744.715317080986, 4248.808803603814, 4346.935000924762, 4354.651627869763, 4375.606195442426, 4380.145871555048, 5016.620429381913, 5028.748562571856, 5034.84895453137, 5052.595792336604, 5059.519345662156, 3700.4634328022285, 3704.1850792825535, 3705.962940370616, 3706.8517259309865, 3727.8881633551036, 5091.134507133796, 5248.186531087649, 5263.552598029172, 5328.147496400557, 5340.946590534084, 3760.172761992357, 3771.6610603236004, 3775.754575952554, 3779.7165212609166, 3781.111438811877, 3828.5214348206473, 3834.61953696669, 3835.6547910687614, 3837.6737977271687, 3838.2323535293053, 4343.261645520269, 4362.76004819738, 4365.80353884076, 4370.606645401929, 4374.693771436033, 4876.414830220326, 5027.924581131286, 5037.571806396498, 5048.268001139814, 5049.84850454487, 1304.2500562176785, 1323.6690827293178, 1323.8146659467682, 1327.157255142991, 1327.4358397680946, 857.9575815384338, 858.6307887608264, 865.536937738307, 890.5191196753681, 921.7787730944525, 4432.977835110803, 4435.844745433894, 4437.112577484516, 4450.821967121344, 4470.0, 5124.282600435942, 5131.512506311969, 5158.174692049329, 5164.767585458663, 5174.870628234325, 4261.446012018418, 4414.3157810539415, 4420.877978570305, 4423.977880110579, 4440.777961101997, 2769.3353595137023, 2792.46943080814, 2803.1310293808983, 2812.2406950123354, 2819.4220184862056, 4933.569264913135, 4936.7284799336385, 4953.0, 4963.181075122564, 4981.950180498221, 5127.87180320495, 5347.385050719217, 5364.409914909357, 5374.48942350476, 5437.646552974044, 4921.212605983097, 4953.405591329064, 4956.256561515802, 4964.280179373971, 4970.378702662168, 5271.89456210866, 5274.815381461631, 5279.287296214962, 5317.202419637086, 5354.598405119709, 4932.210846264724, 5177.430482646982, 5192.948070519246, 5231.89536209266, 5234.2672025915645, 4954.355933728592, 4961.801527938842, 4979.004199160255, 4981.701097934136, 4992.176290911959, 3711.461838033524, 3718.6095459977396, 3721.9069523262133, 3723.851045958131, 3724.478572999728, 5058.418281897481, 5201.427842937198, 5217.399999000164, 5278.97360513195, 5292.947070529245, 5044.679447454212, 5076.898462030665, 5080.872978175576, 5089.211172268304, 5090.2364645303505, 5051.797928082982, 5067.569256613229, 5068.3917929847175, 5089.821856235014, 5091.949080509147, 4720.409948756405, 5007.148784706682, 5024.472430394902, 5025.522575355335, 5028.622853286091, 4874.513273451631, 4948.1835497142565, 5074.086664400444, 5111.642185047011, 5112.156494178419, 4966.875828104182, 4985.576226020684, 4988.002399520038, 4995.17579599362, 4998.525140111684], "value": 3845.206907794289, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [597.0983814440197, 639.1148259660371, 684.7295318349252, 694.6839188169383, 759.8176437654964, 12386.0, 13044.08691391603, 13224.27266500342, 13272.800907986388, 13496.662583435407, 12195.878041219585, 12232.082593805455, 12309.199902006363, 12327.876721232786, 12328.075394345415, 638.4094712391043, 767.3132546370995, 793.6388943030936, 795.7175202802994, 815.1807433529324, 805.794522396788, 805.8710606302964, 807.7011505742854, 809.0736107157302, 809.7489778168757, 836.8410002099612, 837.2590257621988, 837.7109897085496, 837.7235512280963, 837.8031162676766, 657.7500549791073, 797.8204903896577, 826.0747962282222, 833.5707110837923, 835.1022650650575, 616.1097214525013, 616.6423474384846, 616.8334549671564, 617.1267656266377, 618.916446279751, 12838.486460541568, 12924.870751292461, 12954.0, 12993.610191694264, 13035.739285214337, 12051.096167787451, 12509.249445033327, 12695.492180312776, 12724.554640587628, 12914.741705165938, 11383.373914434702, 11397.48711307985, 11603.303801771921, 11647.534098636044, 12053.698657533545, 4052.0, 4114.033202197481, 4209.179210054041, 4260.744355338689, 4261.403403523478, 58135.0, 58386.0, 58549.70725146347, 58573.414265857224, 58879.705601472146, 9865.1121399073, 10103.84844227337, 10214.489275536194, 10261.28171028021, 10663.146948244123, 18501.90749046246, 18610.627787444446, 18738.81261187398, 18739.812601873808, 18767.0616469176, 6516.348365163541, 6544.770933017321, 6586.209654841354, 6658.067870498134, 6693.069700037773, 3414.8804791832167, 3440.2947395784304, 3445.638207988175, 3465.9480107798404, 3492.7555071145284, 2693.4747724193594, 2784.9721502784714, 2793.7625301849166, 2795.021742390147, 2795.2872017635373, 427.92511310520536, 439.03631528794625, 439.7954950947761, 455.6901307111196, 456.31097043463944, 437.87739432958824, 513.7148882370245, 518.8132272381939, 525.7739172155933, 552.8009916430082, 7393.593352365671, 7533.0, 7928.841423171504, 7982.84034319322, 8034.558099304594, 447.5077414843646, 450.9932351014737, 516.3107251818864, 525.4456548341536, 531.5269410224903, 3679.3193259247123, 3776.9244615107546, 3778.8677396290996, 3819.8854034379015, 3900.239453306578, 54235.72882135643, 54412.727936360854, 86701.0, 91811.54094229486, 92944.0, 71956.0, 77703.22296777074, 78002.60998695083, 78113.21886781174, 78535.60732196302, 58171.0, 68282.31717682858, 69587.30412695809, 69653.65173174204, 70535.0, 7468.439867009887, 7481.364084052916, 7522.097348318237, 7554.471187016856, 7574.0, 44124.0, 44274.0, 44480.05254960182, 44755.0, 45155.09689806251, 59373.703131484064, 60124.09813852883, 62415.0, 65118.674406627666, 65596.0, 9775.706728798148, 10025.0, 10043.69868903934, 10074.798504030025, 10338.896611033793, 11131.276467029616, 11170.944145279222, 11240.0, 11717.882821172021, 11828.526858925547, 9733.561989710339, 10208.795824083625, 10293.845592316271, 10302.381857088598, 10317.638882639072, 9716.951415242878, 10094.343867648578, 10333.689989300334, 10599.417032063311, 10635.096016838655, 8821.426607270507, 8891.333150013645, 10088.495575221063, 10296.433696146783, 10630.787384252117, 8302.460340077876, 8305.626246819029, 8398.887326892669, 8464.280536154496, 8591.742247732578, 8609.053004169411, 8643.654253829776, 8745.169208925143, 8770.298376129767, 8980.640774368952], "value": 6211.549808929569, "unit": "score"}], "name": "dromaeo_css", "value": 6325.889007659168, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 113.0, 113.0, 113.0, 114.0, 114.0, 112.0, 115.0, 113.0], "value": 112.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 127.0, 129.0, 179.0, 123.0, 125.0, 148.0, 128.0, 163.0, 125.0], "value": 139.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 160.0, 159.0, 161.0, 163.0, 161.0, 161.0, 161.0, 162.0, 161.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 76.0, 77.0, 117.0, 76.0, 76.0, 77.0, 76.0, 97.0, 76.0], "value": 82.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 117.0, 85.0, 85.0, 85.0, 120.0, 85.0, 85.0, 127.0], "value": 95.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 117.0, 116.0, 118.0, 118.0, 118.0, 118.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0], "value": 146.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0], "value": 94.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 64.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 65.0, 64.0], "value": 65.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 65.0, 65.0, 65.0, 64.0, 66.0, 70.0, 72.0, 65.0], "value": 66.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 81.0, 78.0, 78.0, 80.0, 79.0, 78.0, 80.0, 78.0], "value": 79.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 143.0, 126.0, 136.0, 127.0, 132.0, 129.0, 181.0, 128.0], "value": 136.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [170.0, 163.0, 166.0, 164.0, 164.0, 164.0, 166.0, 165.0, 170.0, 163.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 66.0, 66.0, 65.0, 69.0, 65.0, 66.0, 67.0, 65.0], "value": 66.4, "unit": "score"}], "name": "kraken", "value": 1529.6000000000001, "alertThreshold": 2.0}]} 08:19:06 INFO - Return code: 0 08:19:06 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:19:06 INFO - # TBPL SUCCESS # 08:19:06 INFO - Running post-action listener: _resource_record_post_action 08:19:06 INFO - ##### 08:19:06 INFO - ##### Finished run-tests step (success) 08:19:06 INFO - ##### 08:19:06 INFO - Running post-run listener: _resource_record_post_run 08:19:06 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 535482368; Read time: 12; Write time: 402392 08:19:06 INFO - TinderboxPrint: CPU usage
13.0% 08:19:06 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 08:19:06 INFO - TinderboxPrint: I/O write bytes / time
535,482,368 / 402,392 08:19:06 INFO - TinderboxPrint: CPU idle
8,336.1 (87.0%) 08:19:06 INFO - TinderboxPrint: CPU user
1,200.6 (12.5%) 08:19:06 INFO - TinderboxPrint: Swap in / out
0 / 0 08:19:06 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 246935552; Read time: 0; Write time: 245796 08:19:06 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 288546816; Read time: 0; Write time: 156596 08:19:07 INFO - Running post-run listener: _upload_blobber_files 08:19:07 INFO - Blob upload gear active. 08:19:07 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:19:07 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 08:19:07 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-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:19:07 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-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:19:07 INFO - (blobuploader) - INFO - Open directory for files ... 08:19:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:19:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:11 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:19:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:11 INFO - (blobuploader) - INFO - Done attempting. 08:19:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:19:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:19:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:12 INFO - (blobuploader) - INFO - Done attempting. 08:19:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:19:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:19:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:19:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:19:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:19:13 INFO - (blobuploader) - INFO - Done attempting. 08:19:13 INFO - (blobuploader) - INFO - Iteration through files over. 08:19:13 INFO - Return code: 0 08:19:13 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:19:13 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:19:13 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/863f27abbea683e063abc2b655c9dc5687d15d7a31652a1c1400f6cc33dbcb692226d55d1d147787003dae944fdf36380653c8db2b945bcd06d26846303abae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/31a176abae830e3642f3585ea5849161571f762f7a6c4991ec494f7dd0edd27c223ea96c9725584f51c01e371629a976dd22a582345fa0be4aabc1ea0a14ac28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/80f2bea912d9bc8c5fbe7167ec171bb52e7122f6a0064d3ab857c99ed79954e5ea7441dcbdbe40ca570f83922fb449bd933b590c9b623dac40287160c4479560"} 08:19:13 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:19:13 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:19:13 INFO - Contents: 08:19:13 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/863f27abbea683e063abc2b655c9dc5687d15d7a31652a1c1400f6cc33dbcb692226d55d1d147787003dae944fdf36380653c8db2b945bcd06d26846303abae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/31a176abae830e3642f3585ea5849161571f762f7a6c4991ec494f7dd0edd27c223ea96c9725584f51c01e371629a976dd22a582345fa0be4aabc1ea0a14ac28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/80f2bea912d9bc8c5fbe7167ec171bb52e7122f6a0064d3ab857c99ed79954e5ea7441dcbdbe40ca570f83922fb449bd933b590c9b623dac40287160c4479560"} 08:19:13 INFO - Running post-run listener: copy_logs_to_upload_dir 08:19:13 INFO - Copying logs to upload dir... 08:19:13 INFO - mkdir: /builds/slave/test/build/upload/logs 08:19:13 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.813814 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-14 08:19:12.859948) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 08:19:12.863734) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/863f27abbea683e063abc2b655c9dc5687d15d7a31652a1c1400f6cc33dbcb692226d55d1d147787003dae944fdf36380653c8db2b945bcd06d26846303abae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/31a176abae830e3642f3585ea5849161571f762f7a6c4991ec494f7dd0edd27c223ea96c9725584f51c01e371629a976dd22a582345fa0be4aabc1ea0a14ac28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/80f2bea912d9bc8c5fbe7167ec171bb52e7122f6a0064d3ab857c99ed79954e5ea7441dcbdbe40ca570f83922fb449bd933b590c9b623dac40287160c4479560"} build_url:https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011193 build_url: 'https://queue.taskcluster.net/v1/task/ArYii_oYRoCXDVal5T-VJA/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/863f27abbea683e063abc2b655c9dc5687d15d7a31652a1c1400f6cc33dbcb692226d55d1d147787003dae944fdf36380653c8db2b945bcd06d26846303abae8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/31a176abae830e3642f3585ea5849161571f762f7a6c4991ec494f7dd0edd27c223ea96c9725584f51c01e371629a976dd22a582345fa0be4aabc1ea0a14ac28", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/80f2bea912d9bc8c5fbe7167ec171bb52e7122f6a0064d3ab857c99ed79954e5ea7441dcbdbe40ca570f83922fb449bd933b590c9b623dac40287160c4479560"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-14 08:19:12.889304) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:19:12.889652) ========= 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=8887e36bb8e381bfd44124ac000001a8-1468506399.483319-1795926099 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004483 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-14 08:19:12.974466) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 08:19:12.974813) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-14 08:19:12.975146) ========= ========= Total master_lag: 0.19 =========