builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-020 starttime: 1468916220.45 results: success (0) buildid: 20160719003820 builduid: 0cd6bb32568f442ba3fdf44440abffe4 revision: 69741c30f7d501fa901bf77059840ad3f54cbbf4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:00.453476) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:00.453866) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:00.454159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:00.495413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:00.495683) ========= 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=af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-19 01:17:00-- 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% 25.7M=0s 2016-07-19 01:17:00 (25.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104437 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:00.620227) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:00.620501) ========= 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=af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022122 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:00.669584) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:00.669899) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev 69741c30f7d501fa901bf77059840ad3f54cbbf4 --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 69741c30f7d501fa901bf77059840ad3f54cbbf4 --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=af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-19 01:17:00,881 truncating revision to first 12 chars 2016-07-19 01:17:00,881 Setting DEBUG logging. 2016-07-19 01:17:00,881 attempt 1/10 2016-07-19 01:17:00,881 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/69741c30f7d5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-19 01:17:01,204 unpacking tar archive at: autoland-69741c30f7d5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.666457 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:01.350337) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:01.350641) ========= script_repo_revision: 69741c30f7d501fa901bf77059840ad3f54cbbf4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:01.351008) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:01.351278) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-19 01:17:01.361599) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-19 01:17:01.361860) ========= /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=af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 01:17:01 INFO - MultiFileLogger online at 20160719 01:17:01 in /builds/slave/test 01:17:01 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 01:17:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 01:17:01 INFO - {'append_to_log': False, 01:17:01 INFO - 'base_work_dir': '/builds/slave/test', 01:17:01 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 01:17:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 01:17:01 INFO - 'branch': 'Autoland-Non-PGO', 01:17:01 INFO - 'buildbot_json_path': 'buildprops.json', 01:17:01 INFO - 'config_files': ('talos/linux_config.py',), 01:17:01 INFO - 'default_actions': ('clobber', 01:17:01 INFO - 'read-buildbot-config', 01:17:01 INFO - 'download-and-extract', 01:17:01 INFO - 'populate-webroot', 01:17:01 INFO - 'create-virtualenv', 01:17:01 INFO - 'install', 01:17:01 INFO - 'run-tests'), 01:17:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 01:17:01 INFO - 'download_minidump_stackwalk': True, 01:17:01 INFO - 'download_symbols': 'ondemand', 01:17:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 01:17:01 INFO - 'tooltool.py': '/tools/tooltool.py', 01:17:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 01:17:01 INFO - '/tools/misc-python/virtualenv.py')}, 01:17:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 01:17:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 01:17:01 INFO - 'installer_path': 'installer.exe', 01:17:01 INFO - 'log_level': 'info', 01:17:01 INFO - 'log_name': 'talos', 01:17:01 INFO - 'log_to_console': True, 01:17:01 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 01:17:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 01:17:01 INFO - 'opt_config_files': (), 01:17:01 INFO - 'pip_index': False, 01:17:01 INFO - 'sps_profile': False, 01:17:01 INFO - 'sps_profile_interval': 0, 01:17:01 INFO - 'suite': 'dromaeojs', 01:17:01 INFO - 'system_bits': '32', 01:17:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 01:17:01 INFO - 'title': 'talos-linux64-ix-020', 01:17:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 01:17:01 INFO - 'use_talos_json': True, 01:17:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 01:17:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 01:17:01 INFO - 'work_dir': 'build'} 01:17:01 INFO - ##### 01:17:01 INFO - ##### Running clobber step. 01:17:01 INFO - ##### 01:17:01 INFO - Running pre-action listener: _resource_record_pre_action 01:17:01 INFO - Running main action method: clobber 01:17:01 INFO - rmtree: /builds/slave/test/build 01:17:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 01:17:02 INFO - Running post-action listener: _resource_record_post_action 01:17:02 INFO - ##### 01:17:02 INFO - ##### Finished clobber step (success) 01:17:02 INFO - ##### 01:17:02 INFO - ##### 01:17:02 INFO - ##### Running read-buildbot-config step. 01:17:02 INFO - ##### 01:17:02 INFO - Running pre-action listener: _resource_record_pre_action 01:17:02 INFO - Running main action method: read_buildbot_config 01:17:02 INFO - Using buildbot properties: 01:17:02 INFO - { 01:17:02 INFO - "project": "", 01:17:02 INFO - "product": "firefox", 01:17:02 INFO - "script_repo_revision": "production", 01:17:02 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 01:17:02 INFO - "repository": "", 01:17:02 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 01:17:02 INFO - "buildid": "20160719003820", 01:17:02 INFO - "pgo_build": "False", 01:17:02 INFO - "basedir": "/builds/slave/test", 01:17:02 INFO - "buildnumber": 65, 01:17:02 INFO - "slavename": "talos-linux64-ix-020", 01:17:02 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 01:17:02 INFO - "platform": "ubuntu64_hw", 01:17:02 INFO - "scheduler": "tests-autoland-linux64-talos", 01:17:02 INFO - "branch": "autoland", 01:17:02 INFO - "repo_path": "integration/autoland", 01:17:02 INFO - "revision": "69741c30f7d501fa901bf77059840ad3f54cbbf4", 01:17:02 INFO - "stage_platform": "linux64", 01:17:02 INFO - "builduid": "0cd6bb32568f442ba3fdf44440abffe4", 01:17:02 INFO - "slavebuilddir": "test" 01:17:02 INFO - } 01:17:02 INFO - Found installer url https://queue.taskcluster.net/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 01:17:02 INFO - Running post-action listener: _resource_record_post_action 01:17:02 INFO - ##### 01:17:02 INFO - ##### Finished read-buildbot-config step (success) 01:17:02 INFO - ##### 01:17:02 INFO - ##### 01:17:02 INFO - ##### Running download-and-extract step. 01:17:02 INFO - ##### 01:17:02 INFO - Running pre-action listener: _resource_record_pre_action 01:17:02 INFO - Running main action method: download_and_extract 01:17:02 INFO - mkdir: /builds/slave/test/build/tests 01:17:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:02 INFO - https://queue.taskcluster.net/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 01:17:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:17:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:17:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:17:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json'}, attempt #1 01:17:06 INFO - Downloaded 1361 bytes. 01:17:06 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 01:17:06 INFO - Using the following test package requirements: 01:17:06 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:17:06 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 01:17:06 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 01:17:06 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:06 INFO - u'jsshell-linux-x86_64.zip'], 01:17:06 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 01:17:06 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 01:17:06 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 01:17:06 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 01:17:06 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 01:17:06 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 01:17:06 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 01:17:06 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 01:17:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:06 INFO - https://queue.taskcluster.net/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:17:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:17:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:17:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:17:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:17:11 INFO - Downloaded 22765536 bytes. 01:17:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:17:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:17:13 INFO - Return code: 0 01:17:13 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 01:17:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:13 INFO - https://queue.taskcluster.net/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 01:17:13 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:17:13 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:17:13 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 01:17:13 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 01:17:15 INFO - Downloaded 22765536 bytes. 01:17:15 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:17:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 01:17:16 INFO - Return code: 0 01:17:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:16 INFO - https://queue.taskcluster.net/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 01:17:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:17:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:17:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 01:17:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 01:17:17 INFO - Downloaded 14403317 bytes. 01:17:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 01:17:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 01:17:17 INFO - Return code: 0 01:17:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:17 INFO - https://queue.taskcluster.net/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 01:17:17 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:17:17 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:17:17 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:17:17 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 01:17:19 INFO - Downloaded 57132819 bytes. 01:17:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:17:19 INFO - mkdir: /builds/slave/test/properties 01:17:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 01:17:19 INFO - Writing to file /builds/slave/test/properties/build_url 01:17:19 INFO - Contents: 01:17:19 INFO - build_url:https://queue.taskcluster.net/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 01:17:19 INFO - Running post-action listener: _resource_record_post_action 01:17:19 INFO - Running post-action listener: set_extra_try_arguments 01:17:19 INFO - ##### 01:17:19 INFO - ##### Finished download-and-extract step (success) 01:17:19 INFO - ##### 01:17:19 INFO - ##### 01:17:19 INFO - ##### Running populate-webroot step. 01:17:19 INFO - ##### 01:17:19 INFO - Running pre-action listener: _resource_record_pre_action 01:17:19 INFO - Running main action method: populate_webroot 01:17:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 01:17:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 01:17:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 01:17:19 INFO - '--tppagecycles', 01:17:19 INFO - '7'], 01:17:19 INFO - 'tests': ['tsvgm']}}, 01:17:19 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 01:17:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 01:17:19 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 01:17:19 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 01:17:19 INFO - 'tests': ['dromaeo_css', 'kraken']}, 01:17:19 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 01:17:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:19 INFO - 'talos_options': ['--disable-e10s'], 01:17:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:17:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 01:17:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:19 INFO - 'talos_options': ['--disable-e10s'], 01:17:19 INFO - 'tests': ['damp', 'tps']}, 01:17:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:19 INFO - 'tests': ['damp', 'tps']}, 01:17:19 INFO - 'g3': {'talos_options': ['--disable-e10s'], 01:17:19 INFO - 'tests': ['dromaeo_dom']}, 01:17:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 01:17:19 INFO - 'g4': {'talos_options': ['--disable-e10s'], 01:17:19 INFO - 'tests': ['basic_compositor_video']}, 01:17:19 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 01:17:19 INFO - 'other': {'talos_options': ['--disable-e10s'], 01:17:19 INFO - 'tests': ['a11yr', 01:17:19 INFO - 'ts_paint', 01:17:19 INFO - 'tpaint', 01:17:19 INFO - 'sessionrestore', 01:17:19 INFO - 'sessionrestore_no_auto_restore', 01:17:19 INFO - 'tabpaint']}, 01:17:19 INFO - 'other-e10s': {'tests': ['a11yr', 01:17:19 INFO - 'ts_paint', 01:17:19 INFO - 'tpaint', 01:17:19 INFO - 'sessionrestore', 01:17:19 INFO - 'sessionrestore_no_auto_restore', 01:17:19 INFO - 'tabpaint']}, 01:17:19 INFO - 'other-e10s_l64': {'tests': ['a11yr', 01:17:19 INFO - 'ts_paint', 01:17:19 INFO - 'tpaint', 01:17:19 INFO - 'sessionrestore', 01:17:19 INFO - 'sessionrestore_no_auto_restore', 01:17:19 INFO - 'tabpaint']}, 01:17:19 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 01:17:19 INFO - 'ts_paint', 01:17:19 INFO - 'tpaint', 01:17:19 INFO - 'sessionrestore', 01:17:19 INFO - 'sessionrestore_no_auto_restore', 01:17:19 INFO - 'tabpaint']}, 01:17:19 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 01:17:19 INFO - 'tests': ['a11yr', 01:17:19 INFO - 'ts_paint', 01:17:19 INFO - 'tpaint', 01:17:19 INFO - 'sessionrestore', 01:17:19 INFO - 'sessionrestore_no_auto_restore', 01:17:19 INFO - 'tabpaint']}, 01:17:19 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 01:17:19 INFO - 'tests': ['a11yr', 01:17:19 INFO - 'ts_paint', 01:17:19 INFO - 'tpaint', 01:17:19 INFO - 'sessionrestore', 01:17:19 INFO - 'sessionrestore_no_auto_restore', 01:17:19 INFO - 'tabpaint']}, 01:17:19 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 01:17:19 INFO - 'tests': ['tsvgx', 01:17:19 INFO - 'tsvgr_opacity', 01:17:19 INFO - 'tart', 01:17:19 INFO - 'tscrollx', 01:17:19 INFO - 'cart']}, 01:17:19 INFO - 'svgr-e10s': {'tests': ['tsvgx', 01:17:19 INFO - 'tsvgr_opacity', 01:17:19 INFO - 'tart', 01:17:19 INFO - 'tscrollx', 01:17:19 INFO - 'cart']}, 01:17:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:19 INFO - 'talos_options': ['--disable-e10s'], 01:17:19 INFO - 'tests': ['tp5o']}, 01:17:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:19 INFO - 'tests': ['tp5o']}, 01:17:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:19 INFO - 'talos_options': ['--disable-e10s', 01:17:19 INFO - '--xperf_path', 01:17:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:17:19 INFO - 'tests': ['tp5n']}, 01:17:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 01:17:19 INFO - 'talos_options': ['--xperf_path', 01:17:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 01:17:19 INFO - 'tests': ['tp5n']}}, 01:17:19 INFO - 'talos.zip': {'path': '', 01:17:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 01:17:19 INFO - Running post-action listener: _resource_record_post_action 01:17:19 INFO - ##### 01:17:19 INFO - ##### Finished populate-webroot step (success) 01:17:19 INFO - ##### 01:17:19 INFO - ##### 01:17:19 INFO - ##### Running create-virtualenv step. 01:17:19 INFO - ##### 01:17:19 INFO - Running pre-action listener: _resource_record_pre_action 01:17:19 INFO - Running main action method: create_virtualenv 01:17:19 INFO - Creating virtualenv /builds/slave/test/build/venv 01:17:19 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 01:17:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 01:17:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 01:17:19 INFO - Using real prefix '/usr' 01:17:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 01:17:20 INFO - Installing distribute.............................................................................................................................................................................................done. 01:17:22 INFO - Installing pip.................done. 01:17:22 INFO - Return code: 0 01:17:22 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 01:17: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')]} 01:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17: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')]} 01:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:22 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 0x1e7d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c3b0>, '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 0x213d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 01:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 01:17:22 INFO - Using env: {'DISPLAY': ':0', 01:17:22 INFO - 'HOME': '/home/cltbld', 01:17:22 INFO - 'LANG': 'en_US.UTF-8', 01:17:22 INFO - 'LANGUAGE': 'en_US:en', 01:17:22 INFO - 'LOGNAME': 'cltbld', 01:17:22 INFO - 'MAIL': '/var/mail/cltbld', 01:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:22 INFO - 'MOZ_NO_REMOTE': '1', 01:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:22 INFO - 'NO_EM_RESTART': '1', 01:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:22 INFO - 'PWD': '/builds/slave/test', 01:17:22 INFO - 'SHELL': '/bin/bash', 01:17:22 INFO - 'SHLVL': '1', 01:17:22 INFO - 'TERM': 'linux', 01:17:22 INFO - 'TMOUT': '86400', 01:17:22 INFO - 'USER': 'cltbld', 01:17:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 01:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:22 INFO - '_': '/tools/buildbot/bin/python'} 01:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:22 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 01:17:22 INFO - Cleaning up... 01:17:22 INFO - Return code: 0 01:17:22 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 01:17: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')]} 01:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17: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')]} 01:17:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:22 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 0x1e7d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c3b0>, '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 0x213d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:17:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 01:17:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 01:17:22 INFO - Using env: {'DISPLAY': ':0', 01:17:22 INFO - 'HOME': '/home/cltbld', 01:17:22 INFO - 'LANG': 'en_US.UTF-8', 01:17:22 INFO - 'LANGUAGE': 'en_US:en', 01:17:22 INFO - 'LOGNAME': 'cltbld', 01:17:22 INFO - 'MAIL': '/var/mail/cltbld', 01:17:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:22 INFO - 'MOZ_NO_REMOTE': '1', 01:17:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:22 INFO - 'NO_EM_RESTART': '1', 01:17:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:22 INFO - 'PWD': '/builds/slave/test', 01:17:22 INFO - 'SHELL': '/bin/bash', 01:17:22 INFO - 'SHLVL': '1', 01:17:22 INFO - 'TERM': 'linux', 01:17:22 INFO - 'TMOUT': '86400', 01:17:22 INFO - 'USER': 'cltbld', 01:17:22 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 01:17:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:22 INFO - '_': '/tools/buildbot/bin/python'} 01:17:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:22 INFO - Downloading/unpacking psutil>=3.1.1 01:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 01:17:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:17:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:17:24 INFO - Installing collected packages: psutil 01:17:24 INFO - Running setup.py install for psutil 01:17:24 INFO - building 'psutil._psutil_linux' extension 01:17:24 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 01:17:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 01:17:25 INFO - building 'psutil._psutil_posix' extension 01:17:25 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 01:17:25 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 01:17:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 01:17:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 01:17:25 INFO - Successfully installed psutil 01:17:25 INFO - Cleaning up... 01:17:25 INFO - Return code: 0 01:17:25 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 01:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:25 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 0x1e7d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c3b0>, '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 0x213d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:17:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 01:17:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 01:17:25 INFO - Using env: {'DISPLAY': ':0', 01:17:25 INFO - 'HOME': '/home/cltbld', 01:17:25 INFO - 'LANG': 'en_US.UTF-8', 01:17:25 INFO - 'LANGUAGE': 'en_US:en', 01:17:25 INFO - 'LOGNAME': 'cltbld', 01:17:25 INFO - 'MAIL': '/var/mail/cltbld', 01:17:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:25 INFO - 'MOZ_NO_REMOTE': '1', 01:17:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:25 INFO - 'NO_EM_RESTART': '1', 01:17:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:25 INFO - 'PWD': '/builds/slave/test', 01:17:25 INFO - 'SHELL': '/bin/bash', 01:17:25 INFO - 'SHLVL': '1', 01:17:25 INFO - 'TERM': 'linux', 01:17:25 INFO - 'TMOUT': '86400', 01:17:25 INFO - 'USER': 'cltbld', 01:17:25 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 01:17:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:25 INFO - '_': '/tools/buildbot/bin/python'} 01:17:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:25 INFO - Downloading/unpacking mozsystemmonitor==0.3 01:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:27 INFO - Downloading mozsystemmonitor-0.3.tar.gz 01:17:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 01:17:27 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 01:17:27 INFO - Installing collected packages: mozsystemmonitor 01:17:27 INFO - Running setup.py install for mozsystemmonitor 01:17:27 INFO - Successfully installed mozsystemmonitor 01:17:27 INFO - Cleaning up... 01:17:27 INFO - Return code: 0 01:17:27 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 01:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:27 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 0x1e7d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c3b0>, '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 0x213d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:17:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 01:17:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 01:17:27 INFO - Using env: {'DISPLAY': ':0', 01:17:27 INFO - 'HOME': '/home/cltbld', 01:17:27 INFO - 'LANG': 'en_US.UTF-8', 01:17:27 INFO - 'LANGUAGE': 'en_US:en', 01:17:27 INFO - 'LOGNAME': 'cltbld', 01:17:27 INFO - 'MAIL': '/var/mail/cltbld', 01:17:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:27 INFO - 'MOZ_NO_REMOTE': '1', 01:17:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:27 INFO - 'NO_EM_RESTART': '1', 01:17:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:27 INFO - 'PWD': '/builds/slave/test', 01:17:27 INFO - 'SHELL': '/bin/bash', 01:17:27 INFO - 'SHLVL': '1', 01:17:27 INFO - 'TERM': 'linux', 01:17:27 INFO - 'TMOUT': '86400', 01:17:27 INFO - 'USER': 'cltbld', 01:17:27 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 01:17:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:27 INFO - '_': '/tools/buildbot/bin/python'} 01:17:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:27 INFO - Downloading/unpacking jsonschema==2.5.1 01:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:30 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 01:17:30 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 01:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:30 INFO - Downloading functools32-3.2.3-2.tar.gz 01:17:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 01:17:30 INFO - warning: no files found matching '*.txt' 01:17:30 INFO - no previously-included directories found matching 'build' 01:17:30 INFO - no previously-included directories found matching 'dist' 01:17:30 INFO - no previously-included directories found matching '.git*' 01:17:30 INFO - Installing collected packages: jsonschema, functools32 01:17:30 INFO - Running setup.py install for functools32 01:17:30 INFO - warning: no files found matching '*.txt' 01:17:30 INFO - no previously-included directories found matching 'build' 01:17:30 INFO - no previously-included directories found matching 'dist' 01:17:30 INFO - no previously-included directories found matching '.git*' 01:17:30 INFO - Successfully installed jsonschema functools32 01:17:30 INFO - Cleaning up... 01:17:30 INFO - Return code: 0 01:17:30 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 01:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:30 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 0x1e7d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c3b0>, '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 0x213d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:17:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 01:17:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 01:17:30 INFO - Using env: {'DISPLAY': ':0', 01:17:30 INFO - 'HOME': '/home/cltbld', 01:17:30 INFO - 'LANG': 'en_US.UTF-8', 01:17:30 INFO - 'LANGUAGE': 'en_US:en', 01:17:30 INFO - 'LOGNAME': 'cltbld', 01:17:30 INFO - 'MAIL': '/var/mail/cltbld', 01:17:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:30 INFO - 'MOZ_NO_REMOTE': '1', 01:17:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:30 INFO - 'NO_EM_RESTART': '1', 01:17:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:30 INFO - 'PWD': '/builds/slave/test', 01:17:30 INFO - 'SHELL': '/bin/bash', 01:17:30 INFO - 'SHLVL': '1', 01:17:30 INFO - 'TERM': 'linux', 01:17:30 INFO - 'TMOUT': '86400', 01:17:30 INFO - 'USER': 'cltbld', 01:17:30 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 01:17:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:30 INFO - '_': '/tools/buildbot/bin/python'} 01:17:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:30 INFO - Downloading/unpacking blobuploader==1.2.4 01:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:32 INFO - Downloading blobuploader-1.2.4.tar.gz 01:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 01:17:32 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 01:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 01:17:33 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 01:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:33 INFO - Downloading docopt-0.6.1.tar.gz 01:17:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 01:17:33 INFO - Installing collected packages: blobuploader, requests, docopt 01:17:33 INFO - Running setup.py install for blobuploader 01:17:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 01:17:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 01:17:33 INFO - Running setup.py install for requests 01:17:33 INFO - Running setup.py install for docopt 01:17:33 INFO - Successfully installed blobuploader requests docopt 01:17:33 INFO - Cleaning up... 01:17:34 INFO - Return code: 0 01:17:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:34 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 0x1e7d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c3b0>, '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 0x213d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:17:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:17:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:17:34 INFO - Using env: {'DISPLAY': ':0', 01:17:34 INFO - 'HOME': '/home/cltbld', 01:17:34 INFO - 'LANG': 'en_US.UTF-8', 01:17:34 INFO - 'LANGUAGE': 'en_US:en', 01:17:34 INFO - 'LOGNAME': 'cltbld', 01:17:34 INFO - 'MAIL': '/var/mail/cltbld', 01:17:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:34 INFO - 'MOZ_NO_REMOTE': '1', 01:17:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:34 INFO - 'NO_EM_RESTART': '1', 01:17:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:34 INFO - 'PWD': '/builds/slave/test', 01:17:34 INFO - 'SHELL': '/bin/bash', 01:17:34 INFO - 'SHLVL': '1', 01:17:34 INFO - 'TERM': 'linux', 01:17:34 INFO - 'TMOUT': '86400', 01:17:34 INFO - 'USER': 'cltbld', 01:17:34 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 01:17:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:34 INFO - '_': '/tools/buildbot/bin/python'} 01:17:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:17:34 INFO - Running setup.py (path:/tmp/pip-x5npzQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:17:34 INFO - Running setup.py (path:/tmp/pip-KAf5Yr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:17:34 INFO - Running setup.py (path:/tmp/pip-qWGJhq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:17:34 INFO - Running setup.py (path:/tmp/pip-pOZ_Pa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:17:34 INFO - Running setup.py (path:/tmp/pip-Qcl2Ct-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:17:34 INFO - Running setup.py (path:/tmp/pip-0kCbw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:17:34 INFO - Running setup.py (path:/tmp/pip-gbPUS8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:17:34 INFO - Running setup.py (path:/tmp/pip-qj72um-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:17:34 INFO - Running setup.py (path:/tmp/pip-AIxT7G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:17:34 INFO - Running setup.py (path:/tmp/pip-LCSrEO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:17:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:17:34 INFO - Running setup.py (path:/tmp/pip-BikZYu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:17:35 INFO - Running setup.py (path:/tmp/pip-nqpXRf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:17:35 INFO - Running setup.py (path:/tmp/pip-vAZ_RT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:17:35 INFO - Running setup.py (path:/tmp/pip-fSVlsX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:35 INFO - Running setup.py (path:/tmp/pip-bwG66A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:17:35 INFO - Running setup.py (path:/tmp/pip-VJfCSw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:17:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:17:35 INFO - Running setup.py (path:/tmp/pip-cXhZfI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:17:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 01:17:35 INFO - Running setup.py install for manifestparser 01:17:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 01:17:35 INFO - Running setup.py install for mozcrash 01:17:35 INFO - Running setup.py install for mozdebug 01:17:35 INFO - Running setup.py install for mozdevice 01:17:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 01:17:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 01:17:35 INFO - Running setup.py install for mozfile 01:17:35 INFO - Running setup.py install for mozhttpd 01:17:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Running setup.py install for mozinfo 01:17:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Running setup.py install for mozInstall 01:17:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Running setup.py install for mozleak 01:17:36 INFO - Running setup.py install for mozlog 01:17:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Running setup.py install for moznetwork 01:17:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Running setup.py install for mozprocess 01:17:36 INFO - Running setup.py install for mozprofile 01:17:36 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Running setup.py install for mozrunner 01:17:36 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 01:17:36 INFO - Running setup.py install for mozscreenshot 01:17:37 INFO - Running setup.py install for moztest 01:17:37 INFO - Running setup.py install for mozversion 01:17:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 01:17:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 01:17:37 INFO - Cleaning up... 01:17:37 INFO - Return code: 0 01:17:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:37 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 0x1e7d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c3b0>, '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 0x213d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:17:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 01:17:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:17:37 INFO - Using env: {'DISPLAY': ':0', 01:17:37 INFO - 'HOME': '/home/cltbld', 01:17:37 INFO - 'LANG': 'en_US.UTF-8', 01:17:37 INFO - 'LANGUAGE': 'en_US:en', 01:17:37 INFO - 'LOGNAME': 'cltbld', 01:17:37 INFO - 'MAIL': '/var/mail/cltbld', 01:17:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:37 INFO - 'MOZ_NO_REMOTE': '1', 01:17:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:37 INFO - 'NO_EM_RESTART': '1', 01:17:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:37 INFO - 'PWD': '/builds/slave/test', 01:17:37 INFO - 'SHELL': '/bin/bash', 01:17:37 INFO - 'SHLVL': '1', 01:17:37 INFO - 'TERM': 'linux', 01:17:37 INFO - 'TMOUT': '86400', 01:17:37 INFO - 'USER': 'cltbld', 01:17:37 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 01:17:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:37 INFO - '_': '/tools/buildbot/bin/python'} 01:17:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 01:17:37 INFO - Running setup.py (path:/tmp/pip-ZmLKeo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 01:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 01:17:37 INFO - Running setup.py (path:/tmp/pip-6JsonF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 01:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 01:17:37 INFO - Running setup.py (path:/tmp/pip-x398tT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 01:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 01:17:37 INFO - Running setup.py (path:/tmp/pip-XyCt7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 01:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 01:17:37 INFO - Running setup.py (path:/tmp/pip-c0kQdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 01:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 01:17:37 INFO - Running setup.py (path:/tmp/pip-b3Ne00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 01:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 01:17:37 INFO - Running setup.py (path:/tmp/pip-N7qNFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 01:17:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 01:17:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 01:17:37 INFO - Running setup.py (path:/tmp/pip-_wlAyl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 01:17:38 INFO - Running setup.py (path:/tmp/pip-2M2xbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 01:17:38 INFO - Running setup.py (path:/tmp/pip-5DaVdO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 01:17:38 INFO - Running setup.py (path:/tmp/pip-2y1DzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 01:17:38 INFO - Running setup.py (path:/tmp/pip-Yv3TLP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 01:17:38 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)) 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 01:17:38 INFO - Running setup.py (path:/tmp/pip-34vsxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 01:17:38 INFO - Running setup.py (path:/tmp/pip-9S3x5g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 01:17:38 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)) 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:38 INFO - Running setup.py (path:/tmp/pip-NcH6mG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 01:17:38 INFO - Running setup.py (path:/tmp/pip-0qE7eJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 01:17:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 01:17:38 INFO - Running setup.py (path:/tmp/pip-fdsUED-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:17:38 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 01:17:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 01:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 01:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 01:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 01:17:40 INFO - Downloading blessings-1.6.tar.gz 01:17:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 01:17:40 INFO - Installing collected packages: blessings 01:17:40 INFO - Running setup.py install for blessings 01:17:41 INFO - Successfully installed blessings 01:17:41 INFO - Cleaning up... 01:17:41 INFO - Return code: 0 01:17:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 01:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:17:41 INFO - Reading from file tmpfile_stdout 01:17:41 INFO - Current package versions: 01:17:41 INFO - argparse == 1.2.1 01:17:41 INFO - blessings == 1.6 01:17:41 INFO - blobuploader == 1.2.4 01:17:41 INFO - docopt == 0.6.1 01:17:41 INFO - functools32 == 3.2.3-2 01:17:41 INFO - jsonschema == 2.5.1 01:17:41 INFO - manifestparser == 1.1 01:17:41 INFO - mozInstall == 1.12 01:17:41 INFO - mozcrash == 0.17 01:17:41 INFO - mozdebug == 0.1 01:17:41 INFO - mozdevice == 0.48 01:17:41 INFO - mozfile == 1.2 01:17:41 INFO - mozhttpd == 0.7 01:17:41 INFO - mozinfo == 0.9 01:17:41 INFO - mozleak == 0.1 01:17:41 INFO - mozlog == 3.2 01:17:41 INFO - moznetwork == 0.27 01:17:41 INFO - mozprocess == 0.23 01:17:41 INFO - mozprofile == 0.28 01:17:41 INFO - mozrunner == 6.12 01:17:41 INFO - mozscreenshot == 0.1 01:17:41 INFO - mozsystemmonitor == 0.3 01:17:41 INFO - moztest == 0.7 01:17:41 INFO - mozversion == 1.4 01:17:41 INFO - psutil == 3.1.1 01:17:41 INFO - requests == 1.2.3 01:17:41 INFO - wsgiref == 0.1.2 01:17:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 01:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:41 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 0x1e7d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c3b0>, '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 0x213d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 01:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 01:17:41 INFO - Using env: {'DISPLAY': ':0', 01:17:41 INFO - 'HOME': '/home/cltbld', 01:17:41 INFO - 'LANG': 'en_US.UTF-8', 01:17:41 INFO - 'LANGUAGE': 'en_US:en', 01:17:41 INFO - 'LOGNAME': 'cltbld', 01:17:41 INFO - 'MAIL': '/var/mail/cltbld', 01:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:41 INFO - 'MOZ_NO_REMOTE': '1', 01:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:41 INFO - 'NO_EM_RESTART': '1', 01:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:41 INFO - 'PWD': '/builds/slave/test', 01:17:41 INFO - 'SHELL': '/bin/bash', 01:17:41 INFO - 'SHLVL': '1', 01:17:41 INFO - 'TERM': 'linux', 01:17:41 INFO - 'TMOUT': '86400', 01:17:41 INFO - 'USER': 'cltbld', 01:17:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 01:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:41 INFO - '_': '/tools/buildbot/bin/python'} 01:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 01:17:41 INFO - Cleaning up... 01:17:41 INFO - Return code: 0 01:17:41 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 01:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 01:17:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 01:17:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 01:17:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 01:17:41 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 0x1e7d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1fe08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x213c3b0>, '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 0x213d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d740>, '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': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 01:17:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 01:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 01:17:41 INFO - Using env: {'DISPLAY': ':0', 01:17:41 INFO - 'HOME': '/home/cltbld', 01:17:41 INFO - 'LANG': 'en_US.UTF-8', 01:17:41 INFO - 'LANGUAGE': 'en_US:en', 01:17:41 INFO - 'LOGNAME': 'cltbld', 01:17:41 INFO - 'MAIL': '/var/mail/cltbld', 01:17:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:41 INFO - 'MOZ_NO_REMOTE': '1', 01:17:41 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:41 INFO - 'NO_EM_RESTART': '1', 01:17:41 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:41 INFO - 'PWD': '/builds/slave/test', 01:17:41 INFO - 'SHELL': '/bin/bash', 01:17:41 INFO - 'SHLVL': '1', 01:17:41 INFO - 'TERM': 'linux', 01:17:41 INFO - 'TMOUT': '86400', 01:17:41 INFO - 'USER': 'cltbld', 01:17:41 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 01:17:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:41 INFO - '_': '/tools/buildbot/bin/python'} 01:17:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 01:17:41 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 01:17:41 INFO - Cleaning up... 01:17:41 INFO - Return code: 0 01:17:41 INFO - Running post-action listener: _resource_record_post_action 01:17:41 INFO - Running post-action listener: _start_resource_monitoring 01:17:41 INFO - Starting resource monitoring. 01:17:41 INFO - ##### 01:17:41 INFO - ##### Finished create-virtualenv step (success) 01:17:41 INFO - ##### 01:17:41 INFO - ##### 01:17:41 INFO - ##### Running install step. 01:17:41 INFO - ##### 01:17:41 INFO - Running pre-action listener: _resource_record_pre_action 01:17:41 INFO - Running main action method: install 01:17:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 01:17:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 01:17:42 INFO - Reading from file tmpfile_stdout 01:17:42 INFO - Detecting whether we're running mozinstall >=1.0... 01:17:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 01:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 01:17:42 INFO - Reading from file tmpfile_stdout 01:17:42 INFO - Output received: 01:17:42 INFO - Usage: mozinstall [options] installer 01:17:42 INFO - Options: 01:17:42 INFO - -h, --help show this help message and exit 01:17:42 INFO - -d DEST, --destination=DEST 01:17:42 INFO - Directory to install application into. [default: 01:17:42 INFO - "/builds/slave/test"] 01:17:42 INFO - --app=APP Application being installed. [default: firefox] 01:17:42 INFO - mkdir: /builds/slave/test/build/application 01:17:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 01:17:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 01:17:58 INFO - Reading from file tmpfile_stdout 01:17:58 INFO - Output received: 01:17:58 INFO - /builds/slave/test/build/application/firefox/firefox 01:17:58 INFO - Running post-action listener: _resource_record_post_action 01:17:58 INFO - ##### 01:17:58 INFO - ##### Finished install step (success) 01:17:58 INFO - ##### 01:17:58 INFO - ##### 01:17:58 INFO - ##### Running run-tests step. 01:17:58 INFO - ##### 01:17:58 INFO - Running pre-action listener: _resource_record_pre_action 01:17:58 INFO - Running main action method: run_tests 01:17:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 01:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 01:17:58 INFO - Python 2.7.3 01:17:58 INFO - Return code: 0 01:17:58 INFO - grabbing minidump binary from tooltool 01:17: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')]} 01:17:58 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 0x213c3b0>, '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 0x213d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x213d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 01:17:58 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 01:17:58 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 01:17:58 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 01:17:58 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 01:17:58 INFO - Return code: 0 01:17:58 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 01:17:58 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 01:17:58 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 01:17:58 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 01:17:58 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 01:17:58 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/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 01:17:58 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/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-020 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 01:17:58 INFO - Using env: {'DISPLAY': ':0', 01:17:58 INFO - 'HOME': '/home/cltbld', 01:17:58 INFO - 'LANG': 'en_US.UTF-8', 01:17:58 INFO - 'LANGUAGE': 'en_US:en', 01:17:58 INFO - 'LOGNAME': 'cltbld', 01:17:58 INFO - 'MAIL': '/var/mail/cltbld', 01:17:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 01:17:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 01:17:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 01:17:58 INFO - 'MOZ_NO_REMOTE': '1', 01:17:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 01:17:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 01:17:58 INFO - 'NO_EM_RESTART': '1', 01:17:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 01:17:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 01:17:58 INFO - 'PWD': '/builds/slave/test', 01:17:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 01:17:58 INFO - 'SHELL': '/bin/bash', 01:17:58 INFO - 'SHLVL': '1', 01:17:58 INFO - 'TERM': 'linux', 01:17:58 INFO - 'TMOUT': '86400', 01:17:58 INFO - 'USER': 'cltbld', 01:17:58 INFO - 'XDG_SESSION_COOKIE': 'af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443', 01:17:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 01:17:58 INFO - '_': '/tools/buildbot/bin/python'} 01:17:58 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/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-020', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 01:17:58 INFO - mozversion application_buildid: 20160719003820 01:17:58 INFO - mozversion application_changeset: 69741c30f7d501fa901bf77059840ad3f54cbbf4 01:17:58 INFO - mozversion application_display_name: Nightly 01:17:58 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 01:17:58 INFO - mozversion application_name: Firefox 01:17:58 INFO - mozversion application_remotingname: firefox 01:17:58 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 01:17:58 INFO - mozversion application_vendor: Mozilla 01:17:58 INFO - mozversion application_version: 50.0a1 01:17:58 INFO - mozversion platform_buildid: 20160719003820 01:17:58 INFO - mozversion platform_changeset: 69741c30f7d501fa901bf77059840ad3f54cbbf4 01:17:58 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 01:17:58 INFO - mozversion platform_version: 50.0a1 01:17:58 INFO - using testdate: 1468916278 01:17:58 INFO - actual date: 1468916278 01:17:58 INFO - starting webserver on 'localhost:36165' 01:17:58 INFO - SUITE-START | Running 2 tests 01:17:58 INFO - TEST-START | dromaeo_css 01:17:58 INFO - operating with platform_type : linux_ 01:17:58 INFO - Initialising browser for dromaeo_css test... 01:17:58 INFO - TEST-INFO | started process 22876 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaBIaU1/profile http://localhost:36165/getInfo.html) 01:18:03 INFO - PROCESS | 22876 | __metrics Screen width/height:1600/1200 01:18:03 INFO - PROCESS | 22876 | colorDepth:24 01:18:03 INFO - PROCESS | 22876 | Browser inner width/height: 1024/697 01:18:03 INFO - PROCESS | 22876 | __metrics 01:18:04 INFO - PROCESS | 22876 | 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" 01:18:04 INFO - PROCESS | 22876 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:18:06 INFO - TEST-INFO | 22876: exit 0 01:18:06 INFO - Browser initialized. 01:18:06 INFO - Running cycle 1/1 for dromaeo_css test... 01:18:06 INFO - TEST-INFO | started process 22957 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpaBIaU1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:18:17 INFO - PROCESS | 22957 | RSS: Main: 159051776 01:18:17 INFO - PROCESS | 22957 | 01:19:09 INFO - PROCESS | 22957 | 1468916349828 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 01:21:22 INFO - PROCESS | 22957 | Cycle 1(1): loaded http://localhost:36165/tests/dromaeo/cssquery-dojo.html (next: http://localhost:36165/tests/dromaeo/cssquery-ext.html) 01:21:23 INFO - PROCESS | 22957 | RSS: Main: 272162816 01:21:23 INFO - PROCESS | 22957 | 01:24:26 INFO - PROCESS | 22957 | Cycle 1(1): loaded http://localhost:36165/tests/dromaeo/cssquery-ext.html (next: http://localhost:36165/tests/dromaeo/cssquery-jquery.html) 01:24:26 INFO - PROCESS | 22957 | RSS: Main: 245678080 01:24:26 INFO - PROCESS | 22957 | 01:27:29 INFO - PROCESS | 22957 | Cycle 1(1): loaded http://localhost:36165/tests/dromaeo/cssquery-jquery.html (next: http://localhost:36165/tests/dromaeo/cssquery-mootools.html) 01:27:29 INFO - PROCESS | 22957 | RSS: Main: 243097600 01:27:29 INFO - PROCESS | 22957 | 01:30:32 INFO - PROCESS | 22957 | Cycle 1(1): loaded http://localhost:36165/tests/dromaeo/cssquery-mootools.html (next: http://localhost:36165/tests/dromaeo/cssquery-prototype.html) 01:30:32 INFO - PROCESS | 22957 | RSS: Main: 243646464 01:30:32 INFO - PROCESS | 22957 | 01:33:35 INFO - PROCESS | 22957 | Cycle 1(1): loaded http://localhost:36165/tests/dromaeo/cssquery-prototype.html (next: http://localhost:36165/tests/dromaeo/cssquery-yui.html) 01:33:36 INFO - PROCESS | 22957 | RSS: Main: 225792000 01:33:36 INFO - PROCESS | 22957 | 01:36:39 INFO - PROCESS | 22957 | Cycle 1(1): loaded http://localhost:36165/tests/dromaeo/cssquery-yui.html (next: http://localhost:36165/tests/dromaeo/cssquery-dojo.html) 01:36:39 INFO - PROCESS | 22957 | RSS: Main: 283631616 01:36:39 INFO - PROCESS | 22957 | 01:36:39 INFO - PROCESS | 22957 | __start_tp_report 01:36:39 INFO - PROCESS | 22957 | _x_x_mozilla_page_load 01:36:39 INFO - PROCESS | 22957 | _x_x_mozilla_page_load_details 01:36:39 INFO - PROCESS | 22957 | |i|pagename|runs| 01:36:39 INFO - PROCESS | 22957 | |0;dojo.html;2586.7930565554757;2592.403747138158;2627.8029147813913;2645.2328824640854;2651.5359812032902;4568.588827005568;4662.97668511657;4666.976665116674;4696.154692155411;4707.24684050552;4653.488116307203;4671.906561868761;4689.671722979393;4691.319758634996;4712.717236965776;4271.722338048017;4285.742855428669;4317.740935543861;4369.126174765044;4379.299312110063;4401.119776044788;4419.138268037734;4478.776061196943;4493.7977790999485;4497.055618320157;4246.193223287596;4294.398784170218;4306.5262821089655;4307.073979094478;4349.369341445505;4277.8288868445225;4301.612854843048;4327.826886924519;4347.43483347166;4347.934780978288;4256.553061928515;4278.850240241608;4297.613214810651;4338.609525142752;4353.25994580922;4691.7888695008805;4699.882502937419;4700.271457924027;4714.905701885943;4733.313669517901;4840.249761287007;5014.824481143142;5083.237514372837;5092.414372347191;5168.043911876315;5151.5363617274625;5169.689818610857;5177.948220517785;5182.067227898977;5182.378114626269;4506.932396014063;4803.999999999965;4810.95189048112;4816.301636262722;4817.855464336006;5146.922796158061;5174;5189.351331083614;5193.714345711022;5224.425313215544;5002.09962206799;5004.924926126111;5044.596432285409;5047.596192304607;5057.772400241998;4839.540243676845;4899.04468628614;5086.694798312114;5129.358830146231;5135.948640513622;4907.043126590281;4936.3829521309835;4946.802127914843;4960.181570040975;5003.374578177728;4914.115459217303;4918.483559226302;4925.408950925912;4927.60579153674;4974.179260422062;4162.271602469556;4214.452121224222;4268.701190916606;4321.2653848845775;4361.956380436219;3725.981370093132;3739.513863197821;3742.120601658608;3785.5078839750654;3790.0145962050065;4351.108022855307;4359.760213188241;4362.258416069276;4402.0095478517715;4403.273459879084;4849.2968519564465;4863.975680121577;4922.950770492321;5040.949590504121;5084.51697088776;4270.167317373144;4279.786010699515;4297.376880352332;4297.935530967038;4337.240982827992;4488.618467430239;4489.573490518395;4492.662911189935;4504.144212599595;4554.27131658933;4517.887052823706;4689.6248300136585;4712.882177945578;4713.8821529460665;4750.596199323097;4941.950580494149;4963.553280204799;4967.602591792575;4967.875803104806;5008.824691135793;4704.905901882012;4719.480857105785;4725.669203155883;4736.336912832137;4773.498782627774;4659.930101048555;4898.559129678346;4908.9754551227015;4927.187014142626;4953.331300274417;5000.77496512665;5022.899542009212;5025.723585202849;5033.84898453047;5054.2671312660195;4884.291777692144;4891.33966914462;4905.681130726492;4913.115639184981;4939.456659767495;4742.1227072991605;4860.246661767432;4890.731009794353;4929.112759703288;4951.5791157750555;4839.975800120977;4869.220924652039;4873.561379475864;4926.3349447824085;4933.235348520985;4783.569478746929;4924.852254432372;4976.452590215146;4980.900381992412;4987.276844857548;4822.035592881508;4892.2661600760175;4898.044881248123;4910.975445122752;4912.754362281943 01:36:39 INFO - PROCESS | 22957 | |1;ext.html;563.0709329606152;565.7850016993542;569.5272923473517;575.2234483447346;581.4127730991697;27332.86333568332;40304.19391612166;41684;41780.99999999996;46078.769606151924;42103.15793684124;42502.7874860626;42536.787316063455;42569.574304256945;42611.78694106525;7541.396688264926;7793.922060779405;7935.682572697114;7941.960290198541;7944;7582.772516824504;7843.686252549891;7846.803829904241;10053.346532475402;10347.223958203127;10495.842562361571;10565.154787616972;10573;10583.417912014836;10584.78830423391;10403.635872744455;10471.214658900613;10483.58065677372;10486.265961382667;10487.895121048768;7624.847503049908;9940.353876998044;10292.845607315896;10329.84505232422;10688.839667404995;39066;39305.21389572221;39319.41020884689;39341.213175736324;39353.80323098395;3214.164317277525;3278.131295206772;3302.7192688621494;3449.3963556377785;3627.564692236922;29551.26121846971;29808.8509557453;30024;30237.395252095055;30397.392052158833;3427.091820667525;3493.8427770750377;3537.080359106625;3602.7297952653657;3609.169890925076;268859;269682;271375;271462;271706;57560.71219643875;57715.422845771005;57834.7108264456;58186.709066454394;58187.70906145442;35085.82457087698;60821.39178608246;60976.69511652413;61024;61062.694686527175;15040.247987600795;15488.612784680474;15513.844861551466;15533.76699349488;15536.844631553766;9417.434953902788;11841.763164736656;11927.582534611247;11951.76096478083;11961.700957476132;18384.908075459538;18648.906755466407;18758.437246882615;19494.610107797766;19554.902225488782;6458.5479016469335;6725.428338591275;6743.5953842769595;6809.353111454404;6898.413634840995;820;913.6254135804288;946.9195118414874;950.4867371619387;966.2559828931824;28499.430011399654;29029.41941161165;29187.708122918924;29656.406871862873;29657.110286691433;927.698497988143;958.4441024205944;1038.231708535678;1050.9159267258601;1087.260662749338;14618.488352907598;14918.104913705212;15020.699586008437;15314.617134571725;15323;383362;385707;386350;386551;387672;51498;51699.74150129225;51710.482895170564;51726.22410663843;51800.22299665508;1123.7359220583157;1194.2774621354129;1201.237214368882;1245.1532957588927;1254.9184303020274;28716.13851584456;29633.851830740707;29807.850960745058;29836.403271934872;30224.244393890327;43413.348799767395;43632.78183609062;44001.55998440103;44002.55997439985;44044.77977610091;267879;269707;270167;270221;270339;22823.429414264778;23497.412564685335;24692.876535617208;25741.227763167135;25746.871265644302;42756;42854.35718464163;43145;43513.34729979116;44116.11767764691;36200.27599448049;36426.27147457089;36590;36815.26369472649;37081.443778343884;36051;36148.45777313395;36368.45447318239;36560;36661.81669091638;35639;35980.28039439249;36173.276534468634;36347.81826090958;36632.45051324179;31645.683543165196;32784.67215327816;32908.1772955678;32958;33257;24886.626700599143;25437.745622543538;25529.617055743805;25629.487410252063;25774.484510309314 01:36:39 INFO - PROCESS | 22957 | |2;jquery.html;342.68516173249725;370.2650239275039;370.44433349975037;375.3131768862979;387.81578750093706;12733.745325093505;16205.91897040516;16661.416850410253;18124.365647202318;18130.274789008425;16046.277917493711;16476.917615411938;16765.413210537634;16885.324587016505;17219.483415497554;4430.534793846648;5007.0736913671;5152.896942061157;5162.096633089194;5164.147915593922;3757.4927384803113;5660;5910.261217347832;5935.940640593603;6039.5772295939305;5681.545476361881;5929.229200203968;5952.70236488176;5953.88092238155;5978.461938425541;5845.620034697774;5875.764969401219;5892.528597712173;5894.557908156884;5904.0553511437965;5113.181890897438;5159.2003239497935;5179.974100129513;5194.792208311663;5291.708956007418;20542.69185962212;20605.38183854487;20912.790872091387;21033.15867365319;21146.25988090425;1750.1949103412446;1883.5761953560477;1993.800619938009;2245.2815099168274;2276.533310671325;8945.105489451067;9044;9277.443353398818;9385.498320268724;9591.184749296319;1697.2447260968875;1710.9743353849701;1745.9650806983789;1748.1434097292363;1753.0796331925712;61711;68817.8709277445;69925.30074699239;70274.29725702728;71916.64041679811;10098.747531311776;10119.291649584606;10175.796484070277;10227.897721022844;10374.221933354878;13853.445862165601;13968.580942571536;13983.510577129751;13985.300734963212;13997.390300115414;7367.857982012797;7408.185099639036;7432.2567743225245;7533.171351151369;7545;7270.963645181846;7361.1166660001145;7472.0286362772495;7491.10106787189;7497.812554686067;4376.890577735582;4436.822527098944;4446.155230506193;4508.729476231437;4522.66080043998;1719.7678313427778;1723.4398820383426;1760.938367157169;1837.724171952793;1915.396650055228;842.688205364007;848.4866655673229;909.8043920557112;925.2505470568726;937.9635502769478;16599.751003734953;16664.58338541522;16932.06873621938;18464.538386540444;19324.61350773005;820.4902978519433;855.4696088425217;860.2515811244258;863.48622569571;887.0730087059039;6593;9479;9522.90477095234;9642.71071867845;9780.364276322016;405766;406208;418223;420123;423399;75914.62042689751;80695.59652201818;81954.59022704848;86120;86284.62588298824;393.1037235103968;407.1490584678037;418.6608846834074;420.8463910672644;425.28552032585554;9792;10188.134008609351;10191.082802547806;10223.948880255552;10334.173266138841;38056.61943380531;39111.217775644895;39269;39944;40010.399844002946;52313.47686523086;54325;54580.72709636585;54705;54941;6881.174259088942;7207.495475316888;7391.113066432063;7408.555486670817;7466;7420.92579074224;8432.957835210786;10354;11257.437128143723;11567.942160289482;9713.36863103896;9782.804343913223;9813.26400519978;9873.901260987299;10044.096031357212;9095.135962083592;9366.297527685314;9383.671571494964;9674.17769489573;9825.263105266991;9592.9040709592;9599.760005999906;9669.323147379617;10262.834733005768;10353.74115647115;7406.111266648037;7428.442866784904;7473.103227612722;7578.280063393969;7603.657835397531;9346.579403926975;9803.901960980298;9972.30193886421;10036.799264014824;10270.897291026995 01:36:39 INFO - PROCESS | 22957 | |3;mootools.html;1323.6756994536338;1389.1040279020033;1446.9855301446983;1663.750437434384;1703.3952946703928;7526.39788816894;7947.960260198691;8000.679972801088;8012.839743205132;8050.637721302541;6579.769708060219;6779.7627083051975;6788.864222715542;6945.305469453052;7883.251091146332;1879.9342023029196;2148.2803260907535;2221.3558068160214;2227.354067320475;2241.5180736141724;2242.686023956647;2252.5157091225383;2272.6136556785304;2274.715660542432;2275.101334972685;1844.2254253213616;2138.5295235048343;2221.6445368741006;2225.4770129019666;2228.520868013377;2187.660912558556;2227.3318004598555;2229.8216142708625;2231.3529076567775;2235.642297232435;2115.5663089066707;2121.31057406342;2130.4247853079737;2151.236311109549;2158.935231943044;7975.880361794578;7998.12020677725;8005.639746211435;8016.358691304682;8021.839563208703;4708.57622813945;4727.881802954919;4834.564889159958;4862.3922009748785;4863.732494712789;2810.18504633656;2868.2542538939815;2904.419116176773;2917.28526511004;2923.8099523531114;951.9904800951971;980.6077568972397;981.9312648114635;1005.9295849290553;1007.5264625625944;10783.6225732099;10815.729606759814;10818.026377625973;10832.945835270852;10874.510647020903;4103.363978583325;4273.867425132343;4305.203537345601;4387.144506821203;4388.692791504564;9229.446233226028;9237.491937943478;9258;9261.351705380694;9275.072492750805;4708.693934894221;4716.764161791897;4718.669693121517;4720.905581888412;4734.479207287196;3741.2330472253125;3743.288775132716;4302.26861433557;4322.7190232634775;4328.8484903028875;3633.1462106404974;3798.430235464647;3803.5435747710453;3803.82882770276;3822.0444888777806;1207.849018872641;1241.366902879538;1242.6147894152841;1265.1713127901055;1271.5041133957764;765.9348955338747;857.9656813727506;876.9210771030638;877.8397768035151;905.5924833824805;5178.61160412963;5238;5335.973320133375;5364.597655175878;5383.973080134574;401.88345379840104;410.47049306395013;420.3232795199726;425.27702905061517;428.8756260684429;3674.3937250353392;3755;3774.8678796241998;3834.789086600208;3841.769493830379;9241.768955776024;9620.230381569458;9717.46553939526;9732.70801875945;9744.07431294026;9596.280278979104;9647.179989700813;9654.662086826927;9669.129778319984;9669.709908702609;7292.927070729224;7326.04761381017;7363.374113200331;7440.925590744131;7446.813829654302;5257.947420525746;5372.811951581676;5406.405295417422;5410.404855465974;5462.481064298885;9025.323100767337;9069.682561110329;9156.587953541974;9187.127222913812;9218.585163667785;7914.960425198067;8350.958245208734;8636.697715579925;8680.696175633822;9225.446473211628;6568.211814582281;6787.89818152738;6797.72809087631;6835.316468353125;6956.686949087202;7449.366803821519;7477.88783168242;7607.961960190164;7618.771436856903;7635.08378994502;6910.101686780687;6944.201416837129;6986.091808064919;7078.044463997295;7079.858402832017;6822.522423430511;6854.657267136723;6878.8624227516175;6905.551139175937;6984.895226571504;6360.109584658244;6405.903911441239;6418.19772528434;6421.068945003042;6430.099786029866;4677.906441871211;4681.929771053369;4698.765061746967;4720.315554244547;4732.952670473252;4753.263244197155;4758.286257061469;4783.378160839069;4793.904121917472;4847.612191024639 01:36:39 INFO - PROCESS | 22957 | |4;prototype.html;291.389538915971;292.485226002236;298.35257491244005;308.31092508244086;311.1521104988907;4780.2590598457255;4847.927281090787;4876.268559716044;4894.192458244385;4911.421503710545;4561.452625684922;4665.4168228971375;4670.136024835408;4686.929696054562;4803.783829727662;3679.668829805317;3715.034091136297;3731.9253614927684;3842.9615703842883;3844.9231015379673;3809.085819403351;3824.101336185994;3830.912152876689;3852.9422058669143;3868.613138686123;3572.9821350893208;3772.8679496217637;3812.7331086823797;3829.463875057494;3830.7893065881367;3739.8130093495215;3747.4004159334377;3756.1736417988;3756.267527832074;3764;3274.361499507597;3278.2951665392056;3284.425225585513;3314.8839790607453;3320.9501857472155;4724.362211101492;4752;4756.07256584966;4762.1666208413735;4764.904701905943;4048.210598933209;4242.109157077018;4260.723053001545;4285.5071666758095;4310.978445107786;5007.298978143063;5008.424031236382;5035.370578677665;5035.874103147414;5038.143515602356;3561.0385195997196;3569.161247106928;3570.6786389225094;3578.8926332210076;3593.6406359364114;5172.6379153459275;5240.528352448298;5253.26454296395;5273.841784746463;5281.867953301198;3636.090977255686;3640.5995340512522;3645.671889529955;3659.579148397915;3668.926621467556;3709.10981364476;3723.6090210528046;3729.4778730977687;3739.569949455793;3747.8500859965297;4261.424707664426;4266.8052945175405;4278.44380230568;4287.256156060124;4298.570142985739;4884.413870335582;5012.198048312325;5042.193249080129;5050.6464547482055;5051.166557518042;1218.939053047344;1262.3688155922039;1264.5700461842835;1270.091884302728;1291.7674818532755;858.9699360522352;879.6481407437076;882.6557642519423;888.3515034025069;892.6964831957166;4358.65130789536;4420.823167073346;4427.40230068943;4459.509453960061;4489.147062058199;5164.2770012198325;5164.457731938092;5165.586753059822;5169.689818610896;5171.50870667286;4314.50383205929;4393.362962370438;4443.466783985878;4450.910981780346;4457.68796184264;2716.253030416651;2719.5920611908373;2744.4373903349765;2745.492083964473;2749.2164733051386;4823.204171311764;4876.756162191948;4903.681260718042;4908.852734417973;4923.77842997066;4994.951060277383;5224.09320597979;5226.843194704165;5242.370915490165;5250.65870718402;4854.344663470457;4879.414470263591;4899.461059283476;4911.336969509142;4913.48408417111;5095.87260318495;5105.28526006352;5125.769340379767;5139.331886854685;5154.53609175176;4858.78135483897;4898.498462700082;4999.475055119306;5010.574101201439;5014.147594908947;4837.7581120943105;4856.611471082376;4863.537963893425;4871.002888815568;4881.90236195267;3643.3806252937593;3645.325614761278;3655.7440979131206;3669.7614655047337;3671.9816400917825;4960.181570040902;5009.699418034929;5088.389393272831;5093.974530127326;5130.333056702754;4916.901661966812;4934.55588996992;4936.581075273162;4946.678465899705;4951.331570238116;4916.213405855046;4966.180580204225;4986.4043506077705;4990.925136122888;5014.197728363444;4693.366395536559;4732.432108147044;4828.975855120702;4882.584980276716;4901.852944411673;5070.974645126751;5078.21287700407;5079.415867175175;5094.15946368845;5103.897922041612;4982.704496830777;4986.301917731593;4987.925181122214;4991.450940396626;4997.275939800763 01:36:39 INFO - PROCESS | 22957 | |5;yui.html;618.6813790897687;682.1302838880424;701.0352151376076;709.5352544083623;725.7822653204041;12255.877441225584;13236.404361803718;13253.668658283535;13256.337183140853;13267.469301227964;11839.526418943233;12009.219400738968;12061.155719099666;13235.404406801694;13559.050866439353;630.5743623054443;762.1463960364399;768.2317682317682;768.8231706707461;772.4785769605522;645.7126578672493;756.7994481462417;777.5062835099695;777.510168593788;778.7897267737708;819.315871247506;826.9090400055989;828.0518805967164;828.3580225325361;828.8300898315861;651.6839332923528;793.6587267474983;818.5497976113173;818.664347617477;819.0335404223015;586.521984582568;586.7682265505101;587.4067192135974;587.7854583077188;595.3778301674761;13508.121972071882;13560.118592291568;13589.660258493617;13593.252371119584;13613.795793063013;12594;12799.48802047917;12865.16376435538;12933.611991640266;13240.602781916557;11696.18126731129;11746.823797643043;11806.291622502677;11836.526538938431;12000.159988800788;3180.8415087411076;3283.5567198428384;3289.802611843297;3327.73378129749;4154.50145982481;59031.40968590345;59702.40297597055;59943.70028149831;60738.39261607372;60849.087263690635;9821.017898210122;10111.696649100539;10279.177665786869;10437.530311136017;10509.264351495474;19507.51231219231;20115.597688046157;20140.194392224148;20153.193872244945;20766.58466830655;7348.448866335047;7442.665080071301;7547.471676982668;7553.8866916996285;7634.975822243549;3864.806759662006;3976.8210430530694;3982.5420076691553;3998.620131087542;4090.0592863641527;2938.4416960777385;3040.878364865425;3042.2242328206166;3045.9238519037203;3047.299121202136;536.3349446686159;537.0976759044842;542.4114835403552;550.3368441028551;550.529297450682;475.3440252451664;489.48359480748155;524.1299442924727;540.8026070484324;545.5962587685163;7967.3626109911065;8127.634256458474;8352.248297653241;8398.244158025807;8476.19476149777;583.8585565219985;595.8272101090636;611.1566038866425;625.8278973282293;632.0496894409938;3895.8441662333757;3989.4813674222164;4057.4522439470293;4103.9179216416105;4133.648639865585;52287.21569176466;52911.47088529143;96613.51693241489;98018.50990745;98047.50976245073;80727.59636201781;83192.58403708064;83997;84126;84209;46742.76628616835;52284.47715522796;74353.25646743571;76024.23975760282;76128.61935690285;7586.848263034819;7652.273034061755;7730.652120654697;7925.247101525346;8064.717734879251;44206.77896610496;45085.77457112693;45947.540524595664;46170.69146542592;46185.76907115443;65239.673801630684;66467.33532664612;66656.33343666501;66727;66916.330836691;10350.689479315633;10680.252382333161;10884;11045.668629941114;11251.15616328795;11315.773684526099;11405.543778248777;11642.825357619473;12058.216215945935;12086.758264834478;9820.607175713178;9960.701178964642;10362.067413932782;10393.116585090353;10439.269251152346;9948.602055917681;10127;10244.795104098026;10350.689479315633;10426.739331516772;9783.168430683472;9876;10291.382517049002;11020.559177632806;11056.391898445663;8724.69463568772;8927.285817134483;8933.28533717288;9134.817303653757;9555.9044409555;8645.394822362374;8649.567521623767;8700.825983480421;8797.47215167092;9048.638054478011 01:36:39 INFO - PROCESS | 22957 | __end_tp_report 01:36:39 INFO - PROCESS | 22957 | __start_cc_report 01:36:39 INFO - PROCESS | 22957 | _x_x_mozilla_cycle_collect,1070 01:36:39 INFO - PROCESS | 22957 | __end_cc_report 01:36:39 INFO - PROCESS | 22957 | __startTimestamp1468917399469__endTimestamp 01:36:39 INFO - PROCESS | 22957 | 01:36:39 INFO - PROCESS | 22957 | ------- Summary: start ------- 01:36:39 INFO - PROCESS | 22957 | Number of tests: 6 01:36:39 INFO - PROCESS | 22957 | 01:36:39 INFO - PROCESS | 22957 | [#0] dojo.html Cycles:165 Average:4647.88 Median:4773.50 stddev:486.41 (10.2%) stddev-sans-first:460.25 01:36:39 INFO - PROCESS | 22957 | Values: 2586.8 2592.4 2627.8 2645.2 2651.5 4568.6 4663.0 4667.0 4696.2 4707.2 4653.5 4671.9 4689.7 4691.3 4712.7 4271.7 4285.7 4317.7 4369.1 4379.3 4401.1 4419.1 4478.8 4493.8 4497.1 4246.2 4294.4 4306.5 4307.1 4349.4 4277.8 4301.6 4327.8 4347.4 4347.9 4256.6 4278.9 4297.6 4338.6 4353.3 4691.8 4699.9 4700.3 4714.9 4733.3 4840.2 5014.8 5083.2 5092.4 5168.0 5151.5 5169.7 5177.9 5182.1 5182.4 4506.9 4804.0 4811.0 4816.3 4817.9 5146.9 5174.0 5189.4 5193.7 5224.4 5002.1 5004.9 5044.6 5047.6 5057.8 4839.5 4899.0 5086.7 5129.4 5135.9 4907.0 4936.4 4946.8 4960.2 5003.4 4914.1 4918.5 4925.4 4927.6 4974.2 4162.3 4214.5 4268.7 4321.3 4362.0 3726.0 3739.5 3742.1 3785.5 3790.0 4351.1 4359.8 4362.3 4402.0 4403.3 4849.3 4864.0 4923.0 5040.9 5084.5 4270.2 4279.8 4297.4 4297.9 4337.2 4488.6 4489.6 4492.7 4504.1 4554.3 4517.9 4689.6 4712.9 4713.9 4750.6 4942.0 4963.6 4967.6 4967.9 5008.8 4704.9 4719.5 4725.7 4736.3 4773.5 4659.9 4898.6 4909.0 4927.2 4953.3 5000.8 5022.9 5025.7 5033.8 5054.3 4884.3 4891.3 4905.7 4913.1 4939.5 4742.1 4860.2 4890.7 4929.1 4951.6 4840.0 4869.2 4873.6 4926.3 4933.2 4783.6 4924.9 4976.5 4980.9 4987.3 4822.0 4892.3 4898.0 4911.0 4912.8 01:36:39 INFO - PROCESS | 22957 | 01:36:39 INFO - PROCESS | 22957 | [#1] ext.html Cycles:180 Average:47390.89 Median:19588.04 stddev:82291.04 (420.1%) stddev-sans-first:82446.78 01:36:39 INFO - PROCESS | 22957 | Values: 563.1 565.8 569.5 575.2 581.4 27332.9 40304.2 41684.0 41781.0 46078.8 42103.2 42502.8 42536.8 42569.6 42611.8 7541.4 7793.9 7935.7 7942.0 7944.0 7582.8 7843.7 7846.8 10053.3 10347.2 10495.8 10565.2 10573.0 10583.4 10584.8 10403.6 10471.2 10483.6 10486.3 10487.9 7624.8 9940.4 10292.8 10329.8 10688.8 39066.0 39305.2 39319.4 39341.2 39353.8 3214.2 3278.1 3302.7 3449.4 3627.6 29551.3 29808.9 30024.0 30237.4 30397.4 3427.1 3493.8 3537.1 3602.7 3609.2 268859.0 269682.0 271375.0 271462.0 271706.0 57560.7 57715.4 57834.7 58186.7 58187.7 35085.8 60821.4 60976.7 61024.0 61062.7 15040.2 15488.6 15513.8 15533.8 15536.8 9417.4 11841.8 11927.6 11951.8 11961.7 18384.9 18648.9 18758.4 19494.6 19554.9 6458.5 6725.4 6743.6 6809.4 6898.4 820.0 913.6 946.9 950.5 966.3 28499.4 29029.4 29187.7 29656.4 29657.1 927.7 958.4 1038.2 1050.9 1087.3 14618.5 14918.1 15020.7 15314.6 15323.0 383362.0 385707.0 386350.0 386551.0 387672.0 51498.0 51699.7 51710.5 51726.2 51800.2 1123.7 1194.3 1201.2 1245.2 1254.9 28716.1 29633.9 29807.9 29836.4 30224.2 43413.3 43632.8 44001.6 44002.6 44044.8 267879.0 269707.0 270167.0 270221.0 270339.0 22823.4 23497.4 24692.9 25741.2 25746.9 42756.0 42854.4 43145.0 43513.3 44116.1 36200.3 36426.3 36590.0 36815.3 37081.4 36051.0 36148.5 36368.5 36560.0 36661.8 35639.0 35980.3 36173.3 36347.8 36632.5 31645.7 32784.7 32908.2 32958.0 33257.0 24886.6 25437.7 25529.6 25629.5 25774.5 01:36:39 INFO - PROCESS | 22957 | 01:36:39 INFO - PROCESS | 22957 | [#2] jquery.html Cycles:180 Average:25040.89 Median:5187.38 stddev:68544.68 (1321.4%) stddev-sans-first:68711.88 01:36:39 INFO - PROCESS | 22957 | Values: 342.7 370.3 370.4 375.3 387.8 12733.7 16205.9 16661.4 18124.4 18130.3 16046.3 16476.9 16765.4 16885.3 17219.5 4430.5 5007.1 5152.9 5162.1 5164.1 3757.5 5660.0 5910.3 5935.9 6039.6 5681.5 5929.2 5952.7 5953.9 5978.5 5845.6 5875.8 5892.5 5894.6 5904.1 5113.2 5159.2 5180.0 5194.8 5291.7 20542.7 20605.4 20912.8 21033.2 21146.3 1750.2 1883.6 1993.8 2245.3 2276.5 8945.1 9044.0 9277.4 9385.5 9591.2 1697.2 1711.0 1746.0 1748.1 1753.1 61711.0 68817.9 69925.3 70274.3 71916.6 10098.7 10119.3 10175.8 10227.9 10374.2 13853.4 13968.6 13983.5 13985.3 13997.4 7367.9 7408.2 7432.3 7533.2 7545.0 7271.0 7361.1 7472.0 7491.1 7497.8 4376.9 4436.8 4446.2 4508.7 4522.7 1719.8 1723.4 1760.9 1837.7 1915.4 842.7 848.5 909.8 925.3 938.0 16599.8 16664.6 16932.1 18464.5 19324.6 820.5 855.5 860.3 863.5 887.1 6593.0 9479.0 9522.9 9642.7 9780.4 405766.0 406208.0 418223.0 420123.0 423399.0 75914.6 80695.6 81954.6 86120.0 86284.6 393.1 407.1 418.7 420.8 425.3 9792.0 10188.1 10191.1 10223.9 10334.2 38056.6 39111.2 39269.0 39944.0 40010.4 52313.5 54325.0 54580.7 54705.0 54941.0 6881.2 7207.5 7391.1 7408.6 7466.0 7420.9 8433.0 10354.0 11257.4 11567.9 9713.4 9782.8 9813.3 9873.9 10044.1 9095.1 9366.3 9383.7 9674.2 9825.3 9592.9 9599.8 9669.3 10262.8 10353.7 7406.1 7428.4 7473.1 7578.3 7603.7 9346.6 9803.9 9972.3 10036.8 10270.9 01:36:39 INFO - PROCESS | 22957 | 01:36:39 INFO - PROCESS | 22957 | [#3] mootools.html Cycles:180 Average:5176.78 Median:4863.06 stddev:2896.11 (59.6%) stddev-sans-first:2889.75 01:36:39 INFO - PROCESS | 22957 | Values: 1323.7 1389.1 1447.0 1663.8 1703.4 7526.4 7948.0 8000.7 8012.8 8050.6 6579.8 6779.8 6788.9 6945.3 7883.3 1879.9 2148.3 2221.4 2227.4 2241.5 2242.7 2252.5 2272.6 2274.7 2275.1 1844.2 2138.5 2221.6 2225.5 2228.5 2187.7 2227.3 2229.8 2231.4 2235.6 2115.6 2121.3 2130.4 2151.2 2158.9 7975.9 7998.1 8005.6 8016.4 8021.8 4708.6 4727.9 4834.6 4862.4 4863.7 2810.2 2868.3 2904.4 2917.3 2923.8 952.0 980.6 981.9 1005.9 1007.5 10783.6 10815.7 10818.0 10832.9 10874.5 4103.4 4273.9 4305.2 4387.1 4388.7 9229.4 9237.5 9258.0 9261.4 9275.1 4708.7 4716.8 4718.7 4720.9 4734.5 3741.2 3743.3 4302.3 4322.7 4328.8 3633.1 3798.4 3803.5 3803.8 3822.0 1207.8 1241.4 1242.6 1265.2 1271.5 765.9 858.0 876.9 877.8 905.6 5178.6 5238.0 5336.0 5364.6 5384.0 401.9 410.5 420.3 425.3 428.9 3674.4 3755.0 3774.9 3834.8 3841.8 9241.8 9620.2 9717.5 9732.7 9744.1 9596.3 9647.2 9654.7 9669.1 9669.7 7292.9 7326.0 7363.4 7440.9 7446.8 5257.9 5372.8 5406.4 5410.4 5462.5 9025.3 9069.7 9156.6 9187.1 9218.6 7915.0 8351.0 8636.7 8680.7 9225.4 6568.2 6787.9 6797.7 6835.3 6956.7 7449.4 7477.9 7608.0 7618.8 7635.1 6910.1 6944.2 6986.1 7078.0 7079.9 6822.5 6854.7 6878.9 6905.6 6984.9 6360.1 6405.9 6418.2 6421.1 6430.1 4677.9 4681.9 4698.8 4720.3 4733.0 4753.3 4758.3 4783.4 4793.9 4847.6 01:36:39 INFO - PROCESS | 22957 | 01:36:39 INFO - PROCESS | 22957 | [#4] prototype.html Cycles:180 Average:4167.99 Median:4772.58 stddev:1201.32 (25.2%) stddev-sans-first:1168.92 01:36:39 INFO - PROCESS | 22957 | Values: 291.4 292.5 298.4 308.3 311.2 4780.3 4847.9 4876.3 4894.2 4911.4 4561.5 4665.4 4670.1 4686.9 4803.8 3679.7 3715.0 3731.9 3843.0 3844.9 3809.1 3824.1 3830.9 3852.9 3868.6 3573.0 3772.9 3812.7 3829.5 3830.8 3739.8 3747.4 3756.2 3756.3 3764.0 3274.4 3278.3 3284.4 3314.9 3321.0 4724.4 4752.0 4756.1 4762.2 4764.9 4048.2 4242.1 4260.7 4285.5 4311.0 5007.3 5008.4 5035.4 5035.9 5038.1 3561.0 3569.2 3570.7 3578.9 3593.6 5172.6 5240.5 5253.3 5273.8 5281.9 3636.1 3640.6 3645.7 3659.6 3668.9 3709.1 3723.6 3729.5 3739.6 3747.9 4261.4 4266.8 4278.4 4287.3 4298.6 4884.4 5012.2 5042.2 5050.6 5051.2 1218.9 1262.4 1264.6 1270.1 1291.8 859.0 879.6 882.7 888.4 892.7 4358.7 4420.8 4427.4 4459.5 4489.1 5164.3 5164.5 5165.6 5169.7 5171.5 4314.5 4393.4 4443.5 4450.9 4457.7 2716.3 2719.6 2744.4 2745.5 2749.2 4823.2 4876.8 4903.7 4908.9 4923.8 4995.0 5224.1 5226.8 5242.4 5250.7 4854.3 4879.4 4899.5 4911.3 4913.5 5095.9 5105.3 5125.8 5139.3 5154.5 4858.8 4898.5 4999.5 5010.6 5014.1 4837.8 4856.6 4863.5 4871.0 4881.9 3643.4 3645.3 3655.7 3669.8 3672.0 4960.2 5009.7 5088.4 5094.0 5130.3 4916.9 4934.6 4936.6 4946.7 4951.3 4916.2 4966.2 4986.4 4990.9 5014.2 4693.4 4732.4 4829.0 4882.6 4901.9 5071.0 5078.2 5079.4 5094.2 5103.9 4982.7 4986.3 4987.9 4991.5 4997.3 01:36:39 INFO - PROCESS | 22957 | 01:36:39 INFO - PROCESS | 22957 | [#5] yui.html Cycles:180 Average:16928.43 Median:547.97 stddev:23771.02 (4338.0%) stddev-sans-first:23806.16 01:36:39 INFO - PROCESS | 22957 | Values: 618.7 682.1 701.0 709.5 725.8 12255.9 13236.4 13253.7 13256.3 13267.5 11839.5 12009.2 12061.2 13235.4 13559.1 630.6 762.1 768.2 768.8 772.5 645.7 756.8 777.5 777.5 778.8 819.3 826.9 828.1 828.4 828.8 651.7 793.7 818.5 818.7 819.0 586.5 586.8 587.4 587.8 595.4 13508.1 13560.1 13589.7 13593.3 13613.8 12594.0 12799.5 12865.2 12933.6 13240.6 11696.2 11746.8 11806.3 11836.5 12000.2 3180.8 3283.6 3289.8 3327.7 4154.5 59031.4 59702.4 59943.7 60738.4 60849.1 9821.0 10111.7 10279.2 10437.5 10509.3 19507.5 20115.6 20140.2 20153.2 20766.6 7348.4 7442.7 7547.5 7553.9 7635.0 3864.8 3976.8 3982.5 3998.6 4090.1 2938.4 3040.9 3042.2 3045.9 3047.3 536.3 537.1 542.4 550.3 550.5 475.3 489.5 524.1 540.8 545.6 7967.4 8127.6 8352.2 8398.2 8476.2 583.9 595.8 611.2 625.8 632.0 3895.8 3989.5 4057.5 4103.9 4133.6 52287.2 52911.5 96613.5 98018.5 98047.5 80727.6 83192.6 83997.0 84126.0 84209.0 46742.8 52284.5 74353.3 76024.2 76128.6 7586.8 7652.3 7730.7 7925.2 8064.7 44206.8 45085.8 45947.5 46170.7 46185.8 65239.7 66467.3 66656.3 66727.0 66916.3 10350.7 10680.3 10884.0 11045.7 11251.2 11315.8 11405.5 11642.8 12058.2 12086.8 9820.6 9960.7 10362.1 10393.1 10439.3 9948.6 10127.0 10244.8 10350.7 10426.7 9783.2 9876.0 10291.4 11020.6 11056.4 8724.7 8927.3 8933.3 9134.8 9555.9 8645.4 8649.6 8700.8 8797.5 9048.6 01:36:39 INFO - PROCESS | 22957 | -------- Summary: end -------- 01:36:39 INFO - PROCESS | 22957 | 01:36:40 INFO - TEST-INFO | 22957: exit 0 01:36:40 INFO - TEST-OK | dromaeo_css | took 1121667ms 01:36:40 INFO - TEST-START | kraken 01:36:40 INFO - operating with platform_type : linux_ 01:36:40 INFO - Initialising browser for kraken test... 01:36:40 INFO - TEST-INFO | started process 23144 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnQBmDF/profile http://localhost:36165/getInfo.html) 01:36:45 INFO - PROCESS | 23144 | __metrics Screen width/height:1600/1200 01:36:45 INFO - PROCESS | 23144 | colorDepth:24 01:36:45 INFO - PROCESS | 23144 | Browser inner width/height: 1024/697 01:36:45 INFO - PROCESS | 23144 | __metrics 01:36:46 INFO - PROCESS | 23144 | 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" 01:36:46 INFO - PROCESS | 23144 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 58: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:36:47 INFO - TEST-INFO | 23144: exit 0 01:36:47 INFO - Browser initialized. 01:36:47 INFO - Running cycle 1/1 for kraken test... 01:36:47 INFO - TEST-INFO | started process 23226 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnQBmDF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 01:36:59 INFO - PROCESS | 23226 | RSS: Main: 158822400 01:36:59 INFO - PROCESS | 23226 | 01:37:01 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:36165/tests/kraken/driver.html?testName=audio-beat-detection) 01:37:02 INFO - PROCESS | 23226 | RSS: Main: 217804800 01:37:02 INFO - PROCESS | 23226 | 01:37:05 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:36165/tests/kraken/driver.html?testName=audio-dft) 01:37:06 INFO - PROCESS | 23226 | RSS: Main: 205533184 01:37:06 INFO - PROCESS | 23226 | 01:37:09 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:36165/tests/kraken/driver.html?testName=audio-fft) 01:37:10 INFO - PROCESS | 23226 | RSS: Main: 273399808 01:37:10 INFO - PROCESS | 23226 | 01:37:12 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:36165/tests/kraken/driver.html?testName=audio-oscillator) 01:37:12 INFO - PROCESS | 23226 | RSS: Main: 181497856 01:37:12 INFO - PROCESS | 23226 | 01:37:15 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:36165/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:37:15 INFO - PROCESS | 23226 | RSS: Main: 185753600 01:37:15 INFO - PROCESS | 23226 | 01:37:18 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:36165/tests/kraken/driver.html?testName=imaging-darkroom) 01:37:19 INFO - PROCESS | 23226 | RSS: Main: 221790208 01:37:19 INFO - PROCESS | 23226 | 01:37:22 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:36165/tests/kraken/driver.html?testName=imaging-desaturate) 01:37:23 INFO - PROCESS | 23226 | RSS: Main: 222679040 01:37:23 INFO - PROCESS | 23226 | 01:37:26 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:36165/tests/kraken/driver.html?testName=json-parse-financial) 01:37:26 INFO - PROCESS | 23226 | RSS: Main: 222101504 01:37:26 INFO - PROCESS | 23226 | 01:37:28 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:36165/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:37:29 INFO - PROCESS | 23226 | RSS: Main: 210300928 01:37:29 INFO - PROCESS | 23226 | 01:37:31 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:36165/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:37:31 INFO - PROCESS | 23226 | RSS: Main: 214499328 01:37:31 INFO - PROCESS | 23226 | 01:37:33 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:36165/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:37:34 INFO - PROCESS | 23226 | RSS: Main: 213299200 01:37:34 INFO - PROCESS | 23226 | 01:37:37 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:36165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:37:37 INFO - PROCESS | 23226 | RSS: Main: 225927168 01:37:37 INFO - PROCESS | 23226 | 01:37:40 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:36165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:37:41 INFO - PROCESS | 23226 | RSS: Main: 226983936 01:37:41 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | Cycle 1(1): loaded http://localhost:36165/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:36165/tests/kraken/driver.html?testName=ai-astar) 01:37:43 INFO - PROCESS | 23226 | RSS: Main: 268726272 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | __start_tp_report 01:37:43 INFO - PROCESS | 23226 | _x_x_mozilla_page_load 01:37:43 INFO - PROCESS | 23226 | _x_x_mozilla_page_load_details 01:37:43 INFO - PROCESS | 23226 | |i|pagename|runs| 01:37:43 INFO - PROCESS | 23226 | |0;ai-astar;103;116;114;115;113;113;113;113;114;115 01:37:43 INFO - PROCESS | 23226 | |1;audio-beat-detection;148;128;129;184;122;127;144;121;154;124 01:37:43 INFO - PROCESS | 23226 | |2;audio-dft;161;163;160;161;161;164;161;159;160;160 01:37:43 INFO - PROCESS | 23226 | |3;audio-fft;77;75;77;102;78;76;75;77;102;76 01:37:43 INFO - PROCESS | 23226 | |4;audio-oscillator;85;85;133;84;85;85;115;83;84;127 01:37:43 INFO - PROCESS | 23226 | |5;imaging-gaussian-blur;117;118;118;117;117;117;117;117;117;117 01:37:43 INFO - PROCESS | 23226 | |6;imaging-darkroom;146;146;146;146;146;146;146;146;146;146 01:37:43 INFO - PROCESS | 23226 | |7;imaging-desaturate;95;95;95;95;96;95;95;95;96;95 01:37:43 INFO - PROCESS | 23226 | |8;json-parse-financial;65;62;63;64;63;62;63;65;63;62 01:37:43 INFO - PROCESS | 23226 | |9;json-stringify-tinderbox;66;67;66;66;67;66;66;66;66;67 01:37:43 INFO - PROCESS | 23226 | |10;stanford-crypto-aes;87;80;84;78;77;80;78;78;80;82 01:37:43 INFO - PROCESS | 23226 | |11;stanford-crypto-ccm;129;131;132;129;127;127;131;127;171;135 01:37:43 INFO - PROCESS | 23226 | |12;stanford-crypto-pbkdf2;165;165;166;165;163;170;168;164;162;161 01:37:43 INFO - PROCESS | 23226 | |13;stanford-crypto-sha256-iterative;66;65;68;66;65;66;66;65;65;67 01:37:43 INFO - PROCESS | 23226 | __end_tp_report 01:37:43 INFO - PROCESS | 23226 | __start_cc_report 01:37:43 INFO - PROCESS | 23226 | _x_x_mozilla_cycle_collect,1890 01:37:43 INFO - PROCESS | 23226 | __end_cc_report 01:37:43 INFO - PROCESS | 23226 | __startTimestamp1468917463347__endTimestamp 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | ------- Summary: start ------- 01:37:43 INFO - PROCESS | 23226 | Number of tests: 14 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#0] ai-astar Cycles:10 Average:112.90 Median:114.00 stddev:3.63 (3.2%) stddev-sans-first:1.12 01:37:43 INFO - PROCESS | 23226 | Values: 103.0 116.0 114.0 115.0 113.0 113.0 113.0 113.0 114.0 115.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:136.50 stddev:19.86 (14.6%) stddev-sans-first:20.74 01:37:43 INFO - PROCESS | 23226 | Values: 148.0 128.0 129.0 184.0 122.0 127.0 144.0 121.0 154.0 124.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.49 (0.9%) stddev-sans-first:1.58 01:37:43 INFO - PROCESS | 23226 | Values: 161.0 163.0 160.0 161.0 161.0 164.0 161.0 159.0 160.0 160.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#3] audio-fft Cycles:10 Average:81.50 Median:76.50 stddev:10.84 (14.2%) stddev-sans-first:11.38 01:37:43 INFO - PROCESS | 23226 | Values: 77.0 75.0 77.0 102.0 78.0 76.0 75.0 77.0 102.0 76.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#4] audio-oscillator Cycles:10 Average:96.60 Median:84.50 stddev:20.08 (23.8%) stddev-sans-first:20.85 01:37:43 INFO - PROCESS | 23226 | Values: 85.0 85.0 133.0 84.0 85.0 85.0 115.0 83.0 84.0 127.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#5] imaging-gaussian-blur Cycles:10 Average:117.20 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:37:43 INFO - PROCESS | 23226 | Values: 117.0 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#6] imaging-darkroom Cycles:10 Average:146.00 Median:146.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 01:37:43 INFO - PROCESS | 23226 | Values: 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 146.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 01:37:43 INFO - PROCESS | 23226 | Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 96.0 95.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#8] json-parse-financial Cycles:10 Average:63.20 Median:63.00 stddev:1.14 (1.8%) stddev-sans-first:1.00 01:37:43 INFO - PROCESS | 23226 | Values: 65.0 62.0 63.0 64.0 63.0 62.0 63.0 65.0 63.0 62.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#9] json-stringify-tinderbox Cycles:10 Average:66.30 Median:66.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 01:37:43 INFO - PROCESS | 23226 | Values: 66.0 67.0 66.0 66.0 67.0 66.0 66.0 66.0 66.0 67.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#10] stanford-crypto-aes Cycles:10 Average:80.40 Median:80.00 stddev:3.13 (3.9%) stddev-sans-first:2.24 01:37:43 INFO - PROCESS | 23226 | Values: 87.0 80.0 84.0 78.0 77.0 80.0 78.0 78.0 80.0 82.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#11] stanford-crypto-ccm Cycles:10 Average:133.90 Median:131.00 stddev:13.29 (10.1%) stddev-sans-first:13.97 01:37:43 INFO - PROCESS | 23226 | Values: 129.0 131.0 132.0 129.0 127.0 127.0 131.0 127.0 171.0 135.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.90 Median:165.00 stddev:2.69 (1.6%) stddev-sans-first:2.85 01:37:43 INFO - PROCESS | 23226 | Values: 165.0 165.0 166.0 165.0 163.0 170.0 168.0 164.0 162.0 161.0 01:37:43 INFO - PROCESS | 23226 | 01:37:43 INFO - PROCESS | 23226 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 01:37:43 INFO - PROCESS | 23226 | Values: 66.0 65.0 68.0 66.0 65.0 66.0 66.0 65.0 65.0 67.0 01:37:43 INFO - PROCESS | 23226 | -------- Summary: end -------- 01:37:43 INFO - PROCESS | 23226 | 01:37:44 INFO - TEST-INFO | 23226: exit 0 01:37:44 INFO - TEST-OK | kraken | took 64090ms 01:37:44 INFO - SUITE-END | took 1185s 01:37:44 INFO - Completed test suite (00:19:45) 01:37:44 INFO - javascript benchmark 01:37:44 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2586.7930565554757, 2592.403747138158, 2627.8029147813913, 2645.2328824640854, 2651.5359812032902, 4568.588827005568, 4662.97668511657, 4666.976665116674, 4696.154692155411, 4707.24684050552, 4653.488116307203, 4671.906561868761, 4689.671722979393, 4691.319758634996, 4712.717236965776, 4271.722338048017, 4285.742855428669, 4317.740935543861, 4369.126174765044, 4379.299312110063, 4401.119776044788, 4419.138268037734, 4478.776061196943, 4493.7977790999485, 4497.055618320157, 4246.193223287596, 4294.398784170218, 4306.5262821089655, 4307.073979094478, 4349.369341445505, 4277.8288868445225, 4301.612854843048, 4327.826886924519, 4347.43483347166, 4347.934780978288, 4256.553061928515, 4278.850240241608, 4297.613214810651, 4338.609525142752, 4353.25994580922, 4691.7888695008805, 4699.882502937419, 4700.271457924027, 4714.905701885943, 4733.313669517901, 4840.249761287007, 5014.824481143142, 5083.237514372837, 5092.414372347191, 5168.043911876315, 5151.5363617274625, 5169.689818610857, 5177.948220517785, 5182.067227898977, 5182.378114626269, 4506.932396014063, 4803.999999999965, 4810.95189048112, 4816.301636262722, 4817.855464336006, 5146.922796158061, 5174.0, 5189.351331083614, 5193.714345711022, 5224.425313215544, 5002.09962206799, 5004.924926126111, 5044.596432285409, 5047.596192304607, 5057.772400241998, 4839.540243676845, 4899.04468628614, 5086.694798312114, 5129.358830146231, 5135.948640513622, 4907.043126590281, 4936.3829521309835, 4946.802127914843, 4960.181570040975, 5003.374578177728, 4914.115459217303, 4918.483559226302, 4925.408950925912, 4927.60579153674, 4974.179260422062, 4162.271602469556, 4214.452121224222, 4268.701190916606, 4321.2653848845775, 4361.956380436219, 3725.981370093132, 3739.513863197821, 3742.120601658608, 3785.5078839750654, 3790.0145962050065, 4351.108022855307, 4359.760213188241, 4362.258416069276, 4402.0095478517715, 4403.273459879084, 4849.2968519564465, 4863.975680121577, 4922.950770492321, 5040.949590504121, 5084.51697088776, 4270.167317373144, 4279.786010699515, 4297.376880352332, 4297.935530967038, 4337.240982827992, 4488.618467430239, 4489.573490518395, 4492.662911189935, 4504.144212599595, 4554.27131658933, 4517.887052823706, 4689.6248300136585, 4712.882177945578, 4713.8821529460665, 4750.596199323097, 4941.950580494149, 4963.553280204799, 4967.602591792575, 4967.875803104806, 5008.824691135793, 4704.905901882012, 4719.480857105785, 4725.669203155883, 4736.336912832137, 4773.498782627774, 4659.930101048555, 4898.559129678346, 4908.9754551227015, 4927.187014142626, 4953.331300274417, 5000.77496512665, 5022.899542009212, 5025.723585202849, 5033.84898453047, 5054.2671312660195, 4884.291777692144, 4891.33966914462, 4905.681130726492, 4913.115639184981, 4939.456659767495, 4742.1227072991605, 4860.246661767432, 4890.731009794353, 4929.112759703288, 4951.5791157750555, 4839.975800120977, 4869.220924652039, 4873.561379475864, 4926.3349447824085, 4933.235348520985, 4783.569478746929, 4924.852254432372, 4976.452590215146, 4980.900381992412, 4987.276844857548, 4822.035592881508, 4892.2661600760175, 4898.044881248123, 4910.975445122752, 4912.754362281943], "value": 4616.958870134252, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.0709329606152, 565.7850016993542, 569.5272923473517, 575.2234483447346, 581.4127730991697, 27332.86333568332, 40304.19391612166, 41684.0, 41780.99999999996, 46078.769606151924, 42103.15793684124, 42502.7874860626, 42536.787316063455, 42569.574304256945, 42611.78694106525, 7541.396688264926, 7793.922060779405, 7935.682572697114, 7941.960290198541, 7944.0, 7582.772516824504, 7843.686252549891, 7846.803829904241, 10053.346532475402, 10347.223958203127, 10495.842562361571, 10565.154787616972, 10573.0, 10583.417912014836, 10584.78830423391, 10403.635872744455, 10471.214658900613, 10483.58065677372, 10486.265961382667, 10487.895121048768, 7624.847503049908, 9940.353876998044, 10292.845607315896, 10329.84505232422, 10688.839667404995, 39066.0, 39305.21389572221, 39319.41020884689, 39341.213175736324, 39353.80323098395, 3214.164317277525, 3278.131295206772, 3302.7192688621494, 3449.3963556377785, 3627.564692236922, 29551.26121846971, 29808.8509557453, 30024.0, 30237.395252095055, 30397.392052158833, 3427.091820667525, 3493.8427770750377, 3537.080359106625, 3602.7297952653657, 3609.169890925076, 268859.0, 269682.0, 271375.0, 271462.0, 271706.0, 57560.71219643875, 57715.422845771005, 57834.7108264456, 58186.709066454394, 58187.70906145442, 35085.82457087698, 60821.39178608246, 60976.69511652413, 61024.0, 61062.694686527175, 15040.247987600795, 15488.612784680474, 15513.844861551466, 15533.76699349488, 15536.844631553766, 9417.434953902788, 11841.763164736656, 11927.582534611247, 11951.76096478083, 11961.700957476132, 18384.908075459538, 18648.906755466407, 18758.437246882615, 19494.610107797766, 19554.902225488782, 6458.5479016469335, 6725.428338591275, 6743.5953842769595, 6809.353111454404, 6898.413634840995, 820.0, 913.6254135804288, 946.9195118414874, 950.4867371619387, 966.2559828931824, 28499.430011399654, 29029.41941161165, 29187.708122918924, 29656.406871862873, 29657.110286691433, 927.698497988143, 958.4441024205944, 1038.231708535678, 1050.9159267258601, 1087.260662749338, 14618.488352907598, 14918.104913705212, 15020.699586008437, 15314.617134571725, 15323.0, 383362.0, 385707.0, 386350.0, 386551.0, 387672.0, 51498.0, 51699.74150129225, 51710.482895170564, 51726.22410663843, 51800.22299665508, 1123.7359220583157, 1194.2774621354129, 1201.237214368882, 1245.1532957588927, 1254.9184303020274, 28716.13851584456, 29633.851830740707, 29807.850960745058, 29836.403271934872, 30224.244393890327, 43413.348799767395, 43632.78183609062, 44001.55998440103, 44002.55997439985, 44044.77977610091, 267879.0, 269707.0, 270167.0, 270221.0, 270339.0, 22823.429414264778, 23497.412564685335, 24692.876535617208, 25741.227763167135, 25746.871265644302, 42756.0, 42854.35718464163, 43145.0, 43513.34729979116, 44116.11767764691, 36200.27599448049, 36426.27147457089, 36590.0, 36815.26369472649, 37081.443778343884, 36051.0, 36148.45777313395, 36368.45447318239, 36560.0, 36661.81669091638, 35639.0, 35980.28039439249, 36173.276534468634, 36347.81826090958, 36632.45051324179, 31645.683543165196, 32784.67215327816, 32908.1772955678, 32958.0, 33257.0, 24886.626700599143, 25437.745622543538, 25529.617055743805, 25629.487410252063, 25774.484510309314], "value": 18310.513825599475, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [342.68516173249725, 370.2650239275039, 370.44433349975037, 375.3131768862979, 387.81578750093706, 12733.745325093505, 16205.91897040516, 16661.416850410253, 18124.365647202318, 18130.274789008425, 16046.277917493711, 16476.917615411938, 16765.413210537634, 16885.324587016505, 17219.483415497554, 4430.534793846648, 5007.0736913671, 5152.896942061157, 5162.096633089194, 5164.147915593922, 3757.4927384803113, 5660.0, 5910.261217347832, 5935.940640593603, 6039.5772295939305, 5681.545476361881, 5929.229200203968, 5952.70236488176, 5953.88092238155, 5978.461938425541, 5845.620034697774, 5875.764969401219, 5892.528597712173, 5894.557908156884, 5904.0553511437965, 5113.181890897438, 5159.2003239497935, 5179.974100129513, 5194.792208311663, 5291.708956007418, 20542.69185962212, 20605.38183854487, 20912.790872091387, 21033.15867365319, 21146.25988090425, 1750.1949103412446, 1883.5761953560477, 1993.800619938009, 2245.2815099168274, 2276.533310671325, 8945.105489451067, 9044.0, 9277.443353398818, 9385.498320268724, 9591.184749296319, 1697.2447260968875, 1710.9743353849701, 1745.9650806983789, 1748.1434097292363, 1753.0796331925712, 61711.0, 68817.8709277445, 69925.30074699239, 70274.29725702728, 71916.64041679811, 10098.747531311776, 10119.291649584606, 10175.796484070277, 10227.897721022844, 10374.221933354878, 13853.445862165601, 13968.580942571536, 13983.510577129751, 13985.300734963212, 13997.390300115414, 7367.857982012797, 7408.185099639036, 7432.2567743225245, 7533.171351151369, 7545.0, 7270.963645181846, 7361.1166660001145, 7472.0286362772495, 7491.10106787189, 7497.812554686067, 4376.890577735582, 4436.822527098944, 4446.155230506193, 4508.729476231437, 4522.66080043998, 1719.7678313427778, 1723.4398820383426, 1760.938367157169, 1837.724171952793, 1915.396650055228, 842.688205364007, 848.4866655673229, 909.8043920557112, 925.2505470568726, 937.9635502769478, 16599.751003734953, 16664.58338541522, 16932.06873621938, 18464.538386540444, 19324.61350773005, 820.4902978519433, 855.4696088425217, 860.2515811244258, 863.48622569571, 887.0730087059039, 6593.0, 9479.0, 9522.90477095234, 9642.71071867845, 9780.364276322016, 405766.0, 406208.0, 418223.0, 420123.0, 423399.0, 75914.62042689751, 80695.59652201818, 81954.59022704848, 86120.0, 86284.62588298824, 393.1037235103968, 407.1490584678037, 418.6608846834074, 420.8463910672644, 425.28552032585554, 9792.0, 10188.134008609351, 10191.082802547806, 10223.948880255552, 10334.173266138841, 38056.61943380531, 39111.217775644895, 39269.0, 39944.0, 40010.399844002946, 52313.47686523086, 54325.0, 54580.72709636585, 54705.0, 54941.0, 6881.174259088942, 7207.495475316888, 7391.113066432063, 7408.555486670817, 7466.0, 7420.92579074224, 8432.957835210786, 10354.0, 11257.437128143723, 11567.942160289482, 9713.36863103896, 9782.804343913223, 9813.26400519978, 9873.901260987299, 10044.096031357212, 9095.135962083592, 9366.297527685314, 9383.671571494964, 9674.17769489573, 9825.263105266991, 9592.9040709592, 9599.760005999906, 9669.323147379617, 10262.834733005768, 10353.74115647115, 7406.111266648037, 7428.442866784904, 7473.103227612722, 7578.280063393969, 7603.657835397531, 9346.579403926975, 9803.901960980298, 9972.30193886421, 10036.799264014824, 10270.897291026995], "value": 7951.96712640271, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1323.6756994536338, 1389.1040279020033, 1446.9855301446983, 1663.750437434384, 1703.3952946703928, 7526.39788816894, 7947.960260198691, 8000.679972801088, 8012.839743205132, 8050.637721302541, 6579.769708060219, 6779.7627083051975, 6788.864222715542, 6945.305469453052, 7883.251091146332, 1879.9342023029196, 2148.2803260907535, 2221.3558068160214, 2227.354067320475, 2241.5180736141724, 2242.686023956647, 2252.5157091225383, 2272.6136556785304, 2274.715660542432, 2275.101334972685, 1844.2254253213616, 2138.5295235048343, 2221.6445368741006, 2225.4770129019666, 2228.520868013377, 2187.660912558556, 2227.3318004598555, 2229.8216142708625, 2231.3529076567775, 2235.642297232435, 2115.5663089066707, 2121.31057406342, 2130.4247853079737, 2151.236311109549, 2158.935231943044, 7975.880361794578, 7998.12020677725, 8005.639746211435, 8016.358691304682, 8021.839563208703, 4708.57622813945, 4727.881802954919, 4834.564889159958, 4862.3922009748785, 4863.732494712789, 2810.18504633656, 2868.2542538939815, 2904.419116176773, 2917.28526511004, 2923.8099523531114, 951.9904800951971, 980.6077568972397, 981.9312648114635, 1005.9295849290553, 1007.5264625625944, 10783.6225732099, 10815.729606759814, 10818.026377625973, 10832.945835270852, 10874.510647020903, 4103.363978583325, 4273.867425132343, 4305.203537345601, 4387.144506821203, 4388.692791504564, 9229.446233226028, 9237.491937943478, 9258.0, 9261.351705380694, 9275.072492750805, 4708.693934894221, 4716.764161791897, 4718.669693121517, 4720.905581888412, 4734.479207287196, 3741.2330472253125, 3743.288775132716, 4302.26861433557, 4322.7190232634775, 4328.8484903028875, 3633.1462106404974, 3798.430235464647, 3803.5435747710453, 3803.82882770276, 3822.0444888777806, 1207.849018872641, 1241.366902879538, 1242.6147894152841, 1265.1713127901055, 1271.5041133957764, 765.9348955338747, 857.9656813727506, 876.9210771030638, 877.8397768035151, 905.5924833824805, 5178.61160412963, 5238.0, 5335.973320133375, 5364.597655175878, 5383.973080134574, 401.88345379840104, 410.47049306395013, 420.3232795199726, 425.27702905061517, 428.8756260684429, 3674.3937250353392, 3755.0, 3774.8678796241998, 3834.789086600208, 3841.769493830379, 9241.768955776024, 9620.230381569458, 9717.46553939526, 9732.70801875945, 9744.07431294026, 9596.280278979104, 9647.179989700813, 9654.662086826927, 9669.129778319984, 9669.709908702609, 7292.927070729224, 7326.04761381017, 7363.374113200331, 7440.925590744131, 7446.813829654302, 5257.947420525746, 5372.811951581676, 5406.405295417422, 5410.404855465974, 5462.481064298885, 9025.323100767337, 9069.682561110329, 9156.587953541974, 9187.127222913812, 9218.585163667785, 7914.960425198067, 8350.958245208734, 8636.697715579925, 8680.696175633822, 9225.446473211628, 6568.211814582281, 6787.89818152738, 6797.72809087631, 6835.316468353125, 6956.686949087202, 7449.366803821519, 7477.88783168242, 7607.961960190164, 7618.771436856903, 7635.08378994502, 6910.101686780687, 6944.201416837129, 6986.091808064919, 7078.044463997295, 7079.858402832017, 6822.522423430511, 6854.657267136723, 6878.8624227516175, 6905.551139175937, 6984.895226571504, 6360.109584658244, 6405.903911441239, 6418.19772528434, 6421.068945003042, 6430.099786029866, 4677.906441871211, 4681.929771053369, 4698.765061746967, 4720.315554244547, 4732.952670473252, 4753.263244197155, 4758.286257061469, 4783.378160839069, 4793.904121917472, 4847.612191024639], "value": 4112.678484557479, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [291.389538915971, 292.485226002236, 298.35257491244005, 308.31092508244086, 311.1521104988907, 4780.2590598457255, 4847.927281090787, 4876.268559716044, 4894.192458244385, 4911.421503710545, 4561.452625684922, 4665.4168228971375, 4670.136024835408, 4686.929696054562, 4803.783829727662, 3679.668829805317, 3715.034091136297, 3731.9253614927684, 3842.9615703842883, 3844.9231015379673, 3809.085819403351, 3824.101336185994, 3830.912152876689, 3852.9422058669143, 3868.613138686123, 3572.9821350893208, 3772.8679496217637, 3812.7331086823797, 3829.463875057494, 3830.7893065881367, 3739.8130093495215, 3747.4004159334377, 3756.1736417988, 3756.267527832074, 3764.0, 3274.361499507597, 3278.2951665392056, 3284.425225585513, 3314.8839790607453, 3320.9501857472155, 4724.362211101492, 4752.0, 4756.07256584966, 4762.1666208413735, 4764.904701905943, 4048.210598933209, 4242.109157077018, 4260.723053001545, 4285.5071666758095, 4310.978445107786, 5007.298978143063, 5008.424031236382, 5035.370578677665, 5035.874103147414, 5038.143515602356, 3561.0385195997196, 3569.161247106928, 3570.6786389225094, 3578.8926332210076, 3593.6406359364114, 5172.6379153459275, 5240.528352448298, 5253.26454296395, 5273.841784746463, 5281.867953301198, 3636.090977255686, 3640.5995340512522, 3645.671889529955, 3659.579148397915, 3668.926621467556, 3709.10981364476, 3723.6090210528046, 3729.4778730977687, 3739.569949455793, 3747.8500859965297, 4261.424707664426, 4266.8052945175405, 4278.44380230568, 4287.256156060124, 4298.570142985739, 4884.413870335582, 5012.198048312325, 5042.193249080129, 5050.6464547482055, 5051.166557518042, 1218.939053047344, 1262.3688155922039, 1264.5700461842835, 1270.091884302728, 1291.7674818532755, 858.9699360522352, 879.6481407437076, 882.6557642519423, 888.3515034025069, 892.6964831957166, 4358.65130789536, 4420.823167073346, 4427.40230068943, 4459.509453960061, 4489.147062058199, 5164.2770012198325, 5164.457731938092, 5165.586753059822, 5169.689818610896, 5171.50870667286, 4314.50383205929, 4393.362962370438, 4443.466783985878, 4450.910981780346, 4457.68796184264, 2716.253030416651, 2719.5920611908373, 2744.4373903349765, 2745.492083964473, 2749.2164733051386, 4823.204171311764, 4876.756162191948, 4903.681260718042, 4908.852734417973, 4923.77842997066, 4994.951060277383, 5224.09320597979, 5226.843194704165, 5242.370915490165, 5250.65870718402, 4854.344663470457, 4879.414470263591, 4899.461059283476, 4911.336969509142, 4913.48408417111, 5095.87260318495, 5105.28526006352, 5125.769340379767, 5139.331886854685, 5154.53609175176, 4858.78135483897, 4898.498462700082, 4999.475055119306, 5010.574101201439, 5014.147594908947, 4837.7581120943105, 4856.611471082376, 4863.537963893425, 4871.002888815568, 4881.90236195267, 3643.3806252937593, 3645.325614761278, 3655.7440979131206, 3669.7614655047337, 3671.9816400917825, 4960.181570040902, 5009.699418034929, 5088.389393272831, 5093.974530127326, 5130.333056702754, 4916.901661966812, 4934.55588996992, 4936.581075273162, 4946.678465899705, 4951.331570238116, 4916.213405855046, 4966.180580204225, 4986.4043506077705, 4990.925136122888, 5014.197728363444, 4693.366395536559, 4732.432108147044, 4828.975855120702, 4882.584980276716, 4901.852944411673, 5070.974645126751, 5078.21287700407, 5079.415867175175, 5094.15946368845, 5103.897922041612, 4982.704496830777, 4986.301917731593, 4987.925181122214, 4991.450940396626, 4997.275939800763], "value": 3787.5797311946594, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [618.6813790897687, 682.1302838880424, 701.0352151376076, 709.5352544083623, 725.7822653204041, 12255.877441225584, 13236.404361803718, 13253.668658283535, 13256.337183140853, 13267.469301227964, 11839.526418943233, 12009.219400738968, 12061.155719099666, 13235.404406801694, 13559.050866439353, 630.5743623054443, 762.1463960364399, 768.2317682317682, 768.8231706707461, 772.4785769605522, 645.7126578672493, 756.7994481462417, 777.5062835099695, 777.510168593788, 778.7897267737708, 819.315871247506, 826.9090400055989, 828.0518805967164, 828.3580225325361, 828.8300898315861, 651.6839332923528, 793.6587267474983, 818.5497976113173, 818.664347617477, 819.0335404223015, 586.521984582568, 586.7682265505101, 587.4067192135974, 587.7854583077188, 595.3778301674761, 13508.121972071882, 13560.118592291568, 13589.660258493617, 13593.252371119584, 13613.795793063013, 12594.0, 12799.48802047917, 12865.16376435538, 12933.611991640266, 13240.602781916557, 11696.18126731129, 11746.823797643043, 11806.291622502677, 11836.526538938431, 12000.159988800788, 3180.8415087411076, 3283.5567198428384, 3289.802611843297, 3327.73378129749, 4154.50145982481, 59031.40968590345, 59702.40297597055, 59943.70028149831, 60738.39261607372, 60849.087263690635, 9821.017898210122, 10111.696649100539, 10279.177665786869, 10437.530311136017, 10509.264351495474, 19507.51231219231, 20115.597688046157, 20140.194392224148, 20153.193872244945, 20766.58466830655, 7348.448866335047, 7442.665080071301, 7547.471676982668, 7553.8866916996285, 7634.975822243549, 3864.806759662006, 3976.8210430530694, 3982.5420076691553, 3998.620131087542, 4090.0592863641527, 2938.4416960777385, 3040.878364865425, 3042.2242328206166, 3045.9238519037203, 3047.299121202136, 536.3349446686159, 537.0976759044842, 542.4114835403552, 550.3368441028551, 550.529297450682, 475.3440252451664, 489.48359480748155, 524.1299442924727, 540.8026070484324, 545.5962587685163, 7967.3626109911065, 8127.634256458474, 8352.248297653241, 8398.244158025807, 8476.19476149777, 583.8585565219985, 595.8272101090636, 611.1566038866425, 625.8278973282293, 632.0496894409938, 3895.8441662333757, 3989.4813674222164, 4057.4522439470293, 4103.9179216416105, 4133.648639865585, 52287.21569176466, 52911.47088529143, 96613.51693241489, 98018.50990745, 98047.50976245073, 80727.59636201781, 83192.58403708064, 83997.0, 84126.0, 84209.0, 46742.76628616835, 52284.47715522796, 74353.25646743571, 76024.23975760282, 76128.61935690285, 7586.848263034819, 7652.273034061755, 7730.652120654697, 7925.247101525346, 8064.717734879251, 44206.77896610496, 45085.77457112693, 45947.540524595664, 46170.69146542592, 46185.76907115443, 65239.673801630684, 66467.33532664612, 66656.33343666501, 66727.0, 66916.330836691, 10350.689479315633, 10680.252382333161, 10884.0, 11045.668629941114, 11251.15616328795, 11315.773684526099, 11405.543778248777, 11642.825357619473, 12058.216215945935, 12086.758264834478, 9820.607175713178, 9960.701178964642, 10362.067413932782, 10393.116585090353, 10439.269251152346, 9948.602055917681, 10127.0, 10244.795104098026, 10350.689479315633, 10426.739331516772, 9783.168430683472, 9876.0, 10291.382517049002, 11020.559177632806, 11056.391898445663, 8724.69463568772, 8927.285817134483, 8933.28533717288, 9134.817303653757, 9555.9044409555, 8645.394822362374, 8649.567521623767, 8700.825983480421, 8797.47215167092, 9048.638054478011], "value": 6423.583613869857, "unit": "score"}], "name": "dromaeo_css", "value": 6377.362678392896, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 116.0, 114.0, 115.0, 113.0, 113.0, 113.0, 113.0, 114.0, 115.0], "value": 112.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 128.0, 129.0, 184.0, 122.0, 127.0, 144.0, 121.0, 154.0, 124.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 163.0, 160.0, 161.0, 161.0, 164.0, 161.0, 159.0, 160.0, 160.0], "value": 161.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 75.0, 77.0, 102.0, 78.0, 76.0, 75.0, 77.0, 102.0, 76.0], "value": 81.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 85.0, 133.0, 84.0, 85.0, 85.0, 115.0, 83.0, 84.0, 127.0], "value": 96.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0], "value": 117.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0], "value": 146.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 63.0, 64.0, 63.0, 62.0, 63.0, 65.0, 63.0, 62.0], "value": 63.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 66.0, 66.0, 67.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 80.0, 84.0, 78.0, 77.0, 80.0, 78.0, 78.0, 80.0, 82.0], "value": 80.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [129.0, 131.0, 132.0, 129.0, 127.0, 127.0, 131.0, 127.0, 171.0, 135.0], "value": 133.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 165.0, 166.0, 165.0, 163.0, 170.0, 168.0, 164.0, 162.0, 161.0], "value": 164.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 65.0, 68.0, 66.0, 65.0, 66.0, 66.0, 65.0, 65.0, 67.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1523.1000000000006, "alertThreshold": 2.0}]} 01:37:44 INFO - Return code: 0 01:37:44 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 01:37:44 INFO - # TBPL SUCCESS # 01:37:44 INFO - Running post-action listener: _resource_record_post_action 01:37:44 INFO - ##### 01:37:44 INFO - ##### Finished run-tests step (success) 01:37:44 INFO - ##### 01:37:44 INFO - Running post-run listener: _resource_record_post_run 01:37:44 INFO - Total resource usage - Wall time: 1202s; CPU: 13.0%; Read bytes: 0; Write bytes: 535928832; Read time: 0; Write time: 1360864 01:37:44 INFO - TinderboxPrint: CPU usage
13.0% 01:37:44 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 01:37:44 INFO - TinderboxPrint: I/O write bytes / time
535,928,832 / 1,360,864 01:37:44 INFO - TinderboxPrint: CPU idle
8,340.7 (86.9%) 01:37:44 INFO - TinderboxPrint: CPU user
1,201.8 (12.5%) 01:37:44 INFO - TinderboxPrint: Swap in / out
0 / 0 01:37:44 INFO - install - Wall time: 17s; CPU: 17.0%; Read bytes: 0; Write bytes: 246738944; Read time: 0; Write time: 717780 01:37:44 INFO - run-tests - Wall time: 1186s; CPU: 13.0%; Read bytes: 0; Write bytes: 289189888; Read time: 0; Write time: 643084 01:37:45 INFO - Running post-run listener: _upload_blobber_files 01:37:45 INFO - Blob upload gear active. 01:37:45 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 01:37:45 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 01:37:45 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'] 01:37:45 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 01:37:45 INFO - (blobuploader) - INFO - Open directory for files ... 01:37:45 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 01:37:45 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:37:45 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:37:52 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 01:37:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:37:52 INFO - (blobuploader) - INFO - Done attempting. 01:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 01:37:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:37:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:37:52 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 01:37:52 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:37:52 INFO - (blobuploader) - INFO - Done attempting. 01:37:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 01:37:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 01:37:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 01:37:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 01:37:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 01:37:53 INFO - (blobuploader) - INFO - Done attempting. 01:37:53 INFO - (blobuploader) - INFO - Iteration through files over. 01:37:53 INFO - Return code: 0 01:37:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 01:37:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 01:37:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/582e40fae639a63095ce802f8077f36c16f04404519d1f2283086d65881158e16d94d5c98387d8511cc422c7e73219ca648a13272b8d28c45aacd920fbfef9f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f82e3ffa73a2d4aa19b9da03075941cbb486f90e1a4d06c66df86e8d0781364ac7d673a124c56279543cd7e22259da5e907507f0b73b009b1cb0cd9331d1e4ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f8532e69840f050fc10fd9b4aceb676b26f372759cf7568a1e398b5de06c2bc6a14a725863828e7764fda1cc0544dcb16f3be5b6d39432e57256ac52c7fe9397"} 01:37:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 01:37:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 01:37:53 INFO - Contents: 01:37:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/582e40fae639a63095ce802f8077f36c16f04404519d1f2283086d65881158e16d94d5c98387d8511cc422c7e73219ca648a13272b8d28c45aacd920fbfef9f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f82e3ffa73a2d4aa19b9da03075941cbb486f90e1a4d06c66df86e8d0781364ac7d673a124c56279543cd7e22259da5e907507f0b73b009b1cb0cd9331d1e4ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f8532e69840f050fc10fd9b4aceb676b26f372759cf7568a1e398b5de06c2bc6a14a725863828e7764fda1cc0544dcb16f3be5b6d39432e57256ac52c7fe9397"} 01:37:53 INFO - Running post-run listener: copy_logs_to_upload_dir 01:37:53 INFO - Copying logs to upload dir... 01:37:53 INFO - mkdir: /builds/slave/test/build/upload/logs 01:37:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1252.191190 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 52 secs) (at 2016-07-19 01:37:53.565484) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 01:37:53.568816) ========= 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=af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443 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/582e40fae639a63095ce802f8077f36c16f04404519d1f2283086d65881158e16d94d5c98387d8511cc422c7e73219ca648a13272b8d28c45aacd920fbfef9f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f82e3ffa73a2d4aa19b9da03075941cbb486f90e1a4d06c66df86e8d0781364ac7d673a124c56279543cd7e22259da5e907507f0b73b009b1cb0cd9331d1e4ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f8532e69840f050fc10fd9b4aceb676b26f372759cf7568a1e398b5de06c2bc6a14a725863828e7764fda1cc0544dcb16f3be5b6d39432e57256ac52c7fe9397"} build_url:https://queue.taskcluster.net/v1/task/cUN2MIolQLiEjPclOXN3sg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/cUN2MIolQLiEjPclOXN3sg/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/582e40fae639a63095ce802f8077f36c16f04404519d1f2283086d65881158e16d94d5c98387d8511cc422c7e73219ca648a13272b8d28c45aacd920fbfef9f1", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f82e3ffa73a2d4aa19b9da03075941cbb486f90e1a4d06c66df86e8d0781364ac7d673a124c56279543cd7e22259da5e907507f0b73b009b1cb0cd9331d1e4ba", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/f8532e69840f050fc10fd9b4aceb676b26f372759cf7568a1e398b5de06c2bc6a14a725863828e7764fda1cc0544dcb16f3be5b6d39432e57256ac52c7fe9397"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-19 01:37:53.594835) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 01:37:53.595219) ========= 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=af724c981e2a0f424dbabf99000001e7-1468913913.963860-1443288443 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004480 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-19 01:37:53.677317) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 01:37:53.677642) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-19 01:37:53.677941) ========= ========= Total master_lag: 0.17 =========