builder: autoland_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-007 starttime: 1467528527.73 results: success (0) buildid: 20160702144223 builduid: bd7aa9a48dd24fd185509157046c588d revision: b8b3b1c92085c1f8b74c13203289360932182da4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:47.732812) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:47.733322) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:47.733632) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:47.748896) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:47.749286) ========= 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=923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-02 23:48:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 104M=0s 2016-07-02 23:48:49 (104 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.102652 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:47.866361) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:47.866694) ========= 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=923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015921 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:47.916313) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:47.916680) ========= bash -c 'python archiver_client.py mozharness --repo integration/autoland --rev b8b3b1c92085c1f8b74c13203289360932182da4 --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 b8b3b1c92085c1f8b74c13203289360932182da4 --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=923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-02 23:48:49,393 truncating revision to first 12 chars 2016-07-02 23:48:49,393 Setting DEBUG logging. 2016-07-02 23:48:49,393 attempt 1/10 2016-07-02 23:48:49,393 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/autoland/b8b3b1c92085?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-02 23:48:50,004 unpacking tar archive at: autoland-b8b3b1c92085/testing/mozharness/ program finished with exit code 0 elapsedTime=0.949849 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:48.880438) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:48.880815) ========= script_repo_revision: b8b3b1c92085c1f8b74c13203289360932182da4 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:48.881221) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:48.881500) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-02 23:48:48.890894) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-02 23:48:48.891274) ========= /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=923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 23:48:50 INFO - MultiFileLogger online at 20160702 23:48:50 in /builds/slave/test 23:48:50 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 23:48:50 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 23:48:50 INFO - {'append_to_log': False, 23:48:50 INFO - 'base_work_dir': '/builds/slave/test', 23:48:50 INFO - 'blob_upload_branch': 'Autoland-Non-PGO', 23:48:50 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 23:48:50 INFO - 'branch': 'Autoland-Non-PGO', 23:48:50 INFO - 'buildbot_json_path': 'buildprops.json', 23:48:50 INFO - 'config_files': ('talos/linux_config.py',), 23:48:50 INFO - 'default_actions': ('clobber', 23:48:50 INFO - 'read-buildbot-config', 23:48:50 INFO - 'download-and-extract', 23:48:50 INFO - 'populate-webroot', 23:48:50 INFO - 'create-virtualenv', 23:48:50 INFO - 'install', 23:48:50 INFO - 'run-tests'), 23:48:50 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 23:48:50 INFO - 'download_minidump_stackwalk': True, 23:48:50 INFO - 'download_symbols': 'ondemand', 23:48:50 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 23:48:50 INFO - 'tooltool.py': '/tools/tooltool.py', 23:48:50 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 23:48:50 INFO - '/tools/misc-python/virtualenv.py')}, 23:48:50 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 23:48:50 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 23:48:50 INFO - 'installer_path': 'installer.exe', 23:48:50 INFO - 'log_level': 'info', 23:48:50 INFO - 'log_name': 'talos', 23:48:50 INFO - 'log_to_console': True, 23:48:50 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 23:48:50 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 23:48:50 INFO - 'opt_config_files': (), 23:48:50 INFO - 'pip_index': False, 23:48:50 INFO - 'sps_profile': False, 23:48:50 INFO - 'sps_profile_interval': 0, 23:48:50 INFO - 'suite': 'dromaeojs', 23:48:50 INFO - 'system_bits': '32', 23:48:50 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 23:48:50 INFO - 'title': 'talos-linux64-ix-007', 23:48:50 INFO - 'tooltool_cache': '/builds/tooltool_cache', 23:48:50 INFO - 'use_talos_json': True, 23:48:50 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 23:48:50 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 23:48:50 INFO - 'work_dir': 'build'} 23:48:50 INFO - ##### 23:48:50 INFO - ##### Running clobber step. 23:48:50 INFO - ##### 23:48:50 INFO - Running pre-action listener: _resource_record_pre_action 23:48:50 INFO - Running main action method: clobber 23:48:50 INFO - rmtree: /builds/slave/test/build 23:48:50 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 23:48:50 INFO - Running post-action listener: _resource_record_post_action 23:48:50 INFO - ##### 23:48:50 INFO - ##### Finished clobber step (success) 23:48:50 INFO - ##### 23:48:50 INFO - ##### 23:48:50 INFO - ##### Running read-buildbot-config step. 23:48:50 INFO - ##### 23:48:50 INFO - Running pre-action listener: _resource_record_pre_action 23:48:50 INFO - Running main action method: read_buildbot_config 23:48:50 INFO - Using buildbot properties: 23:48:50 INFO - { 23:48:50 INFO - "project": "", 23:48:50 INFO - "product": "firefox", 23:48:50 INFO - "script_repo_revision": "production", 23:48:50 INFO - "builddir": "autoland_ubuntu64_hw_test-dromaeojs", 23:48:50 INFO - "repository": "", 23:48:50 INFO - "buildername": "Ubuntu HW 12.04 x64 autoland talos dromaeojs", 23:48:50 INFO - "buildid": "20160702144223", 23:48:50 INFO - "pgo_build": "False", 23:48:50 INFO - "basedir": "/builds/slave/test", 23:48:50 INFO - "buildnumber": 10, 23:48:50 INFO - "slavename": "talos-linux64-ix-007", 23:48:50 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 23:48:50 INFO - "platform": "ubuntu64_hw", 23:48:50 INFO - "scheduler": "tests-autoland-linux64-talos", 23:48:50 INFO - "branch": "autoland", 23:48:50 INFO - "repo_path": "integration/autoland", 23:48:50 INFO - "revision": "b8b3b1c92085c1f8b74c13203289360932182da4", 23:48:50 INFO - "stage_platform": "linux64", 23:48:50 INFO - "builduid": "bd7aa9a48dd24fd185509157046c588d", 23:48:50 INFO - "slavebuilddir": "test" 23:48:50 INFO - } 23:48:50 INFO - Found installer url https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 23:48:50 INFO - Running post-action listener: _resource_record_post_action 23:48:50 INFO - ##### 23:48:50 INFO - ##### Finished read-buildbot-config step (success) 23:48:50 INFO - ##### 23:48:50 INFO - ##### 23:48:50 INFO - ##### Running download-and-extract step. 23:48:50 INFO - ##### 23:48:50 INFO - Running pre-action listener: _resource_record_pre_action 23:48:50 INFO - Running main action method: download_and_extract 23:48:50 INFO - mkdir: /builds/slave/test/build/tests 23:48:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:48:50 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 23:48:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:48:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:48:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:48:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:48:51 INFO - Downloaded 1361 bytes. 23:48:51 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 23:48:51 INFO - Using the following test package requirements: 23:48:51 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:48:51 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:48:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 23:48:51 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:48:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 23:48:51 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:48:51 INFO - u'jsshell-linux-x86_64.zip'], 23:48:51 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:48:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 23:48:51 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 23:48:51 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:48:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 23:48:51 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:48:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 23:48:51 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:48:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 23:48:51 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 23:48:51 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 23:48:51 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 23:48:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:48:51 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:48:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:48:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:48:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:48:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:48:52 INFO - Downloaded 22705905 bytes. 23:48:52 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'] 23:48:52 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 23:48:53 INFO - Return code: 0 23:48:53 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 23:48:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:48:53 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 23:48:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:48:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 23:48:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:48:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:48:54 INFO - Downloaded 22705905 bytes. 23:48:54 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'] 23:48:54 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 23:48:56 INFO - Return code: 0 23:48:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:48:56 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 23:48:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:48:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 23:48:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:48:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:48:57 INFO - Downloaded 14405327 bytes. 23:48:57 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'] 23:48:57 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 23:48:57 INFO - Return code: 0 23:48:57 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')]} 23:48:57 INFO - https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 23:48:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:48:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:48:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:48:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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 23:48:58 INFO - Downloaded 56486849 bytes. 23:48:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:48:58 INFO - mkdir: /builds/slave/test/properties 23:48:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 23:48:58 INFO - Writing to file /builds/slave/test/properties/build_url 23:48:58 INFO - Contents: 23:48:58 INFO - build_url:https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 23:48:59 INFO - Running post-action listener: _resource_record_post_action 23:48:59 INFO - Running post-action listener: set_extra_try_arguments 23:48:59 INFO - ##### 23:48:59 INFO - ##### Finished download-and-extract step (success) 23:48:59 INFO - ##### 23:48:59 INFO - ##### 23:48:59 INFO - ##### Running populate-webroot step. 23:48:59 INFO - ##### 23:48:59 INFO - Running pre-action listener: _resource_record_pre_action 23:48:59 INFO - Running main action method: populate_webroot 23:48:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 23:48:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 23:48:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 23:48:59 INFO - '--tppagecycles', 23:48:59 INFO - '7'], 23:48:59 INFO - 'tests': ['tsvgm']}}, 23:48:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 23:48:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 23:48:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 23:48:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 23:48:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 23:48:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 23:48:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:59 INFO - 'talos_options': ['--disable-e10s'], 23:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:48:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 23:48:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:59 INFO - 'talos_options': ['--disable-e10s'], 23:48:59 INFO - 'tests': ['damp', 'tps']}, 23:48:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:59 INFO - 'tests': ['damp', 'tps']}, 23:48:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 23:48:59 INFO - 'tests': ['dromaeo_dom']}, 23:48:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 23:48:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 23:48:59 INFO - 'tests': ['basic_compositor_video']}, 23:48:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 23:48:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 23:48:59 INFO - 'tests': ['a11yr', 23:48:59 INFO - 'ts_paint', 23:48:59 INFO - 'tpaint', 23:48:59 INFO - 'sessionrestore', 23:48:59 INFO - 'sessionrestore_no_auto_restore', 23:48:59 INFO - 'tabpaint']}, 23:48:59 INFO - 'other-e10s': {'tests': ['a11yr', 23:48:59 INFO - 'ts_paint', 23:48:59 INFO - 'tpaint', 23:48:59 INFO - 'sessionrestore', 23:48:59 INFO - 'sessionrestore_no_auto_restore', 23:48:59 INFO - 'tabpaint']}, 23:48:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 23:48:59 INFO - 'ts_paint', 23:48:59 INFO - 'tpaint', 23:48:59 INFO - 'sessionrestore', 23:48:59 INFO - 'sessionrestore_no_auto_restore', 23:48:59 INFO - 'tabpaint']}, 23:48:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 23:48:59 INFO - 'ts_paint', 23:48:59 INFO - 'tpaint', 23:48:59 INFO - 'sessionrestore', 23:48:59 INFO - 'sessionrestore_no_auto_restore', 23:48:59 INFO - 'tabpaint']}, 23:48:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 23:48:59 INFO - 'tests': ['a11yr', 23:48:59 INFO - 'ts_paint', 23:48:59 INFO - 'tpaint', 23:48:59 INFO - 'sessionrestore', 23:48:59 INFO - 'sessionrestore_no_auto_restore', 23:48:59 INFO - 'tabpaint']}, 23:48:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 23:48:59 INFO - 'tests': ['a11yr', 23:48:59 INFO - 'ts_paint', 23:48:59 INFO - 'tpaint', 23:48:59 INFO - 'sessionrestore', 23:48:59 INFO - 'sessionrestore_no_auto_restore', 23:48:59 INFO - 'tabpaint']}, 23:48:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 23:48:59 INFO - 'tests': ['tsvgx', 23:48:59 INFO - 'tsvgr_opacity', 23:48:59 INFO - 'tart', 23:48:59 INFO - 'tscrollx', 23:48:59 INFO - 'cart']}, 23:48:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 23:48:59 INFO - 'tsvgr_opacity', 23:48:59 INFO - 'tart', 23:48:59 INFO - 'tscrollx', 23:48:59 INFO - 'cart']}, 23:48:59 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:59 INFO - 'talos_options': ['--disable-e10s'], 23:48:59 INFO - 'tests': ['tp5o']}, 23:48:59 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:59 INFO - 'tests': ['tp5o']}, 23:48:59 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:59 INFO - 'talos_options': ['--disable-e10s', 23:48:59 INFO - '--xperf_path', 23:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:48:59 INFO - 'tests': ['tp5n']}, 23:48:59 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 23:48:59 INFO - 'talos_options': ['--xperf_path', 23:48:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 23:48:59 INFO - 'tests': ['tp5n']}}, 23:48:59 INFO - 'talos.zip': {'path': '', 23:48:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 23:48:59 INFO - Running post-action listener: _resource_record_post_action 23:48:59 INFO - ##### 23:48:59 INFO - ##### Finished populate-webroot step (success) 23:48:59 INFO - ##### 23:48:59 INFO - ##### 23:48:59 INFO - ##### Running create-virtualenv step. 23:48:59 INFO - ##### 23:48:59 INFO - Running pre-action listener: _resource_record_pre_action 23:48:59 INFO - Running main action method: create_virtualenv 23:48:59 INFO - Creating virtualenv /builds/slave/test/build/venv 23:48:59 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 23:48:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 23:48:59 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 23:48:59 INFO - Using real prefix '/usr' 23:48:59 INFO - New python executable in /builds/slave/test/build/venv/bin/python 23:49:00 INFO - Installing distribute.............................................................................................................................................................................................done. 23:49:02 INFO - Installing pip.................done. 23:49:02 INFO - Return code: 0 23:49:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 23:49: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')]} 23:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49: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')]} 23:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:02 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 0x22d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25983b0>, '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 0x25992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2599740>, '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': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', '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 23:49:02 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 23:49:02 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 23:49:02 INFO - Using env: {'DISPLAY': ':0', 23:49:02 INFO - 'HOME': '/home/cltbld', 23:49:02 INFO - 'LANG': 'en_US.UTF-8', 23:49:02 INFO - 'LANGUAGE': 'en_US:en', 23:49:02 INFO - 'LOGNAME': 'cltbld', 23:49:02 INFO - 'MAIL': '/var/mail/cltbld', 23:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:02 INFO - 'MOZ_NO_REMOTE': '1', 23:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:49:02 INFO - 'NO_EM_RESTART': '1', 23:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:02 INFO - 'PWD': '/builds/slave/test', 23:49:02 INFO - 'SHELL': '/bin/bash', 23:49:02 INFO - 'SHLVL': '1', 23:49:02 INFO - 'TERM': 'linux', 23:49:02 INFO - 'TMOUT': '86400', 23:49:02 INFO - 'USER': 'cltbld', 23:49:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', 23:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:02 INFO - '_': '/tools/buildbot/bin/python'} 23:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:49:02 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 23:49:02 INFO - Cleaning up... 23:49:02 INFO - Return code: 0 23:49:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 23:49: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')]} 23:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49: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')]} 23:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:02 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 0x22d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25983b0>, '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 0x25992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2599740>, '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': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', '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 23:49:02 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 23:49:02 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 23:49:02 INFO - Using env: {'DISPLAY': ':0', 23:49:02 INFO - 'HOME': '/home/cltbld', 23:49:02 INFO - 'LANG': 'en_US.UTF-8', 23:49:02 INFO - 'LANGUAGE': 'en_US:en', 23:49:02 INFO - 'LOGNAME': 'cltbld', 23:49:02 INFO - 'MAIL': '/var/mail/cltbld', 23:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:02 INFO - 'MOZ_NO_REMOTE': '1', 23:49:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:49:02 INFO - 'NO_EM_RESTART': '1', 23:49:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:02 INFO - 'PWD': '/builds/slave/test', 23:49:02 INFO - 'SHELL': '/bin/bash', 23:49:02 INFO - 'SHLVL': '1', 23:49:02 INFO - 'TERM': 'linux', 23:49:02 INFO - 'TMOUT': '86400', 23:49:02 INFO - 'USER': 'cltbld', 23:49:02 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', 23:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:02 INFO - '_': '/tools/buildbot/bin/python'} 23:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:49:02 INFO - Downloading/unpacking psutil>=3.1.1 23:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:49:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:49:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:49:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:49:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 23:49:04 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:49:04 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:49:04 INFO - Installing collected packages: psutil 23:49:04 INFO - Running setup.py install for psutil 23:49:04 INFO - building 'psutil._psutil_linux' extension 23:49:04 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 23:49:04 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 23:49:04 INFO - building 'psutil._psutil_posix' extension 23:49:04 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 23:49:05 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 23:49:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 23:49:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 23:49:05 INFO - Successfully installed psutil 23:49:05 INFO - Cleaning up... 23:49:05 INFO - Return code: 0 23:49:05 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 23:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:49:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:49:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:49:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:49:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x22d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25983b0>, '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 0x25992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2599740>, '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': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', '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 23:49:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 23:49:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 23:49:05 INFO - Using env: {'DISPLAY': ':0', 23:49:05 INFO - 'HOME': '/home/cltbld', 23:49:05 INFO - 'LANG': 'en_US.UTF-8', 23:49:05 INFO - 'LANGUAGE': 'en_US:en', 23:49:05 INFO - 'LOGNAME': 'cltbld', 23:49:05 INFO - 'MAIL': '/var/mail/cltbld', 23:49:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:05 INFO - 'MOZ_NO_REMOTE': '1', 23:49:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:49:05 INFO - 'NO_EM_RESTART': '1', 23:49:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:49:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:05 INFO - 'PWD': '/builds/slave/test', 23:49:05 INFO - 'SHELL': '/bin/bash', 23:49:05 INFO - 'SHLVL': '1', 23:49:05 INFO - 'TERM': 'linux', 23:49:05 INFO - 'TMOUT': '86400', 23:49:05 INFO - 'USER': 'cltbld', 23:49:05 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', 23:49:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:05 INFO - '_': '/tools/buildbot/bin/python'} 23:49:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:49:05 INFO - Downloading/unpacking mozsystemmonitor==0.3 23:49:05 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 23:49:05 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 23:49:05 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 23:49:05 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 23:49:05 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 23:49:05 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 23:49:07 INFO - Downloading mozsystemmonitor-0.3.tar.gz 23:49:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 23:49:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 23:49:07 INFO - Installing collected packages: mozsystemmonitor 23:49:07 INFO - Running setup.py install for mozsystemmonitor 23:49:07 INFO - Successfully installed mozsystemmonitor 23:49:07 INFO - Cleaning up... 23:49:07 INFO - Return code: 0 23:49:07 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 23:49:07 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')]} 23:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:07 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')]} 23:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:07 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 0x22d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25983b0>, '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 0x25992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2599740>, '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': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', '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 23:49:07 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 23:49:07 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 23:49:07 INFO - Using env: {'DISPLAY': ':0', 23:49:07 INFO - 'HOME': '/home/cltbld', 23:49:07 INFO - 'LANG': 'en_US.UTF-8', 23:49:07 INFO - 'LANGUAGE': 'en_US:en', 23:49:07 INFO - 'LOGNAME': 'cltbld', 23:49:07 INFO - 'MAIL': '/var/mail/cltbld', 23:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:07 INFO - 'MOZ_NO_REMOTE': '1', 23:49:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:49:07 INFO - 'NO_EM_RESTART': '1', 23:49:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:07 INFO - 'PWD': '/builds/slave/test', 23:49:07 INFO - 'SHELL': '/bin/bash', 23:49:07 INFO - 'SHLVL': '1', 23:49:07 INFO - 'TERM': 'linux', 23:49:07 INFO - 'TMOUT': '86400', 23:49:07 INFO - 'USER': 'cltbld', 23:49:07 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', 23:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:07 INFO - '_': '/tools/buildbot/bin/python'} 23:49:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:49:07 INFO - Downloading/unpacking jsonschema==2.5.1 23:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:49:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:49:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:49:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:49:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 23:49:09 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 23:49:09 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 23:49:09 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 23:49:09 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 23:49:09 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 23:49:09 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 23:49:09 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 23:49:09 INFO - Downloading functools32-3.2.3-2.tar.gz 23:49:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 23:49:09 INFO - warning: no files found matching '*.txt' 23:49:09 INFO - no previously-included directories found matching 'build' 23:49:09 INFO - no previously-included directories found matching 'dist' 23:49:09 INFO - no previously-included directories found matching '.git*' 23:49:09 INFO - Installing collected packages: jsonschema, functools32 23:49:09 INFO - Running setup.py install for functools32 23:49:10 INFO - warning: no files found matching '*.txt' 23:49:10 INFO - no previously-included directories found matching 'build' 23:49:10 INFO - no previously-included directories found matching 'dist' 23:49:10 INFO - no previously-included directories found matching '.git*' 23:49:10 INFO - Successfully installed jsonschema functools32 23:49:10 INFO - Cleaning up... 23:49:10 INFO - Return code: 0 23:49:10 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 23:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 23:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x22d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25983b0>, '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 0x25992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2599740>, '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': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', '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 23:49:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 23:49:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 23:49:10 INFO - Using env: {'DISPLAY': ':0', 23:49:10 INFO - 'HOME': '/home/cltbld', 23:49:10 INFO - 'LANG': 'en_US.UTF-8', 23:49:10 INFO - 'LANGUAGE': 'en_US:en', 23:49:10 INFO - 'LOGNAME': 'cltbld', 23:49:10 INFO - 'MAIL': '/var/mail/cltbld', 23:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:10 INFO - 'MOZ_NO_REMOTE': '1', 23:49:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:49:10 INFO - 'NO_EM_RESTART': '1', 23:49:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:10 INFO - 'PWD': '/builds/slave/test', 23:49:10 INFO - 'SHELL': '/bin/bash', 23:49:10 INFO - 'SHLVL': '1', 23:49:10 INFO - 'TERM': 'linux', 23:49:10 INFO - 'TMOUT': '86400', 23:49:10 INFO - 'USER': 'cltbld', 23:49:10 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', 23:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:10 INFO - '_': '/tools/buildbot/bin/python'} 23:49:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:49:10 INFO - Downloading/unpacking blobuploader==1.2.4 23:49:10 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 23:49:10 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 23:49:10 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 23:49:10 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 23:49:10 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 23:49:10 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 23:49:12 INFO - Downloading blobuploader-1.2.4.tar.gz 23:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 23:49:12 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 23:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:49:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 23:49:12 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 23:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:49:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:49:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 23:49:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 23:49:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 23:49:12 INFO - Downloading docopt-0.6.1.tar.gz 23:49:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 23:49:13 INFO - Installing collected packages: blobuploader, requests, docopt 23:49:13 INFO - Running setup.py install for blobuploader 23:49:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 23:49:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 23:49:13 INFO - Running setup.py install for requests 23:49:13 INFO - Running setup.py install for docopt 23:49:13 INFO - Successfully installed blobuploader requests docopt 23:49:13 INFO - Cleaning up... 23:49:13 INFO - Return code: 0 23:49:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:49: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')]} 23:49:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:49:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49: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')]} 23:49:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:49:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:13 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 0x22d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25983b0>, '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 0x25992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2599740>, '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': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', '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 23:49:13 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 23:49:13 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 23:49:13 INFO - Using env: {'DISPLAY': ':0', 23:49:13 INFO - 'HOME': '/home/cltbld', 23:49:13 INFO - 'LANG': 'en_US.UTF-8', 23:49:13 INFO - 'LANGUAGE': 'en_US:en', 23:49:13 INFO - 'LOGNAME': 'cltbld', 23:49:13 INFO - 'MAIL': '/var/mail/cltbld', 23:49:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:13 INFO - 'MOZ_NO_REMOTE': '1', 23:49:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:49:13 INFO - 'NO_EM_RESTART': '1', 23:49:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:49:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:13 INFO - 'PWD': '/builds/slave/test', 23:49:13 INFO - 'SHELL': '/bin/bash', 23:49:13 INFO - 'SHLVL': '1', 23:49:13 INFO - 'TERM': 'linux', 23:49:13 INFO - 'TMOUT': '86400', 23:49:13 INFO - 'USER': 'cltbld', 23:49:13 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', 23:49:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:13 INFO - '_': '/tools/buildbot/bin/python'} 23:49:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:49:13 INFO - Running setup.py (path:/tmp/pip-84XnsO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:49:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:49:13 INFO - Running setup.py (path:/tmp/pip-Rw9mBN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:49:14 INFO - Running setup.py (path:/tmp/pip-e0BzBC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:49:14 INFO - Running setup.py (path:/tmp/pip-chSv36-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:49:14 INFO - Running setup.py (path:/tmp/pip-bN7qJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:49:14 INFO - Running setup.py (path:/tmp/pip-xQJ45a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:49:14 INFO - Running setup.py (path:/tmp/pip-GAW5Cy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:49:14 INFO - Running setup.py (path:/tmp/pip-pcqOoK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:49:14 INFO - Running setup.py (path:/tmp/pip-qLxTw9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:49:14 INFO - Running setup.py (path:/tmp/pip-7_0b_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:49:14 INFO - Running setup.py (path:/tmp/pip-n40z41-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:49:14 INFO - Running setup.py (path:/tmp/pip-xUETmO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:49:14 INFO - Running setup.py (path:/tmp/pip-cj0b7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:49:14 INFO - Running setup.py (path:/tmp/pip-o7_dGi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:49:14 INFO - Running setup.py (path:/tmp/pip-iTMl80-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:49:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:49:14 INFO - Running setup.py (path:/tmp/pip-xTqdM5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:49:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:49:15 INFO - Running setup.py (path:/tmp/pip-Uj26ix-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:49:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 23:49:15 INFO - Running setup.py install for manifestparser 23:49:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 23:49:15 INFO - Running setup.py install for mozcrash 23:49:15 INFO - Running setup.py install for mozdebug 23:49:15 INFO - Running setup.py install for mozdevice 23:49:15 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 23:49:15 INFO - Installing dm script to /builds/slave/test/build/venv/bin 23:49:15 INFO - Running setup.py install for mozfile 23:49:15 INFO - Running setup.py install for mozhttpd 23:49:15 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 23:49:15 INFO - Running setup.py install for mozinfo 23:49:15 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 23:49:15 INFO - Running setup.py install for mozInstall 23:49:15 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 23:49:15 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 23:49:15 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 23:49:15 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 23:49:15 INFO - Running setup.py install for mozleak 23:49:16 INFO - Running setup.py install for mozlog 23:49:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 23:49:16 INFO - Running setup.py install for moznetwork 23:49:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 23:49:16 INFO - Running setup.py install for mozprocess 23:49:16 INFO - Running setup.py install for mozprofile 23:49:16 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 23:49:16 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 23:49:16 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 23:49:16 INFO - Running setup.py install for mozrunner 23:49:16 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 23:49:16 INFO - Running setup.py install for mozscreenshot 23:49:16 INFO - Running setup.py install for moztest 23:49:16 INFO - Running setup.py install for mozversion 23:49:16 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 23:49:16 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 23:49:16 INFO - Cleaning up... 23:49:16 INFO - Return code: 0 23:49:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:49: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')]} 23:49:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:49:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49: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')]} 23:49:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:49:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:16 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 0x22d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25983b0>, '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 0x25992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2599740>, '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': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', '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 23:49:16 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 23:49:16 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 23:49:16 INFO - Using env: {'DISPLAY': ':0', 23:49:16 INFO - 'HOME': '/home/cltbld', 23:49:16 INFO - 'LANG': 'en_US.UTF-8', 23:49:16 INFO - 'LANGUAGE': 'en_US:en', 23:49:16 INFO - 'LOGNAME': 'cltbld', 23:49:16 INFO - 'MAIL': '/var/mail/cltbld', 23:49:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:16 INFO - 'MOZ_NO_REMOTE': '1', 23:49:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:49:16 INFO - 'NO_EM_RESTART': '1', 23:49:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:49:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:16 INFO - 'PWD': '/builds/slave/test', 23:49:16 INFO - 'SHELL': '/bin/bash', 23:49:16 INFO - 'SHLVL': '1', 23:49:16 INFO - 'TERM': 'linux', 23:49:16 INFO - 'TMOUT': '86400', 23:49:16 INFO - 'USER': 'cltbld', 23:49:16 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', 23:49:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:16 INFO - '_': '/tools/buildbot/bin/python'} 23:49:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 23:49:17 INFO - Running setup.py (path:/tmp/pip-q9I1s3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 23:49:17 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)) 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 23:49:17 INFO - Running setup.py (path:/tmp/pip-RJOWbF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 23:49:17 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)) 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 23:49:17 INFO - Running setup.py (path:/tmp/pip-nCv36N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 23:49:17 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)) 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 23:49:17 INFO - Running setup.py (path:/tmp/pip-ldMjdu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 23:49:17 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)) 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 23:49:17 INFO - Running setup.py (path:/tmp/pip-L4L8In-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 23:49:17 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)) 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 23:49:17 INFO - Running setup.py (path:/tmp/pip-rC7Joz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 23:49:17 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)) 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 23:49:17 INFO - Running setup.py (path:/tmp/pip-cCdnWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 23:49:17 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)) 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 23:49:17 INFO - Running setup.py (path:/tmp/pip-kr1qKK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 23:49:17 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)) 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 23:49:17 INFO - Running setup.py (path:/tmp/pip-iA6Ohk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 23:49:17 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)) 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 23:49:17 INFO - Running setup.py (path:/tmp/pip-kfFUKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 23:49:17 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)) 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 23:49:17 INFO - Running setup.py (path:/tmp/pip-aoi53X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 23:49:17 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)) 23:49:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 23:49:17 INFO - Running setup.py (path:/tmp/pip-ndp0f7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 23:49:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 23:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 23:49:18 INFO - Running setup.py (path:/tmp/pip-Lwzwl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 23:49:18 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)) 23:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 23:49:18 INFO - Running setup.py (path:/tmp/pip-Nw2wX7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 23:49:18 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 23:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 23:49:18 INFO - Running setup.py (path:/tmp/pip-Yx8_Rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 23:49:18 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)) 23:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 23:49:18 INFO - Running setup.py (path:/tmp/pip-wr70DP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 23:49:18 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)) 23:49:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 23:49:18 INFO - Running setup.py (path:/tmp/pip-ktT6lh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 23:49:18 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)) 23:49:18 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)) 23:49:18 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)) 23:49:18 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)) 23:49:18 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)) 23:49:18 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)) 23:49:18 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 23:49:18 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 23:49:18 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 23:49:18 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 23:49:18 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 23:49:18 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 23:49:18 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 23:49:20 INFO - Downloading blessings-1.6.tar.gz 23:49:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 23:49:20 INFO - Installing collected packages: blessings 23:49:20 INFO - Running setup.py install for blessings 23:49:20 INFO - Successfully installed blessings 23:49:20 INFO - Cleaning up... 23:49:20 INFO - Return code: 0 23:49:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 23:49:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:49:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:49:20 INFO - Reading from file tmpfile_stdout 23:49:20 INFO - Current package versions: 23:49:20 INFO - argparse == 1.2.1 23:49:20 INFO - blessings == 1.6 23:49:20 INFO - blobuploader == 1.2.4 23:49:20 INFO - docopt == 0.6.1 23:49:20 INFO - functools32 == 3.2.3-2 23:49:20 INFO - jsonschema == 2.5.1 23:49:20 INFO - manifestparser == 1.1 23:49:20 INFO - mozInstall == 1.12 23:49:20 INFO - mozcrash == 0.17 23:49:20 INFO - mozdebug == 0.1 23:49:20 INFO - mozdevice == 0.48 23:49:20 INFO - mozfile == 1.2 23:49:20 INFO - mozhttpd == 0.7 23:49:20 INFO - mozinfo == 0.9 23:49:20 INFO - mozleak == 0.1 23:49:20 INFO - mozlog == 3.2 23:49:20 INFO - moznetwork == 0.27 23:49:20 INFO - mozprocess == 0.22 23:49:20 INFO - mozprofile == 0.28 23:49:20 INFO - mozrunner == 6.11 23:49:20 INFO - mozscreenshot == 0.1 23:49:20 INFO - mozsystemmonitor == 0.3 23:49:20 INFO - moztest == 0.7 23:49:20 INFO - mozversion == 1.4 23:49:20 INFO - psutil == 3.1.1 23:49:20 INFO - requests == 1.2.3 23:49:20 INFO - wsgiref == 0.1.2 23:49:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 23:49:20 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')]} 23:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:20 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')]} 23:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:20 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 0x22d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25983b0>, '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 0x25992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2599740>, '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': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', '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 23:49:20 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 23:49:20 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 23:49:20 INFO - Using env: {'DISPLAY': ':0', 23:49:20 INFO - 'HOME': '/home/cltbld', 23:49:20 INFO - 'LANG': 'en_US.UTF-8', 23:49:20 INFO - 'LANGUAGE': 'en_US:en', 23:49:20 INFO - 'LOGNAME': 'cltbld', 23:49:20 INFO - 'MAIL': '/var/mail/cltbld', 23:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:20 INFO - 'MOZ_NO_REMOTE': '1', 23:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:49:20 INFO - 'NO_EM_RESTART': '1', 23:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:20 INFO - 'PWD': '/builds/slave/test', 23:49:20 INFO - 'SHELL': '/bin/bash', 23:49:20 INFO - 'SHLVL': '1', 23:49:20 INFO - 'TERM': 'linux', 23:49:20 INFO - 'TMOUT': '86400', 23:49:20 INFO - 'USER': 'cltbld', 23:49:20 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', 23:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:20 INFO - '_': '/tools/buildbot/bin/python'} 23:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:49:20 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)) 23:49:20 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)) 23:49:20 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)) 23:49:20 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)) 23:49:20 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)) 23:49:20 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)) 23:49:20 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)) 23:49:20 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)) 23:49:20 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)) 23:49:20 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)) 23:49:20 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)) 23:49:20 INFO - Cleaning up... 23:49:20 INFO - Return code: 0 23:49:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 23:49:20 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')]} 23:49:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 23:49:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:20 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')]} 23:49:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 23:49:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 23:49:20 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 0x22d9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x243c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x259a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x25983b0>, '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 0x25992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2599740>, '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': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', '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 23:49:20 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 23:49:20 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 23:49:20 INFO - Using env: {'DISPLAY': ':0', 23:49:20 INFO - 'HOME': '/home/cltbld', 23:49:20 INFO - 'LANG': 'en_US.UTF-8', 23:49:20 INFO - 'LANGUAGE': 'en_US:en', 23:49:20 INFO - 'LOGNAME': 'cltbld', 23:49:20 INFO - 'MAIL': '/var/mail/cltbld', 23:49:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:20 INFO - 'MOZ_NO_REMOTE': '1', 23:49:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:49:20 INFO - 'NO_EM_RESTART': '1', 23:49:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:49:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:20 INFO - 'PWD': '/builds/slave/test', 23:49:20 INFO - 'SHELL': '/bin/bash', 23:49:20 INFO - 'SHLVL': '1', 23:49:20 INFO - 'TERM': 'linux', 23:49:20 INFO - 'TMOUT': '86400', 23:49:20 INFO - 'USER': 'cltbld', 23:49:20 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', 23:49:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:20 INFO - '_': '/tools/buildbot/bin/python'} 23:49:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 23:49:21 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 23:49:21 INFO - Cleaning up... 23:49:21 INFO - Return code: 0 23:49:21 INFO - Running post-action listener: _resource_record_post_action 23:49:21 INFO - Running post-action listener: _start_resource_monitoring 23:49:21 INFO - Starting resource monitoring. 23:49:21 INFO - ##### 23:49:21 INFO - ##### Finished create-virtualenv step (success) 23:49:21 INFO - ##### 23:49:21 INFO - ##### 23:49:21 INFO - ##### Running install step. 23:49:21 INFO - ##### 23:49:21 INFO - Running pre-action listener: _resource_record_pre_action 23:49:21 INFO - Running main action method: install 23:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 23:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 23:49:21 INFO - Reading from file tmpfile_stdout 23:49:21 INFO - Detecting whether we're running mozinstall >=1.0... 23:49:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 23:49:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 23:49:21 INFO - Reading from file tmpfile_stdout 23:49:21 INFO - Output received: 23:49:21 INFO - Usage: mozinstall [options] installer 23:49:21 INFO - Options: 23:49:21 INFO - -h, --help show this help message and exit 23:49:21 INFO - -d DEST, --destination=DEST 23:49:21 INFO - Directory to install application into. [default: 23:49:21 INFO - "/builds/slave/test"] 23:49:21 INFO - --app=APP Application being installed. [default: firefox] 23:49:21 INFO - mkdir: /builds/slave/test/build/application 23:49:21 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'] 23:49:21 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 23:49:37 INFO - Reading from file tmpfile_stdout 23:49:37 INFO - Output received: 23:49:37 INFO - /builds/slave/test/build/application/firefox/firefox 23:49:37 INFO - Running post-action listener: _resource_record_post_action 23:49:37 INFO - ##### 23:49:37 INFO - ##### Finished install step (success) 23:49:37 INFO - ##### 23:49:37 INFO - ##### 23:49:37 INFO - ##### Running run-tests step. 23:49:37 INFO - ##### 23:49:37 INFO - Running pre-action listener: _resource_record_pre_action 23:49:37 INFO - Running main action method: run_tests 23:49:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 23:49:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 23:49:37 INFO - Python 2.7.3 23:49:37 INFO - Return code: 0 23:49:37 INFO - grabbing minidump binary from tooltool 23:49: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')]} 23:49:37 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 0x25983b0>, '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 0x25992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2599740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 23:49:37 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 23:49:37 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 23:49:37 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 23:49:37 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 23:49:37 INFO - Return code: 0 23:49:37 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 23:49:37 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 23:49:37 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 23:49:37 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 23:49:37 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 23:49:37 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/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 23:49:37 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/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-007 --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 23:49:37 INFO - Using env: {'DISPLAY': ':0', 23:49:37 INFO - 'HOME': '/home/cltbld', 23:49:37 INFO - 'LANG': 'en_US.UTF-8', 23:49:37 INFO - 'LANGUAGE': 'en_US:en', 23:49:37 INFO - 'LOGNAME': 'cltbld', 23:49:37 INFO - 'MAIL': '/var/mail/cltbld', 23:49:37 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 23:49:37 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 23:49:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 23:49:37 INFO - 'MOZ_NO_REMOTE': '1', 23:49:37 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 23:49:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 23:49:37 INFO - 'NO_EM_RESTART': '1', 23:49:37 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 23:49:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 23:49:37 INFO - 'PWD': '/builds/slave/test', 23:49:37 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 23:49:37 INFO - 'SHELL': '/bin/bash', 23:49:37 INFO - 'SHLVL': '1', 23:49:37 INFO - 'TERM': 'linux', 23:49:37 INFO - 'TMOUT': '86400', 23:49:37 INFO - 'USER': 'cltbld', 23:49:37 INFO - 'XDG_SESSION_COOKIE': '923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343', 23:49:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 23:49:37 INFO - '_': '/tools/buildbot/bin/python'} 23:49:37 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/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-007', '--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 23:49:38 INFO - mozversion application_buildid: 20160702144223 23:49:38 INFO - mozversion application_changeset: b8b3b1c92085c1f8b74c13203289360932182da4 23:49:38 INFO - mozversion application_display_name: Nightly 23:49:38 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 23:49:38 INFO - mozversion application_name: Firefox 23:49:38 INFO - mozversion application_remotingname: firefox 23:49:38 INFO - mozversion application_repository: https://hg.mozilla.org/integration/autoland 23:49:38 INFO - mozversion application_vendor: Mozilla 23:49:38 INFO - mozversion application_version: 50.0a1 23:49:38 INFO - mozversion platform_buildid: 20160702144223 23:49:38 INFO - mozversion platform_changeset: b8b3b1c92085c1f8b74c13203289360932182da4 23:49:38 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/autoland 23:49:38 INFO - mozversion platform_version: 50.0a1 23:49:38 INFO - using testdate: 1467528578 23:49:38 INFO - actual date: 1467528578 23:49:38 INFO - starting webserver on 'localhost:48983' 23:49:38 INFO - SUITE-START | Running 2 tests 23:49:38 INFO - TEST-START | dromaeo_css 23:49:38 INFO - operating with platform_type : linux_ 23:49:38 INFO - Initialising browser for dromaeo_css test... 23:49:38 INFO - TEST-INFO | started process 27077 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi2yEtK/profile http://localhost:48983/getInfo.html) 23:49:42 INFO - PROCESS | 27077 | __metrics Screen width/height:1600/1200 23:49:42 INFO - PROCESS | 27077 | colorDepth:24 23:49:42 INFO - PROCESS | 27077 | Browser inner width/height: 1024/697 23:49:42 INFO - PROCESS | 27077 | __metrics 23:49:43 INFO - PROCESS | 27077 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 23:49:44 INFO - TEST-INFO | 27077: exit 0 23:49:44 INFO - Browser initialized. 23:49:44 INFO - Running cycle 1/1 for dromaeo_css test... 23:49:44 INFO - TEST-INFO | started process 27158 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpi2yEtK/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 23:49:55 INFO - PROCESS | 27158 | RSS: Main: 159072256 23:49:55 INFO - PROCESS | 27158 | 23:50:47 INFO - PROCESS | 27158 | 1467528647007 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] 23:52:59 INFO - PROCESS | 27158 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-dojo.html (next: http://localhost:48983/tests/dromaeo/cssquery-ext.html) 23:53:00 INFO - PROCESS | 27158 | RSS: Main: 268201984 23:53:00 INFO - PROCESS | 27158 | 23:56:03 INFO - PROCESS | 27158 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-ext.html (next: http://localhost:48983/tests/dromaeo/cssquery-jquery.html) 23:56:04 INFO - PROCESS | 27158 | RSS: Main: 243097600 23:56:04 INFO - PROCESS | 27158 | 23:59:06 INFO - PROCESS | 27158 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-jquery.html (next: http://localhost:48983/tests/dromaeo/cssquery-mootools.html) 23:59:06 INFO - PROCESS | 27158 | RSS: Main: 247578624 23:59:06 INFO - PROCESS | 27158 | 00:02:08 INFO - PROCESS | 27158 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-mootools.html (next: http://localhost:48983/tests/dromaeo/cssquery-prototype.html) 00:02:09 INFO - PROCESS | 27158 | RSS: Main: 237592576 00:02:09 INFO - PROCESS | 27158 | 00:05:12 INFO - PROCESS | 27158 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-prototype.html (next: http://localhost:48983/tests/dromaeo/cssquery-yui.html) 00:05:13 INFO - PROCESS | 27158 | RSS: Main: 220971008 00:05:13 INFO - PROCESS | 27158 | 00:08:15 INFO - PROCESS | 27158 | Cycle 1(1): loaded http://localhost:48983/tests/dromaeo/cssquery-yui.html (next: http://localhost:48983/tests/dromaeo/cssquery-dojo.html) 00:08:16 INFO - PROCESS | 27158 | RSS: Main: 297115648 00:08:16 INFO - PROCESS | 27158 | 00:08:16 INFO - PROCESS | 27158 | __start_tp_report 00:08:16 INFO - PROCESS | 27158 | _x_x_mozilla_page_load 00:08:16 INFO - PROCESS | 27158 | _x_x_mozilla_page_load_details 00:08:16 INFO - PROCESS | 27158 | |i|pagename|runs| 00:08:16 INFO - PROCESS | 27158 | |0;dojo.html;2619.6332513448115;2626.2383908666466;2652.257367936977;2665.320343312454;2668.186203208022;4566.474855391622;4631.7915693793775;4713.363695901056;4771.546703063208;4808.927866082007;4635.374224479694;4689.554492323233;4694.694844835083;4702.0360826030665;4716.481187069428;4299.26912424887;4331.501877284121;4363.650907927358;4400.295952647577;4462.79917403716;4427.667924905629;4437.64498840092;4456.955430445686;4485.0805584855025;4520.141173177086;4228.746275223466;4276.572342765729;4299.269124248885;4345.521992580813;4377.4528183977;4289.056407590325;4292.055747735493;4298.849540266076;4386.8903277418;4428.269335559628;4367.825286988516;4372.934405983913;4384.320430333271;4427.977860110711;4443.066955939256;4504.8873778155485;4676.976615116937;4679.415073115861;4739.905201895977;4813.711177329372;5130.461301563357;5136.280920671109;5139.691618502864;5143.022825663112;5158.380994280673;5112.488751124858;5118.283440318359;5125.3080834087295;5153.3558305211845;5156.407013193456;4605.470370907322;4713.505081966413;4719.669623126417;4723.315119307681;4819.927701084486;5200.271961925334;5221.190715439113;5225.6603320784025;5278.8944221116135;5283.815066472655;5021.196608542616;5023.1711767557945;5059.671121377099;5072;5072.82245121419;4892.363992680928;5008.974955125201;5050.217216331474;5061.898762024739;5076.695398276115;5007.499250074963;5035.571976381975;5049.6212784041345;5052.949470505321;5105.978804239167;4812.711237325771;4986.227134794112;5010.749462526932;5014.448410674823;5016.322796422509;4166.708330416903;4173.290540608104;4183.937240941388;4223.704340696183;4256.510501292391;3749.456328832304;3756.079760458705;3789.2232092420986;3792.886213413602;3830.8084595770656;4427.734335939854;4438.955610443919;4440.33394990754;4479.955200448019;4486.237339652267;4934.284528743312;4974.602031837444;5041.664168814817;5047.596192304607;5108.106081435808;4361.890952726144;4406.757628330409;4409.206342858316;4438.556144385536;4450.354698568754;4519.615832654261;4523.095380923828;4530.935230220895;4531.954680453219;4570.451545814523;4552.430946131733;4746.908211111395;4766.308885211694;4805.183118869731;4816.229403295456;5114.769835357492;5124.128898087409;5129.025485157808;5134.948650513447;5184.040952423814;4814.5907597854575;4823.469418364048;4826.710397376169;4830.758462076952;4869.975650121868;4792.137415265146;4859.222524396079;4894.755262236803;4912.189488734319;4956.430010548833;4993.975030124826;5020.974895125501;5025.824096156617;5027.472115427828;5074.391073071108;4816.807327706852;4885.291632713308;4899.461059283547;4905.48492408292;4948.579370753526;4825.927611085766;4859;4866.829660961849;4886.267059941038;4899.730514821576;4809.831655892027;4825.4933232011535;4860.538248866352;4872.707637541759;4878.609711223023;4825.324454576432;4894.681845680019;4900.901981960412;4923.679960802537;4923.852284431473;4675.368825208553;4738.099761045391;4756.405449318835;4818.71087734737;4826.155422801066 00:08:16 INFO - PROCESS | 27158 | |1;ext.html;573.787698551536;575.1372940589116;577.7544543568985;578.7989920914105;579.1139556478583;39866.80066599666;41611.37582936254;41670.58329416709;46158;46176.53823461764;41984.58015419845;42462;42510.7874460628;42519.787401063026;42522.78738606303;7879.6060196990065;8017.3986950978615;8018.639161237729;8020.518768873857;8021.5187088774865;7787;7863.488873223251;7863.685452581918;7867.291943725064;7868.370530357558;7856.2143785621265;7887.132415434297;7894.381651761404;7894.921050789505;7897.328727058179;7824.413169012319;7842.41181911356;7853.410994175402;7855.8821617675785;7859.8035049123655;7891.723789667334;7944.6027698614835;7950.681972721084;7953.164917683618;7955.24425179607;38350.61649383498;38626.613733862585;38734.225315493815;38779.41830872539;38809.22381552353;3143.4970404735363;3152.8265945372996;3561.269939662363;3789.5263092113487;3810.4474851146706;29958.400831983457;30108.69891301081;30323.848380758176;30681;31002.534961975587;3480.547528821237;3555.2711694102645;3561.9643803561894;3570.6786389225094;3582.6775590197008;257190;259951;260685;261025;262000;52307.215391769154;52415;52650;52711.73644131832;52808.47191528112;33286.66713332836;34450.310993780484;54882;54918.17622735662;55037.174442383395;14817.481388151364;14975.775363369557;14984.850151498564;14993.475228367173;15007;11199.776004479865;11232.719182020515;11332.886671133183;11361.943190283995;11378.943105284587;18218.635627287644;18267.177976991068;18269.81730182708;18277.268909243747;18365.7245141323;6747.797566073025;6856.6228857412325;6882.174139103239;7149.82125446868;7186.6704659638135;854.3250831842898;959.596969272907;976.799756050008;1011.1354791653177;1023.2734758321526;28585.57121643177;28843.134705958855;29120.525399114722;29280.560791588145;29508.262293442836;978.9853152202722;984.7981163861391;990.3067852503276;1053.9262251642313;1084.5282302198568;14937.850621493646;15397.335325613249;15398.46105386306;15668.68662626764;15705.293261803246;411749;416261;416751;417296;417556;50283.245751313756;50989.66587840075;51002;51019;51091.744541277054;1071.8177909755361;1134.6539305511733;1151.9424028798694;1186.6677330347516;1203.843500344967;27290;29215;29783.55324670175;29990.550141747455;30017.549736753528;42704.57295427006;43183.35224971691;43248.56751432445;43294.134117318106;43307.13385732205;306012;307057;307710;308313;308417;22210.88894555517;24621.261362159163;25555.616665749658;25570.616440753776;25637.23088307354;41482.37776433295;41640;42796;43102.78448607737;43339.13321733485;35933.64066359407;36960.26079478342;37398.8130059348;37503.43744843884;37562.06094847651;36315.03494414939;36633.45049824308;36844.44733329056;36944.63055369412;37141.62858371382;35721.82139089392;36094;36118.45822312615;36387;36756.264874702894;31735.84132079325;32971.726829074214;33074.33851323008;33430.331393372486;33553.32893342168;24721.87639061793;25415.36461588475;25751;26076.8696156518;27667.44665106727 00:08:16 INFO - PROCESS | 27158 | |2;jquery.html;357.56020095282787;375.33378253599847;376.05985037406487;383.45932235547866;389.3653345047572;13118.624307781985;13225.669358266035;17910.731339029924;17942;17951.28194872207;15954.361825526994;17103.40138095167;17129.314827406888;17135.82864171358;17177;3778.9433158502643;5075.7715902784375;5283.445238249986;5286.31277933868;5287.788488460457;5777.59556831022;6113.083037544382;6113.296970848365;6237.126802247689;6239.844003899893;6010.669413182273;6090.695465226743;6148.169997050408;6164.59930104544;6187.690615469209;6218.253809542861;6220.813375598739;6224.284207316171;6227.221597300338;6261.561690681654;5268.973655131738;5344.706041167734;5347.893042139174;5351.839444816662;5352.652077614943;21501.56996860054;21502.677459838116;21559.1376344946;21697.67453488199;21720.13119475219;1972.9506762331057;2124.6812978053263;2255.1430456426615;2352.776486233805;2528.4563818778865;12876.613701588967;13608.319584020759;13749.381277842522;13876.444942202299;14147.080439771382;1735.2798588585722;1817.282173541457;1822.5352535103596;1832.93584724534;1886.8584856135708;50466.495335046544;75848.62075689586;76041.61979190123;76134.619326903;77384;9675.516224188763;9820.214382849355;9886.209103271722;10091.949540252252;10139.7465063374;13015.869841301466;13067.673308167181;13146.671333216555;13210.933945330213;13262.734745305233;7562.978997835332;7638.50349727266;7651.1583725790115;7713.267239612228;7848.843023139505;7194;7352.70589176427;7415.998840156618;7470.178280389153;7551.093868735787;6096.311731402527;6339.429451349401;6382.808515744535;6412.551121421456;6542.901856472156;1674.6148385871318;1702.3956495444186;1711.6063305439818;1730.1781653714386;1741.712617418112;832.5878690048464;848.7878030492377;862.8662557303628;910.5356268303213;925.7176561148914;17491.737623935653;17792.55518612045;18070.5482362942;18090.366837160636;18332.816671833378;851.8168593752373;874.5059041641452;879.4503435352905;900.9234215091659;925.3753716241511;8252.876206856901;10003.699889003341;10403.219758518142;10419.687409377731;10428.426436545911;422501;427305;429036;435043;435710;47368;77871.22128778753;77995.22004779993;78918;80543.59728201322;881.8412685716504;892.5448021508947;899.2760827533767;899.7525680437932;900.5632268349846;15871.285792139612;16075.35698572044;16096.11471369086;16157.192140392699;16194;38358.2328353437;38428.23143537057;38819;38878;39834;48886.75556622194;49621;50510;50808.491915080376;51035.23447148222;6693.866122677617;7781.649825757741;7874.960625196837;7913.643886025257;7949.523028618301;12151.513939442324;12388.690282743004;12397.256164630151;12543.87456125427;12784.296863672214;11050.668479945292;11181.32912025281;11356.375399353115;11430.371329576954;11454.599089031844;10590.4704764763;10975.670729878117;11002.944985275022;11004.22970392097;11153.944230278797;10220.335678180894;10833.891661083288;10883.564657413615;11208.55165793359;11375.54497820078;7953.483023603448;7973.040439340988;8163.551004694561;8275.089740128702;8279.047909490486;9585;10845.674629761119;10896.400697961371;11047.889521105008;11199.21605487608 00:08:16 INFO - PROCESS | 27158 | |3;mootools.html;1268.7969924812032;1382.5092092307232;1397.916125032498;1494.7458931981562;1720.3720641965679;7109.928900710991;7888.881666774996;8175;8187.18128187181;8414.158584141584;8115;8251.298639615625;8270.214329638675;8272.214139656722;8280.378971577125;2272.920447784332;2303.2053941390195;2305.4697419593504;2307.157887371114;2307.492351682627;2242.7420846602686;2278.8176945844375;2282.7945484906354;2283.0525331987205;2283.6574513822893;2251.6509940959177;2272.7045484087043;2281.589313923493;2287.0508738873345;2292.4039749665126;2167.2631305356254;2183.279517759144;2185.115028413495;2187.453136715821;2191.1783081344497;2165.1231251343074;2167.414798004546;2169.121505790142;2170.4248374180856;2171.9782802171935;8155.062167850714;8167.918320816834;8217.219364160395;8232.670693172266;8436.02985656645;4704.670673052888;4815.975920120412;4816.277558366238;4817.3737414136285;4833.589144922686;2834.2064222017866;2952.7342539171364;3000.144958686764;3007.6541197762317;3010.834404107773;960.5293406230967;964.9083337082966;973.8733964584629;978.1294647763497;980.7695191630032;11368.317900925887;11479;11485.425728713531;11489.368084755335;11492;4250.277452833026;4255.87232383029;4280.892977675583;4302.612764851178;4304.225239456865;8930.732078037669;8983.46099234048;8985.775355616031;8992.505412202392;8997.100289971082;4656.67403281767;4662.883427914329;4666.603338716247;4666.673332866667;4668.066386722669;3774.6225377462033;3796.886093417202;3914.6085391460624;4214.726042807208;4317.460317460317;3516.894493165209;3535.416656251741;3612.1330880588994;3632.0556655269293;3647.179384638488;1078.132103656564;1081.1891081688734;1093.1746531368765;1097.5609756097465;1099.543689368903;755.7657126290867;794.1859593916282;818.8485130250804;819.5041999590162;847.1740053447962;5160.509751573594;5221.608379371486;5404.432534583891;5433.972830135824;5545.889082218333;857.3998201259144;861.814709837388;878.9208971192623;886.9047323128539;896.188949001155;3598.676119149289;3749.681277091423;3801.5438147421933;3802.980985095057;3876.5541962674088;9438.433693978246;9810.901890981142;9831.213502919749;10247.487625618838;10586.894131058745;9630.711078667651;9999.50002499872;10075;10085.193184545218;10140.898591013995;7298.854022919512;7629.198934111839;7669.309762121436;7674.232576742281;7858.017747781641;5629.408912064175;5710.600257981901;5850.356460789225;5951.315598706205;6007.789727359696;9528.666496672584;9572.712818615453;9607.471589062668;9660.565274562521;9674.75813104678;9185.540722963959;9580;9808.215342772704;9828.901710982798;9830.508474576385;7724.9227507726455;7853.1361550228285;7885.093214280431;8002.599870006593;8005.519668819889;7956.2441568050945;7968.442209045311;7982.8802567960365;7984.241497058003;8014.599270036591;6783.05037294789;6953.930460695531;7048.964755176191;7063.611501367474;7181.317774811385;6941.583504989717;7033.191183013814;7062.046623705939;7073.752418665322;7108.182559005781;6522.28254891952;6636.601803891782;6639.402453779183;6646.667666616553;6700.195976482853;4668.393108895822;4726.196546587157;4746.145693775154;4751.6436267279405;4798.2082956311815;4894.290327902506;4932.654714169974;4992.301077849177;5020.698758074527;5099.26060721186 00:08:16 INFO - PROCESS | 27158 | |4;prototype.html;296.4249356248877;299.33248855053233;306.4805155261831;309.27320796129084;311.81291225264846;4801.159797035518;4829.613630909527;4834.709917404954;4846.684965477241;4850.320955066285;4481.977590112045;4599.908001839961;4600.17196904557;4611.584957353837;4751.572358487735;3635.291118231946;3688.3360995020953;3727.6831469325;3739.7845700147427;3780.451834483998;3709.4806727058235;3741.4948981887505;3741.7380783345175;3759.248150369937;3762.341590221714;3606.6393360663988;3689.1001134415797;3716.7769933803925;3739.196072844338;3764.247150569883;3758.267137908109;3771.4531392948006;3779.6598306152305;3782.5082739244;3790.2419516096893;3307.3054658521737;3324.734021278316;3334.7832390894514;3337.147882924976;3345.1135449106005;4665.4168228971375;4675.88310292242;4678;4681.7190968542;4688.789004494772;4178.979105104486;4196.391523229146;4279.20273485137;4285.550017248175;4297.527272000078;4945.615227736203;4980.82567110153;4994.750262486861;5006.299118123466;5010.3737032870895;3597.3704601694863;3598.1904071583945;3606;3611.223586928823;3617;4945.678530895516;5179.456157103526;5191.999999999962;5206.479352064764;5210.426853046162;3649.069487280726;3651.1602331463914;3674.706023518112;3682.3371793076967;3685.1892583631557;3742.5321834770652;3743.9251214975548;3745.8688945887307;3747.775133491999;3750.1937083527173;4238.321868501025;4245.044864905433;4248.4052232687445;4248.830046798155;4257.510386305615;4869.269609558523;4926.3842019747535;4942.9011419771405;4946.9010619787405;5022.573081288131;1280.5070048031575;1281.8974482041601;1296.682312833362;1302.602706174607;1303.48512337628;838.2288294768828;884.5842454046588;911.8586619074055;919.9816003679889;925.7130289610243;4425.955740442619;4434.645228381722;4437.156940181355;4443.178012067778;4444.11117776446;5081.745912704424;5102.9489705103215;5106.540411362921;5126.282320475137;5128.974355128201;4210.305299625588;4403.097365040223;4414.977925110354;4444.2222611042935;4454;2663.4673065386614;2687.368468409922;2691.9461610767676;2696.9056083037;2696.9595456068173;4804.399450068741;4813.7352445615825;4816.590589799836;4823.300621409946;4824.951750482521;5047.217681259411;5190.844274671766;5208.166693329049;5308.469153084738;5308.575313974873;4898.432501599454;4918.926216106833;4919.286703428054;4927.852164435073;4931.284963680247;5169.276301317894;5202.97398513005;5205.245239440184;5242.475752424727;5242.5281724644965;4885;5086.474057782576;5097.400325833925;5104.387473503203;5163.715995620277;4881.463039065629;4907.877303067452;4910.091633047898;4916.532929371704;4917.803287868445;3634.9636503634624;3646.872359467406;3651.3062518121474;3655.214128962286;3655.4334078217917;5098.745062746922;5163.638545301793;5167.534921856901;5209.973950130225;5227.137522308776;4987.6508644396;4989.975050124726;4999.825006124768;5013.147764880052;5024.974875125601;5033.295338652519;5071.366079240095;5072.365954255718;5085.855682471414;5105.617078719037;4727.747147005977;4774.3554620127225;4965.304857319906;4993.176125939324;5038.168702164102;4868.245421959602;4921.089598424303;4945.901081978413;4949.33184020167;4958.355413796184;4892.0705066037335;4923.163062279349;4923.359963204904;4930.334404855299;4939.728314942569 00:08:16 INFO - PROCESS | 27158 | |5;yui.html;670.865826834633;690.6305126757186;734.713461749918;750.028712816902;764.9579273139975;13731.93134034331;13806.58580242593;14239.78640320396;14555.417783288669;14557.92721036396;13531;13561.864381356183;13684.794728079087;13708.383122759475;13710.45158193671;635.5582869905418;751.6955632968629;769.7960040589248;787.8030492376906;797.7646594254679;790.6916302641974;791.2008871040262;793.5714714054403;794.3010151067082;795.2842441802367;833.7457075591942;839.0225387423675;841.0034109580137;842.7176895739934;842.8356470488258;651.2608189704696;673.1047706550277;678.067656971664;685.5612408058846;830.9542975136366;583.3787016827066;606.2452246952572;608.9969550152265;610.2280615022;610.4322979628944;13680.65798355039;13693.589192324247;13708.17750934937;13710.794338084937;13731.45074197031;12280.631581052583;12332.81500777489;12484.687882803002;12556;12992.935035324857;12153.513859445611;12419.93790031044;12441.75116497674;12561.874381256162;12672.80990785139;3343.2477692519233;3466.3933811582874;3512.0693016350688;3572.964270357289;4385.736855788663;63923;64064;64462;64741.676291618714;64956;10687.465626718633;10857.51141198648;10859.07697845692;11020.44897755109;11052.944735276273;19030.714539281922;19088.80911190898;19129.52176195606;19135.13891874869;19244;6820.31796820324;6986.54587451814;7075.716971321192;7162.319579639926;7163.42692584592;3503.5445392098864;4000.5199376075057;4008.617027125637;4029.738067025634;4068.0846809467635;2937.9559306610417;3016.1403999859936;3025;3027.4399236141385;3035.514317709156;491.63127654259307;495.3288294361161;509.5465036117858;511.88994366211443;512.5233532814444;431.7107537949581;440.27354864473875;508.36200568286563;526.9394019687785;531.7713383245242;8251.133630968781;8348.833023339499;8542.40203185771;8677.479351238819;8898.154675305836;574.7844558290641;583.1660725162973;585.6339787632729;586.9178315035813;594.6402426531886;3677.7548428072128;4066.207089617496;4134.834606615702;4307.784610769449;4523.36672865799;92471;100773;104339;107288.46355768171;107681;53844.461555384725;54979.45020549744;63682;68884.3111568878;69078;48999;60877.39122608717;69514;71459;73819.63090184514;8134.959325203336;8180.30467410253;8359.707410240613;8378.622961966605;8454.323654107533;43630;45152;45874.54125458836;46117;46207.53792462167;63471;66561;66860.3313966854;67271;67415;11411.714707132389;11619.734018032885;11624.128190385585;11723.824142638037;11738.94130529342;12741.55404560836;12950.585518556207;12951.287679177736;13028.934855325662;14001.089929154572;12568.685782855502;12662.176958497668;12835.294058826481;12844.550440734529;13294.135881167693;12078.154529182873;12706.87293127057;12868.678283042998;12941.805872912102;13047.804282935953;10785.40680262593;11285.266457680225;11294.60468883585;11335;11354.772904542027;10313.690589282334;10325.173986081245;10508.474576271308;10585.470726463493;10814.783704325711;9499.667511637059;9709.465979371202;9728.75678108053;9843.360181588174;9850.655227067018 00:08:16 INFO - PROCESS | 27158 | __end_tp_report 00:08:16 INFO - PROCESS | 27158 | __start_cc_report 00:08:16 INFO - PROCESS | 27158 | _x_x_mozilla_cycle_collect,1107 00:08:16 INFO - PROCESS | 27158 | __end_cc_report 00:08:16 INFO - PROCESS | 27158 | __startTimestamp1467529696185__endTimestamp 00:08:16 INFO - PROCESS | 27158 | 00:08:16 INFO - PROCESS | 27158 | ------- Summary: start ------- 00:08:16 INFO - PROCESS | 27158 | Number of tests: 6 00:08:16 INFO - PROCESS | 27158 | 00:08:16 INFO - PROCESS | 27158 | [#0] dojo.html Cycles:165 Average:4672.99 Median:4812.71 stddev:486.02 (10.1%) stddev-sans-first:460.04 00:08:16 INFO - PROCESS | 27158 | Values: 2619.6 2626.2 2652.3 2665.3 2668.2 4566.5 4631.8 4713.4 4771.5 4808.9 4635.4 4689.6 4694.7 4702.0 4716.5 4299.3 4331.5 4363.7 4400.3 4462.8 4427.7 4437.6 4457.0 4485.1 4520.1 4228.7 4276.6 4299.3 4345.5 4377.5 4289.1 4292.1 4298.8 4386.9 4428.3 4367.8 4372.9 4384.3 4428.0 4443.1 4504.9 4677.0 4679.4 4739.9 4813.7 5130.5 5136.3 5139.7 5143.0 5158.4 5112.5 5118.3 5125.3 5153.4 5156.4 4605.5 4713.5 4719.7 4723.3 4819.9 5200.3 5221.2 5225.7 5278.9 5283.8 5021.2 5023.2 5059.7 5072.0 5072.8 4892.4 5009.0 5050.2 5061.9 5076.7 5007.5 5035.6 5049.6 5052.9 5106.0 4812.7 4986.2 5010.7 5014.4 5016.3 4166.7 4173.3 4183.9 4223.7 4256.5 3749.5 3756.1 3789.2 3792.9 3830.8 4427.7 4439.0 4440.3 4480.0 4486.2 4934.3 4974.6 5041.7 5047.6 5108.1 4361.9 4406.8 4409.2 4438.6 4450.4 4519.6 4523.1 4530.9 4532.0 4570.5 4552.4 4746.9 4766.3 4805.2 4816.2 5114.8 5124.1 5129.0 5134.9 5184.0 4814.6 4823.5 4826.7 4830.8 4870.0 4792.1 4859.2 4894.8 4912.2 4956.4 4994.0 5021.0 5025.8 5027.5 5074.4 4816.8 4885.3 4899.5 4905.5 4948.6 4825.9 4859.0 4866.8 4886.3 4899.7 4809.8 4825.5 4860.5 4872.7 4878.6 4825.3 4894.7 4900.9 4923.7 4923.9 4675.4 4738.1 4756.4 4818.7 4826.2 00:08:16 INFO - PROCESS | 27158 | 00:08:16 INFO - PROCESS | 27158 | [#1] ext.html Cycles:180 Average:48414.82 Median:37270.22 stddev:88067.26 (236.3%) stddev-sans-first:88241.06 00:08:16 INFO - PROCESS | 27158 | Values: 573.8 575.1 577.8 578.8 579.1 39866.8 41611.4 41670.6 46158.0 46176.5 41984.6 42462.0 42510.8 42519.8 42522.8 7879.6 8017.4 8018.6 8020.5 8021.5 7787.0 7863.5 7863.7 7867.3 7868.4 7856.2 7887.1 7894.4 7894.9 7897.3 7824.4 7842.4 7853.4 7855.9 7859.8 7891.7 7944.6 7950.7 7953.2 7955.2 38350.6 38626.6 38734.2 38779.4 38809.2 3143.5 3152.8 3561.3 3789.5 3810.4 29958.4 30108.7 30323.8 30681.0 31002.5 3480.5 3555.3 3562.0 3570.7 3582.7 257190.0 259951.0 260685.0 261025.0 262000.0 52307.2 52415.0 52650.0 52711.7 52808.5 33286.7 34450.3 54882.0 54918.2 55037.2 14817.5 14975.8 14984.9 14993.5 15007.0 11199.8 11232.7 11332.9 11361.9 11378.9 18218.6 18267.2 18269.8 18277.3 18365.7 6747.8 6856.6 6882.2 7149.8 7186.7 854.3 959.6 976.8 1011.1 1023.3 28585.6 28843.1 29120.5 29280.6 29508.3 979.0 984.8 990.3 1053.9 1084.5 14937.9 15397.3 15398.5 15668.7 15705.3 411749.0 416261.0 416751.0 417296.0 417556.0 50283.2 50989.7 51002.0 51019.0 51091.7 1071.8 1134.7 1151.9 1186.7 1203.8 27290.0 29215.0 29783.6 29990.6 30017.5 42704.6 43183.4 43248.6 43294.1 43307.1 306012.0 307057.0 307710.0 308313.0 308417.0 22210.9 24621.3 25555.6 25570.6 25637.2 41482.4 41640.0 42796.0 43102.8 43339.1 35933.6 36960.3 37398.8 37503.4 37562.1 36315.0 36633.5 36844.4 36944.6 37141.6 35721.8 36094.0 36118.5 36387.0 36756.3 31735.8 32971.7 33074.3 33430.3 33553.3 24721.9 25415.4 25751.0 26076.9 27667.4 00:08:16 INFO - PROCESS | 27158 | 00:08:16 INFO - PROCESS | 27158 | [#2] jquery.html Cycles:180 Average:25802.74 Median:231167.50 stddev:70662.90 (30.6%) stddev-sans-first:70835.30 00:08:16 INFO - PROCESS | 27158 | Values: 357.6 375.3 376.1 383.5 389.4 13118.6 13225.7 17910.7 17942.0 17951.3 15954.4 17103.4 17129.3 17135.8 17177.0 3778.9 5075.8 5283.4 5286.3 5287.8 5777.6 6113.1 6113.3 6237.1 6239.8 6010.7 6090.7 6148.2 6164.6 6187.7 6218.3 6220.8 6224.3 6227.2 6261.6 5269.0 5344.7 5347.9 5351.8 5352.7 21501.6 21502.7 21559.1 21697.7 21720.1 1973.0 2124.7 2255.1 2352.8 2528.5 12876.6 13608.3 13749.4 13876.4 14147.1 1735.3 1817.3 1822.5 1832.9 1886.9 50466.5 75848.6 76041.6 76134.6 77384.0 9675.5 9820.2 9886.2 10091.9 10139.7 13015.9 13067.7 13146.7 13210.9 13262.7 7563.0 7638.5 7651.2 7713.3 7848.8 7194.0 7352.7 7416.0 7470.2 7551.1 6096.3 6339.4 6382.8 6412.6 6542.9 1674.6 1702.4 1711.6 1730.2 1741.7 832.6 848.8 862.9 910.5 925.7 17491.7 17792.6 18070.5 18090.4 18332.8 851.8 874.5 879.5 900.9 925.4 8252.9 10003.7 10403.2 10419.7 10428.4 422501.0 427305.0 429036.0 435043.0 435710.0 47368.0 77871.2 77995.2 78918.0 80543.6 881.8 892.5 899.3 899.8 900.6 15871.3 16075.4 16096.1 16157.2 16194.0 38358.2 38428.2 38819.0 38878.0 39834.0 48886.8 49621.0 50510.0 50808.5 51035.2 6693.9 7781.6 7875.0 7913.6 7949.5 12151.5 12388.7 12397.3 12543.9 12784.3 11050.7 11181.3 11356.4 11430.4 11454.6 10590.5 10975.7 11002.9 11004.2 11153.9 10220.3 10833.9 10883.6 11208.6 11375.5 7953.5 7973.0 8163.6 8275.1 8279.0 9585.0 10845.7 10896.4 11047.9 11199.2 00:08:16 INFO - PROCESS | 27158 | 00:08:16 INFO - PROCESS | 27158 | [#3] mootools.html Cycles:180 Average:5379.15 Median:5191.06 stddev:3069.79 (59.1%) stddev-sans-first:3062.86 00:08:16 INFO - PROCESS | 27158 | Values: 1268.8 1382.5 1397.9 1494.7 1720.4 7109.9 7888.9 8175.0 8187.2 8414.2 8115.0 8251.3 8270.2 8272.2 8280.4 2272.9 2303.2 2305.5 2307.2 2307.5 2242.7 2278.8 2282.8 2283.1 2283.7 2251.7 2272.7 2281.6 2287.1 2292.4 2167.3 2183.3 2185.1 2187.5 2191.2 2165.1 2167.4 2169.1 2170.4 2172.0 8155.1 8167.9 8217.2 8232.7 8436.0 4704.7 4816.0 4816.3 4817.4 4833.6 2834.2 2952.7 3000.1 3007.7 3010.8 960.5 964.9 973.9 978.1 980.8 11368.3 11479.0 11485.4 11489.4 11492.0 4250.3 4255.9 4280.9 4302.6 4304.2 8930.7 8983.5 8985.8 8992.5 8997.1 4656.7 4662.9 4666.6 4666.7 4668.1 3774.6 3796.9 3914.6 4214.7 4317.5 3516.9 3535.4 3612.1 3632.1 3647.2 1078.1 1081.2 1093.2 1097.6 1099.5 755.8 794.2 818.8 819.5 847.2 5160.5 5221.6 5404.4 5434.0 5545.9 857.4 861.8 878.9 886.9 896.2 3598.7 3749.7 3801.5 3803.0 3876.6 9438.4 9810.9 9831.2 10247.5 10586.9 9630.7 9999.5 10075.0 10085.2 10140.9 7298.9 7629.2 7669.3 7674.2 7858.0 5629.4 5710.6 5850.4 5951.3 6007.8 9528.7 9572.7 9607.5 9660.6 9674.8 9185.5 9580.0 9808.2 9828.9 9830.5 7724.9 7853.1 7885.1 8002.6 8005.5 7956.2 7968.4 7982.9 7984.2 8014.6 6783.1 6953.9 7049.0 7063.6 7181.3 6941.6 7033.2 7062.0 7073.8 7108.2 6522.3 6636.6 6639.4 6646.7 6700.2 4668.4 4726.2 4746.1 4751.6 4798.2 4894.3 4932.7 4992.3 5020.7 5099.3 00:08:16 INFO - PROCESS | 27158 | 00:08:16 INFO - PROCESS | 27158 | [#4] prototype.html Cycles:180 Average:4163.18 Median:4762.96 stddev:1199.54 (25.2%) stddev-sans-first:1167.27 00:08:16 INFO - PROCESS | 27158 | Values: 296.4 299.3 306.5 309.3 311.8 4801.2 4829.6 4834.7 4846.7 4850.3 4482.0 4599.9 4600.2 4611.6 4751.6 3635.3 3688.3 3727.7 3739.8 3780.5 3709.5 3741.5 3741.7 3759.2 3762.3 3606.6 3689.1 3716.8 3739.2 3764.2 3758.3 3771.5 3779.7 3782.5 3790.2 3307.3 3324.7 3334.8 3337.1 3345.1 4665.4 4675.9 4678.0 4681.7 4688.8 4179.0 4196.4 4279.2 4285.6 4297.5 4945.6 4980.8 4994.8 5006.3 5010.4 3597.4 3598.2 3606.0 3611.2 3617.0 4945.7 5179.5 5192.0 5206.5 5210.4 3649.1 3651.2 3674.7 3682.3 3685.2 3742.5 3743.9 3745.9 3747.8 3750.2 4238.3 4245.0 4248.4 4248.8 4257.5 4869.3 4926.4 4942.9 4946.9 5022.6 1280.5 1281.9 1296.7 1302.6 1303.5 838.2 884.6 911.9 920.0 925.7 4426.0 4434.6 4437.2 4443.2 4444.1 5081.7 5102.9 5106.5 5126.3 5129.0 4210.3 4403.1 4415.0 4444.2 4454.0 2663.5 2687.4 2691.9 2696.9 2697.0 4804.4 4813.7 4816.6 4823.3 4825.0 5047.2 5190.8 5208.2 5308.5 5308.6 4898.4 4918.9 4919.3 4927.9 4931.3 5169.3 5203.0 5205.2 5242.5 5242.5 4885.0 5086.5 5097.4 5104.4 5163.7 4881.5 4907.9 4910.1 4916.5 4917.8 3635.0 3646.9 3651.3 3655.2 3655.4 5098.7 5163.6 5167.5 5210.0 5227.1 4987.7 4990.0 4999.8 5013.1 5025.0 5033.3 5071.4 5072.4 5085.9 5105.6 4727.7 4774.4 4965.3 4993.2 5038.2 4868.2 4921.1 4945.9 4949.3 4958.4 4892.1 4923.2 4923.4 4930.3 4939.7 00:08:16 INFO - PROCESS | 27158 | 00:08:16 INFO - PROCESS | 27158 | [#5] yui.html Cycles:180 Average:17460.58 Median:22796.14 stddev:24198.54 (106.2%) stddev-sans-first:24233.58 00:08:16 INFO - PROCESS | 27158 | Values: 670.9 690.6 734.7 750.0 765.0 13731.9 13806.6 14239.8 14555.4 14557.9 13531.0 13561.9 13684.8 13708.4 13710.5 635.6 751.7 769.8 787.8 797.8 790.7 791.2 793.6 794.3 795.3 833.7 839.0 841.0 842.7 842.8 651.3 673.1 678.1 685.6 831.0 583.4 606.2 609.0 610.2 610.4 13680.7 13693.6 13708.2 13710.8 13731.5 12280.6 12332.8 12484.7 12556.0 12992.9 12153.5 12419.9 12441.8 12561.9 12672.8 3343.2 3466.4 3512.1 3573.0 4385.7 63923.0 64064.0 64462.0 64741.7 64956.0 10687.5 10857.5 10859.1 11020.4 11052.9 19030.7 19088.8 19129.5 19135.1 19244.0 6820.3 6986.5 7075.7 7162.3 7163.4 3503.5 4000.5 4008.6 4029.7 4068.1 2938.0 3016.1 3025.0 3027.4 3035.5 491.6 495.3 509.5 511.9 512.5 431.7 440.3 508.4 526.9 531.8 8251.1 8348.8 8542.4 8677.5 8898.2 574.8 583.2 585.6 586.9 594.6 3677.8 4066.2 4134.8 4307.8 4523.4 92471.0 100773.0 104339.0 107288.5 107681.0 53844.5 54979.5 63682.0 68884.3 69078.0 48999.0 60877.4 69514.0 71459.0 73819.6 8135.0 8180.3 8359.7 8378.6 8454.3 43630.0 45152.0 45874.5 46117.0 46207.5 63471.0 66561.0 66860.3 67271.0 67415.0 11411.7 11619.7 11624.1 11723.8 11738.9 12741.6 12950.6 12951.3 13028.9 14001.1 12568.7 12662.2 12835.3 12844.6 13294.1 12078.2 12706.9 12868.7 12941.8 13047.8 10785.4 11285.3 11294.6 11335.0 11354.8 10313.7 10325.2 10508.5 10585.5 10814.8 9499.7 9709.5 9728.8 9843.4 9850.7 00:08:16 INFO - PROCESS | 27158 | -------- Summary: end -------- 00:08:16 INFO - PROCESS | 27158 | 00:08:16 INFO - TEST-INFO | 27158: exit 0 00:08:16 INFO - TEST-OK | dromaeo_css | took 1118914ms 00:08:16 INFO - TEST-START | kraken 00:08:16 INFO - operating with platform_type : linux_ 00:08:16 INFO - Initialising browser for kraken test... 00:08:16 INFO - TEST-INFO | started process 27349 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph47WRr/profile http://localhost:48983/getInfo.html) 00:08:20 INFO - PROCESS | 27349 | __metrics Screen width/height:1600/1200 00:08:20 INFO - PROCESS | 27349 | colorDepth:24 00:08:20 INFO - PROCESS | 27349 | Browser inner width/height: 1024/697 00:08:20 INFO - PROCESS | 27349 | __metrics 00:08:21 INFO - PROCESS | 27349 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:08:22 INFO - TEST-INFO | 27349: exit 0 00:08:22 INFO - Browser initialized. 00:08:22 INFO - Running cycle 1/1 for kraken test... 00:08:22 INFO - TEST-INFO | started process 27431 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmph47WRr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 00:08:34 INFO - PROCESS | 27431 | RSS: Main: 159113216 00:08:34 INFO - PROCESS | 27431 | 00:08:37 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:48983/tests/kraken/driver.html?testName=audio-beat-detection) 00:08:38 INFO - PROCESS | 27431 | RSS: Main: 216891392 00:08:38 INFO - PROCESS | 27431 | 00:08:40 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:48983/tests/kraken/driver.html?testName=audio-dft) 00:08:41 INFO - PROCESS | 27431 | RSS: Main: 205275136 00:08:41 INFO - PROCESS | 27431 | 00:08:44 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:48983/tests/kraken/driver.html?testName=audio-fft) 00:08:45 INFO - PROCESS | 27431 | RSS: Main: 270798848 00:08:45 INFO - PROCESS | 27431 | 00:08:47 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:48983/tests/kraken/driver.html?testName=audio-oscillator) 00:08:48 INFO - PROCESS | 27431 | RSS: Main: 181686272 00:08:48 INFO - PROCESS | 27431 | 00:08:50 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:48983/tests/kraken/driver.html?testName=imaging-gaussian-blur) 00:08:51 INFO - PROCESS | 27431 | RSS: Main: 185626624 00:08:51 INFO - PROCESS | 27431 | 00:08:54 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:48983/tests/kraken/driver.html?testName=imaging-darkroom) 00:08:54 INFO - PROCESS | 27431 | RSS: Main: 222068736 00:08:54 INFO - PROCESS | 27431 | 00:08:58 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:48983/tests/kraken/driver.html?testName=imaging-desaturate) 00:08:58 INFO - PROCESS | 27431 | RSS: Main: 217960448 00:08:58 INFO - PROCESS | 27431 | 00:09:01 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:48983/tests/kraken/driver.html?testName=json-parse-financial) 00:09:02 INFO - PROCESS | 27431 | RSS: Main: 220381184 00:09:02 INFO - PROCESS | 27431 | 00:09:04 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:48983/tests/kraken/driver.html?testName=json-stringify-tinderbox) 00:09:04 INFO - PROCESS | 27431 | RSS: Main: 206626816 00:09:04 INFO - PROCESS | 27431 | 00:09:06 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-aes) 00:09:07 INFO - PROCESS | 27431 | RSS: Main: 211410944 00:09:07 INFO - PROCESS | 27431 | 00:09:09 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-ccm) 00:09:10 INFO - PROCESS | 27431 | RSS: Main: 209940480 00:09:10 INFO - PROCESS | 27431 | 00:09:12 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 00:09:13 INFO - PROCESS | 27431 | RSS: Main: 224620544 00:09:13 INFO - PROCESS | 27431 | 00:09:16 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 00:09:16 INFO - PROCESS | 27431 | RSS: Main: 225452032 00:09:16 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | Cycle 1(1): loaded http://localhost:48983/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:48983/tests/kraken/driver.html?testName=ai-astar) 00:09:18 INFO - PROCESS | 27431 | RSS: Main: 267522048 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | __start_tp_report 00:09:18 INFO - PROCESS | 27431 | _x_x_mozilla_page_load 00:09:18 INFO - PROCESS | 27431 | _x_x_mozilla_page_load_details 00:09:18 INFO - PROCESS | 27431 | |i|pagename|runs| 00:09:18 INFO - PROCESS | 27431 | |0;ai-astar;103;114;114;115;113;113;113;112;114;114 00:09:18 INFO - PROCESS | 27431 | |1;audio-beat-detection;160;121;123;181;124;130;145;122;152;123 00:09:18 INFO - PROCESS | 27431 | |2;audio-dft;162;162;160;162;161;161;162;161;160;160 00:09:18 INFO - PROCESS | 27431 | |3;audio-fft;76;77;76;115;75;76;75;76;98;75 00:09:18 INFO - PROCESS | 27431 | |4;audio-oscillator;86;84;130;86;85;86;114;86;85;130 00:09:18 INFO - PROCESS | 27431 | |5;imaging-gaussian-blur;118;118;117;117;117;117;117;117;118;118 00:09:18 INFO - PROCESS | 27431 | |6;imaging-darkroom;146;146;146;147;146;147;146;146;146;146 00:09:18 INFO - PROCESS | 27431 | |7;imaging-desaturate;95;94;95;95;96;95;95;96;95;94 00:09:18 INFO - PROCESS | 27431 | |8;json-parse-financial;62;63;64;64;65;62;62;64;65;62 00:09:18 INFO - PROCESS | 27431 | |9;json-stringify-tinderbox;65;65;65;65;67;65;65;65;65;66 00:09:18 INFO - PROCESS | 27431 | |10;stanford-crypto-aes;80;80;80;80;79;81;79;81;78;79 00:09:18 INFO - PROCESS | 27431 | |11;stanford-crypto-ccm;127;129;126;128;138;130;142;142;171;137 00:09:18 INFO - PROCESS | 27431 | |12;stanford-crypto-pbkdf2;172;179;170;168;171;167;170;173;176;167 00:09:18 INFO - PROCESS | 27431 | |13;stanford-crypto-sha256-iterative;67;68;68;69;71;71;67;70;67;66 00:09:18 INFO - PROCESS | 27431 | __end_tp_report 00:09:18 INFO - PROCESS | 27431 | __start_cc_report 00:09:18 INFO - PROCESS | 27431 | _x_x_mozilla_cycle_collect,1892 00:09:18 INFO - PROCESS | 27431 | __end_cc_report 00:09:18 INFO - PROCESS | 27431 | __startTimestamp1467529758969__endTimestamp 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | ------- Summary: start ------- 00:09:18 INFO - PROCESS | 27431 | Number of tests: 14 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#0] ai-astar Cycles:10 Average:112.50 Median:114.00 stddev:3.44 (3.0%) stddev-sans-first:0.88 00:09:18 INFO - PROCESS | 27431 | Values: 103.0 114.0 114.0 115.0 113.0 113.0 113.0 112.0 114.0 114.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#1] audio-beat-detection Cycles:10 Average:138.10 Median:137.50 stddev:20.64 (15.0%) stddev-sans-first:20.31 00:09:18 INFO - PROCESS | 27431 | Values: 160.0 121.0 123.0 181.0 124.0 130.0 145.0 122.0 152.0 123.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#2] audio-dft Cycles:10 Average:161.10 Median:161.50 stddev:0.88 (0.5%) stddev-sans-first:0.87 00:09:18 INFO - PROCESS | 27431 | Values: 162.0 162.0 160.0 162.0 161.0 161.0 162.0 161.0 160.0 160.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#3] audio-fft Cycles:10 Average:81.90 Median:76.00 stddev:13.58 (17.9%) stddev-sans-first:14.24 00:09:18 INFO - PROCESS | 27431 | Values: 76.0 77.0 76.0 115.0 75.0 76.0 75.0 76.0 98.0 75.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#4] audio-oscillator Cycles:10 Average:97.20 Median:85.50 stddev:19.46 (22.8%) stddev-sans-first:20.21 00:09:18 INFO - PROCESS | 27431 | Values: 86.0 84.0 130.0 86.0 85.0 86.0 114.0 86.0 85.0 130.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#5] imaging-gaussian-blur Cycles:10 Average:117.40 Median:117.50 stddev:0.52 (0.4%) stddev-sans-first:0.50 00:09:18 INFO - PROCESS | 27431 | Values: 118.0 118.0 117.0 117.0 117.0 117.0 117.0 117.0 118.0 118.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.44 00:09:18 INFO - PROCESS | 27431 | Values: 146.0 146.0 146.0 147.0 146.0 147.0 146.0 146.0 146.0 146.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 00:09:18 INFO - PROCESS | 27431 | Values: 95.0 94.0 95.0 95.0 96.0 95.0 95.0 96.0 95.0 94.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#8] json-parse-financial Cycles:10 Average:63.30 Median:64.00 stddev:1.25 (2.0%) stddev-sans-first:1.24 00:09:18 INFO - PROCESS | 27431 | Values: 62.0 63.0 64.0 64.0 65.0 62.0 62.0 64.0 65.0 62.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#9] json-stringify-tinderbox Cycles:10 Average:65.30 Median:65.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 00:09:18 INFO - PROCESS | 27431 | Values: 65.0 65.0 65.0 65.0 67.0 65.0 65.0 65.0 65.0 66.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#10] stanford-crypto-aes Cycles:10 Average:79.70 Median:80.00 stddev:0.95 (1.2%) stddev-sans-first:1.00 00:09:18 INFO - PROCESS | 27431 | Values: 80.0 80.0 80.0 80.0 79.0 81.0 79.0 81.0 78.0 79.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#11] stanford-crypto-ccm Cycles:10 Average:137.00 Median:137.50 stddev:13.42 (9.8%) stddev-sans-first:13.74 00:09:18 INFO - PROCESS | 27431 | Values: 127.0 129.0 126.0 128.0 138.0 130.0 142.0 142.0 171.0 137.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:171.30 Median:171.50 stddev:3.89 (2.3%) stddev-sans-first:4.12 00:09:18 INFO - PROCESS | 27431 | Values: 172.0 179.0 170.0 168.0 171.0 167.0 170.0 173.0 176.0 167.0 00:09:18 INFO - PROCESS | 27431 | 00:09:18 INFO - PROCESS | 27431 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.40 Median:68.50 stddev:1.78 (2.6%) stddev-sans-first:1.81 00:09:18 INFO - PROCESS | 27431 | Values: 67.0 68.0 68.0 69.0 71.0 71.0 67.0 70.0 67.0 66.0 00:09:18 INFO - PROCESS | 27431 | -------- Summary: end -------- 00:09:18 INFO - PROCESS | 27431 | 00:09:19 INFO - TEST-INFO | 27431: exit 0 00:09:20 INFO - TEST-OK | kraken | took 63020ms 00:09:20 INFO - SUITE-END | took 1181s 00:09:20 INFO - Completed test suite (00:19:42) 00:09:20 INFO - javascript benchmark 00:09:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2619.6332513448115, 2626.2383908666466, 2652.257367936977, 2665.320343312454, 2668.186203208022, 4566.474855391622, 4631.7915693793775, 4713.363695901056, 4771.546703063208, 4808.927866082007, 4635.374224479694, 4689.554492323233, 4694.694844835083, 4702.0360826030665, 4716.481187069428, 4299.26912424887, 4331.501877284121, 4363.650907927358, 4400.295952647577, 4462.79917403716, 4427.667924905629, 4437.64498840092, 4456.955430445686, 4485.0805584855025, 4520.141173177086, 4228.746275223466, 4276.572342765729, 4299.269124248885, 4345.521992580813, 4377.4528183977, 4289.056407590325, 4292.055747735493, 4298.849540266076, 4386.8903277418, 4428.269335559628, 4367.825286988516, 4372.934405983913, 4384.320430333271, 4427.977860110711, 4443.066955939256, 4504.8873778155485, 4676.976615116937, 4679.415073115861, 4739.905201895977, 4813.711177329372, 5130.461301563357, 5136.280920671109, 5139.691618502864, 5143.022825663112, 5158.380994280673, 5112.488751124858, 5118.283440318359, 5125.3080834087295, 5153.3558305211845, 5156.407013193456, 4605.470370907322, 4713.505081966413, 4719.669623126417, 4723.315119307681, 4819.927701084486, 5200.271961925334, 5221.190715439113, 5225.6603320784025, 5278.8944221116135, 5283.815066472655, 5021.196608542616, 5023.1711767557945, 5059.671121377099, 5072.0, 5072.82245121419, 4892.363992680928, 5008.974955125201, 5050.217216331474, 5061.898762024739, 5076.695398276115, 5007.499250074963, 5035.571976381975, 5049.6212784041345, 5052.949470505321, 5105.978804239167, 4812.711237325771, 4986.227134794112, 5010.749462526932, 5014.448410674823, 5016.322796422509, 4166.708330416903, 4173.290540608104, 4183.937240941388, 4223.704340696183, 4256.510501292391, 3749.456328832304, 3756.079760458705, 3789.2232092420986, 3792.886213413602, 3830.8084595770656, 4427.734335939854, 4438.955610443919, 4440.33394990754, 4479.955200448019, 4486.237339652267, 4934.284528743312, 4974.602031837444, 5041.664168814817, 5047.596192304607, 5108.106081435808, 4361.890952726144, 4406.757628330409, 4409.206342858316, 4438.556144385536, 4450.354698568754, 4519.615832654261, 4523.095380923828, 4530.935230220895, 4531.954680453219, 4570.451545814523, 4552.430946131733, 4746.908211111395, 4766.308885211694, 4805.183118869731, 4816.229403295456, 5114.769835357492, 5124.128898087409, 5129.025485157808, 5134.948650513447, 5184.040952423814, 4814.5907597854575, 4823.469418364048, 4826.710397376169, 4830.758462076952, 4869.975650121868, 4792.137415265146, 4859.222524396079, 4894.755262236803, 4912.189488734319, 4956.430010548833, 4993.975030124826, 5020.974895125501, 5025.824096156617, 5027.472115427828, 5074.391073071108, 4816.807327706852, 4885.291632713308, 4899.461059283547, 4905.48492408292, 4948.579370753526, 4825.927611085766, 4859.0, 4866.829660961849, 4886.267059941038, 4899.730514821576, 4809.831655892027, 4825.4933232011535, 4860.538248866352, 4872.707637541759, 4878.609711223023, 4825.324454576432, 4894.681845680019, 4900.901981960412, 4923.679960802537, 4923.852284431473, 4675.368825208553, 4738.099761045391, 4756.405449318835, 4818.71087734737, 4826.155422801066], "value": 4642.26405996154, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [573.787698551536, 575.1372940589116, 577.7544543568985, 578.7989920914105, 579.1139556478583, 39866.80066599666, 41611.37582936254, 41670.58329416709, 46158.0, 46176.53823461764, 41984.58015419845, 42462.0, 42510.7874460628, 42519.787401063026, 42522.78738606303, 7879.6060196990065, 8017.3986950978615, 8018.639161237729, 8020.518768873857, 8021.5187088774865, 7787.0, 7863.488873223251, 7863.685452581918, 7867.291943725064, 7868.370530357558, 7856.2143785621265, 7887.132415434297, 7894.381651761404, 7894.921050789505, 7897.328727058179, 7824.413169012319, 7842.41181911356, 7853.410994175402, 7855.8821617675785, 7859.8035049123655, 7891.723789667334, 7944.6027698614835, 7950.681972721084, 7953.164917683618, 7955.24425179607, 38350.61649383498, 38626.613733862585, 38734.225315493815, 38779.41830872539, 38809.22381552353, 3143.4970404735363, 3152.8265945372996, 3561.269939662363, 3789.5263092113487, 3810.4474851146706, 29958.400831983457, 30108.69891301081, 30323.848380758176, 30681.0, 31002.534961975587, 3480.547528821237, 3555.2711694102645, 3561.9643803561894, 3570.6786389225094, 3582.6775590197008, 257190.0, 259951.0, 260685.0, 261025.0, 262000.0, 52307.215391769154, 52415.0, 52650.0, 52711.73644131832, 52808.47191528112, 33286.66713332836, 34450.310993780484, 54882.0, 54918.17622735662, 55037.174442383395, 14817.481388151364, 14975.775363369557, 14984.850151498564, 14993.475228367173, 15007.0, 11199.776004479865, 11232.719182020515, 11332.886671133183, 11361.943190283995, 11378.943105284587, 18218.635627287644, 18267.177976991068, 18269.81730182708, 18277.268909243747, 18365.7245141323, 6747.797566073025, 6856.6228857412325, 6882.174139103239, 7149.82125446868, 7186.6704659638135, 854.3250831842898, 959.596969272907, 976.799756050008, 1011.1354791653177, 1023.2734758321526, 28585.57121643177, 28843.134705958855, 29120.525399114722, 29280.560791588145, 29508.262293442836, 978.9853152202722, 984.7981163861391, 990.3067852503276, 1053.9262251642313, 1084.5282302198568, 14937.850621493646, 15397.335325613249, 15398.46105386306, 15668.68662626764, 15705.293261803246, 411749.0, 416261.0, 416751.0, 417296.0, 417556.0, 50283.245751313756, 50989.66587840075, 51002.0, 51019.0, 51091.744541277054, 1071.8177909755361, 1134.6539305511733, 1151.9424028798694, 1186.6677330347516, 1203.843500344967, 27290.0, 29215.0, 29783.55324670175, 29990.550141747455, 30017.549736753528, 42704.57295427006, 43183.35224971691, 43248.56751432445, 43294.134117318106, 43307.13385732205, 306012.0, 307057.0, 307710.0, 308313.0, 308417.0, 22210.88894555517, 24621.261362159163, 25555.616665749658, 25570.616440753776, 25637.23088307354, 41482.37776433295, 41640.0, 42796.0, 43102.78448607737, 43339.13321733485, 35933.64066359407, 36960.26079478342, 37398.8130059348, 37503.43744843884, 37562.06094847651, 36315.03494414939, 36633.45049824308, 36844.44733329056, 36944.63055369412, 37141.62858371382, 35721.82139089392, 36094.0, 36118.45822312615, 36387.0, 36756.264874702894, 31735.84132079325, 32971.726829074214, 33074.33851323008, 33430.331393372486, 33553.32893342168, 24721.87639061793, 25415.36461588475, 25751.0, 26076.8696156518, 27667.44665106727], "value": 17873.355117923515, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.56020095282787, 375.33378253599847, 376.05985037406487, 383.45932235547866, 389.3653345047572, 13118.624307781985, 13225.669358266035, 17910.731339029924, 17942.0, 17951.28194872207, 15954.361825526994, 17103.40138095167, 17129.314827406888, 17135.82864171358, 17177.0, 3778.9433158502643, 5075.7715902784375, 5283.445238249986, 5286.31277933868, 5287.788488460457, 5777.59556831022, 6113.083037544382, 6113.296970848365, 6237.126802247689, 6239.844003899893, 6010.669413182273, 6090.695465226743, 6148.169997050408, 6164.59930104544, 6187.690615469209, 6218.253809542861, 6220.813375598739, 6224.284207316171, 6227.221597300338, 6261.561690681654, 5268.973655131738, 5344.706041167734, 5347.893042139174, 5351.839444816662, 5352.652077614943, 21501.56996860054, 21502.677459838116, 21559.1376344946, 21697.67453488199, 21720.13119475219, 1972.9506762331057, 2124.6812978053263, 2255.1430456426615, 2352.776486233805, 2528.4563818778865, 12876.613701588967, 13608.319584020759, 13749.381277842522, 13876.444942202299, 14147.080439771382, 1735.2798588585722, 1817.282173541457, 1822.5352535103596, 1832.93584724534, 1886.8584856135708, 50466.495335046544, 75848.62075689586, 76041.61979190123, 76134.619326903, 77384.0, 9675.516224188763, 9820.214382849355, 9886.209103271722, 10091.949540252252, 10139.7465063374, 13015.869841301466, 13067.673308167181, 13146.671333216555, 13210.933945330213, 13262.734745305233, 7562.978997835332, 7638.50349727266, 7651.1583725790115, 7713.267239612228, 7848.843023139505, 7194.0, 7352.70589176427, 7415.998840156618, 7470.178280389153, 7551.093868735787, 6096.311731402527, 6339.429451349401, 6382.808515744535, 6412.551121421456, 6542.901856472156, 1674.6148385871318, 1702.3956495444186, 1711.6063305439818, 1730.1781653714386, 1741.712617418112, 832.5878690048464, 848.7878030492377, 862.8662557303628, 910.5356268303213, 925.7176561148914, 17491.737623935653, 17792.55518612045, 18070.5482362942, 18090.366837160636, 18332.816671833378, 851.8168593752373, 874.5059041641452, 879.4503435352905, 900.9234215091659, 925.3753716241511, 8252.876206856901, 10003.699889003341, 10403.219758518142, 10419.687409377731, 10428.426436545911, 422501.0, 427305.0, 429036.0, 435043.0, 435710.0, 47368.0, 77871.22128778753, 77995.22004779993, 78918.0, 80543.59728201322, 881.8412685716504, 892.5448021508947, 899.2760827533767, 899.7525680437932, 900.5632268349846, 15871.285792139612, 16075.35698572044, 16096.11471369086, 16157.192140392699, 16194.0, 38358.2328353437, 38428.23143537057, 38819.0, 38878.0, 39834.0, 48886.75556622194, 49621.0, 50510.0, 50808.491915080376, 51035.23447148222, 6693.866122677617, 7781.649825757741, 7874.960625196837, 7913.643886025257, 7949.523028618301, 12151.513939442324, 12388.690282743004, 12397.256164630151, 12543.87456125427, 12784.296863672214, 11050.668479945292, 11181.32912025281, 11356.375399353115, 11430.371329576954, 11454.599089031844, 10590.4704764763, 10975.670729878117, 11002.944985275022, 11004.22970392097, 11153.944230278797, 10220.335678180894, 10833.891661083288, 10883.564657413615, 11208.55165793359, 11375.54497820078, 7953.483023603448, 7973.040439340988, 8163.551004694561, 8275.089740128702, 8279.047909490486, 9585.0, 10845.674629761119, 10896.400697961371, 11047.889521105008, 11199.21605487608], "value": 8669.839998861074, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1268.7969924812032, 1382.5092092307232, 1397.916125032498, 1494.7458931981562, 1720.3720641965679, 7109.928900710991, 7888.881666774996, 8175.0, 8187.18128187181, 8414.158584141584, 8115.0, 8251.298639615625, 8270.214329638675, 8272.214139656722, 8280.378971577125, 2272.920447784332, 2303.2053941390195, 2305.4697419593504, 2307.157887371114, 2307.492351682627, 2242.7420846602686, 2278.8176945844375, 2282.7945484906354, 2283.0525331987205, 2283.6574513822893, 2251.6509940959177, 2272.7045484087043, 2281.589313923493, 2287.0508738873345, 2292.4039749665126, 2167.2631305356254, 2183.279517759144, 2185.115028413495, 2187.453136715821, 2191.1783081344497, 2165.1231251343074, 2167.414798004546, 2169.121505790142, 2170.4248374180856, 2171.9782802171935, 8155.062167850714, 8167.918320816834, 8217.219364160395, 8232.670693172266, 8436.02985656645, 4704.670673052888, 4815.975920120412, 4816.277558366238, 4817.3737414136285, 4833.589144922686, 2834.2064222017866, 2952.7342539171364, 3000.144958686764, 3007.6541197762317, 3010.834404107773, 960.5293406230967, 964.9083337082966, 973.8733964584629, 978.1294647763497, 980.7695191630032, 11368.317900925887, 11479.0, 11485.425728713531, 11489.368084755335, 11492.0, 4250.277452833026, 4255.87232383029, 4280.892977675583, 4302.612764851178, 4304.225239456865, 8930.732078037669, 8983.46099234048, 8985.775355616031, 8992.505412202392, 8997.100289971082, 4656.67403281767, 4662.883427914329, 4666.603338716247, 4666.673332866667, 4668.066386722669, 3774.6225377462033, 3796.886093417202, 3914.6085391460624, 4214.726042807208, 4317.460317460317, 3516.894493165209, 3535.416656251741, 3612.1330880588994, 3632.0556655269293, 3647.179384638488, 1078.132103656564, 1081.1891081688734, 1093.1746531368765, 1097.5609756097465, 1099.543689368903, 755.7657126290867, 794.1859593916282, 818.8485130250804, 819.5041999590162, 847.1740053447962, 5160.509751573594, 5221.608379371486, 5404.432534583891, 5433.972830135824, 5545.889082218333, 857.3998201259144, 861.814709837388, 878.9208971192623, 886.9047323128539, 896.188949001155, 3598.676119149289, 3749.681277091423, 3801.5438147421933, 3802.980985095057, 3876.5541962674088, 9438.433693978246, 9810.901890981142, 9831.213502919749, 10247.487625618838, 10586.894131058745, 9630.711078667651, 9999.50002499872, 10075.0, 10085.193184545218, 10140.898591013995, 7298.854022919512, 7629.198934111839, 7669.309762121436, 7674.232576742281, 7858.017747781641, 5629.408912064175, 5710.600257981901, 5850.356460789225, 5951.315598706205, 6007.789727359696, 9528.666496672584, 9572.712818615453, 9607.471589062668, 9660.565274562521, 9674.75813104678, 9185.540722963959, 9580.0, 9808.215342772704, 9828.901710982798, 9830.508474576385, 7724.9227507726455, 7853.1361550228285, 7885.093214280431, 8002.599870006593, 8005.519668819889, 7956.2441568050945, 7968.442209045311, 7982.8802567960365, 7984.241497058003, 8014.599270036591, 6783.05037294789, 6953.930460695531, 7048.964755176191, 7063.611501367474, 7181.317774811385, 6941.583504989717, 7033.191183013814, 7062.046623705939, 7073.752418665322, 7108.182559005781, 6522.28254891952, 6636.601803891782, 6639.402453779183, 6646.667666616553, 6700.195976482853, 4668.393108895822, 4726.196546587157, 4746.145693775154, 4751.6436267279405, 4798.2082956311815, 4894.290327902506, 4932.654714169974, 4992.301077849177, 5020.698758074527, 5099.26060721186], "value": 4284.884862957247, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [296.4249356248877, 299.33248855053233, 306.4805155261831, 309.27320796129084, 311.81291225264846, 4801.159797035518, 4829.613630909527, 4834.709917404954, 4846.684965477241, 4850.320955066285, 4481.977590112045, 4599.908001839961, 4600.17196904557, 4611.584957353837, 4751.572358487735, 3635.291118231946, 3688.3360995020953, 3727.6831469325, 3739.7845700147427, 3780.451834483998, 3709.4806727058235, 3741.4948981887505, 3741.7380783345175, 3759.248150369937, 3762.341590221714, 3606.6393360663988, 3689.1001134415797, 3716.7769933803925, 3739.196072844338, 3764.247150569883, 3758.267137908109, 3771.4531392948006, 3779.6598306152305, 3782.5082739244, 3790.2419516096893, 3307.3054658521737, 3324.734021278316, 3334.7832390894514, 3337.147882924976, 3345.1135449106005, 4665.4168228971375, 4675.88310292242, 4678.0, 4681.7190968542, 4688.789004494772, 4178.979105104486, 4196.391523229146, 4279.20273485137, 4285.550017248175, 4297.527272000078, 4945.615227736203, 4980.82567110153, 4994.750262486861, 5006.299118123466, 5010.3737032870895, 3597.3704601694863, 3598.1904071583945, 3606.0, 3611.223586928823, 3617.0, 4945.678530895516, 5179.456157103526, 5191.999999999962, 5206.479352064764, 5210.426853046162, 3649.069487280726, 3651.1602331463914, 3674.706023518112, 3682.3371793076967, 3685.1892583631557, 3742.5321834770652, 3743.9251214975548, 3745.8688945887307, 3747.775133491999, 3750.1937083527173, 4238.321868501025, 4245.044864905433, 4248.4052232687445, 4248.830046798155, 4257.510386305615, 4869.269609558523, 4926.3842019747535, 4942.9011419771405, 4946.9010619787405, 5022.573081288131, 1280.5070048031575, 1281.8974482041601, 1296.682312833362, 1302.602706174607, 1303.48512337628, 838.2288294768828, 884.5842454046588, 911.8586619074055, 919.9816003679889, 925.7130289610243, 4425.955740442619, 4434.645228381722, 4437.156940181355, 4443.178012067778, 4444.11117776446, 5081.745912704424, 5102.9489705103215, 5106.540411362921, 5126.282320475137, 5128.974355128201, 4210.305299625588, 4403.097365040223, 4414.977925110354, 4444.2222611042935, 4454.0, 2663.4673065386614, 2687.368468409922, 2691.9461610767676, 2696.9056083037, 2696.9595456068173, 4804.399450068741, 4813.7352445615825, 4816.590589799836, 4823.300621409946, 4824.951750482521, 5047.217681259411, 5190.844274671766, 5208.166693329049, 5308.469153084738, 5308.575313974873, 4898.432501599454, 4918.926216106833, 4919.286703428054, 4927.852164435073, 4931.284963680247, 5169.276301317894, 5202.97398513005, 5205.245239440184, 5242.475752424727, 5242.5281724644965, 4885.0, 5086.474057782576, 5097.400325833925, 5104.387473503203, 5163.715995620277, 4881.463039065629, 4907.877303067452, 4910.091633047898, 4916.532929371704, 4917.803287868445, 3634.9636503634624, 3646.872359467406, 3651.3062518121474, 3655.214128962286, 3655.4334078217917, 5098.745062746922, 5163.638545301793, 5167.534921856901, 5209.973950130225, 5227.137522308776, 4987.6508644396, 4989.975050124726, 4999.825006124768, 5013.147764880052, 5024.974875125601, 5033.295338652519, 5071.366079240095, 5072.365954255718, 5085.855682471414, 5105.617078719037, 4727.747147005977, 4774.3554620127225, 4965.304857319906, 4993.176125939324, 5038.168702164102, 4868.245421959602, 4921.089598424303, 4945.901081978413, 4949.33184020167, 4958.355413796184, 4892.0705066037335, 4923.163062279349, 4923.359963204904, 4930.334404855299, 4939.728314942569], "value": 3787.194549458986, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [670.865826834633, 690.6305126757186, 734.713461749918, 750.028712816902, 764.9579273139975, 13731.93134034331, 13806.58580242593, 14239.78640320396, 14555.417783288669, 14557.92721036396, 13531.0, 13561.864381356183, 13684.794728079087, 13708.383122759475, 13710.45158193671, 635.5582869905418, 751.6955632968629, 769.7960040589248, 787.8030492376906, 797.7646594254679, 790.6916302641974, 791.2008871040262, 793.5714714054403, 794.3010151067082, 795.2842441802367, 833.7457075591942, 839.0225387423675, 841.0034109580137, 842.7176895739934, 842.8356470488258, 651.2608189704696, 673.1047706550277, 678.067656971664, 685.5612408058846, 830.9542975136366, 583.3787016827066, 606.2452246952572, 608.9969550152265, 610.2280615022, 610.4322979628944, 13680.65798355039, 13693.589192324247, 13708.17750934937, 13710.794338084937, 13731.45074197031, 12280.631581052583, 12332.81500777489, 12484.687882803002, 12556.0, 12992.935035324857, 12153.513859445611, 12419.93790031044, 12441.75116497674, 12561.874381256162, 12672.80990785139, 3343.2477692519233, 3466.3933811582874, 3512.0693016350688, 3572.964270357289, 4385.736855788663, 63923.0, 64064.0, 64462.0, 64741.676291618714, 64956.0, 10687.465626718633, 10857.51141198648, 10859.07697845692, 11020.44897755109, 11052.944735276273, 19030.714539281922, 19088.80911190898, 19129.52176195606, 19135.13891874869, 19244.0, 6820.31796820324, 6986.54587451814, 7075.716971321192, 7162.319579639926, 7163.42692584592, 3503.5445392098864, 4000.5199376075057, 4008.617027125637, 4029.738067025634, 4068.0846809467635, 2937.9559306610417, 3016.1403999859936, 3025.0, 3027.4399236141385, 3035.514317709156, 491.63127654259307, 495.3288294361161, 509.5465036117858, 511.88994366211443, 512.5233532814444, 431.7107537949581, 440.27354864473875, 508.36200568286563, 526.9394019687785, 531.7713383245242, 8251.133630968781, 8348.833023339499, 8542.40203185771, 8677.479351238819, 8898.154675305836, 574.7844558290641, 583.1660725162973, 585.6339787632729, 586.9178315035813, 594.6402426531886, 3677.7548428072128, 4066.207089617496, 4134.834606615702, 4307.784610769449, 4523.36672865799, 92471.0, 100773.0, 104339.0, 107288.46355768171, 107681.0, 53844.461555384725, 54979.45020549744, 63682.0, 68884.3111568878, 69078.0, 48999.0, 60877.39122608717, 69514.0, 71459.0, 73819.63090184514, 8134.959325203336, 8180.30467410253, 8359.707410240613, 8378.622961966605, 8454.323654107533, 43630.0, 45152.0, 45874.54125458836, 46117.0, 46207.53792462167, 63471.0, 66561.0, 66860.3313966854, 67271.0, 67415.0, 11411.714707132389, 11619.734018032885, 11624.128190385585, 11723.824142638037, 11738.94130529342, 12741.55404560836, 12950.585518556207, 12951.287679177736, 13028.934855325662, 14001.089929154572, 12568.685782855502, 12662.176958497668, 12835.294058826481, 12844.550440734529, 13294.135881167693, 12078.154529182873, 12706.87293127057, 12868.678283042998, 12941.805872912102, 13047.804282935953, 10785.40680262593, 11285.266457680225, 11294.60468883585, 11335.0, 11354.772904542027, 10313.690589282334, 10325.173986081245, 10508.474576271308, 10585.470726463493, 10814.783704325711, 9499.667511637059, 9709.465979371202, 9728.75678108053, 9843.360181588174, 9850.655227067018], "value": 6638.195624320822, "unit": "score"}], "name": "dromaeo_css", "value": 6529.561587397835, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 115.0, 113.0, 113.0, 113.0, 112.0, 114.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 121.0, 123.0, 181.0, 124.0, 130.0, 145.0, 122.0, 152.0, 123.0], "value": 138.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 160.0, 162.0, 161.0, 161.0, 162.0, 161.0, 160.0, 160.0], "value": 161.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 76.0, 115.0, 75.0, 76.0, 75.0, 76.0, 98.0, 75.0], "value": 81.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 130.0, 86.0, 85.0, 86.0, 114.0, 86.0, 85.0, 130.0], "value": 97.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 118.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 118.0, 118.0], "value": 117.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0, 146.0, 146.0], "value": 146.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 95.0, 94.0], "value": 95.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 63.0, 64.0, 64.0, 65.0, 62.0, 62.0, 64.0, 65.0, 62.0], "value": 63.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 65.0, 65.0, 67.0, 65.0, 65.0, 65.0, 65.0, 66.0], "value": 65.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 80.0, 80.0, 80.0, 79.0, 81.0, 79.0, 81.0, 78.0, 79.0], "value": 79.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [127.0, 129.0, 126.0, 128.0, 138.0, 130.0, 142.0, 142.0, 171.0, 137.0], "value": 137.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 179.0, 170.0, 168.0, 171.0, 167.0, 170.0, 173.0, 176.0, 167.0], "value": 171.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 69.0, 71.0, 71.0, 67.0, 70.0, 67.0, 66.0], "value": 68.4, "unit": "score"}], "name": "kraken", "value": 1534.4, "alertThreshold": 2.0}]} 00:09:20 INFO - Return code: 0 00:09:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 00:09:20 INFO - # TBPL SUCCESS # 00:09:20 INFO - Running post-action listener: _resource_record_post_action 00:09:20 INFO - ##### 00:09:20 INFO - ##### Finished run-tests step (success) 00:09:20 INFO - ##### 00:09:20 INFO - Running post-run listener: _resource_record_post_run 00:09:20 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 539013120; Read time: 92; Write time: 391816 00:09:20 INFO - TinderboxPrint: CPU usage
12.9% 00:09:20 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 92 00:09:20 INFO - TinderboxPrint: I/O write bytes / time
539,013,120 / 391,816 00:09:20 INFO - TinderboxPrint: CPU idle
8,324.6 (87.0%) 00:09:20 INFO - TinderboxPrint: CPU user
1,199.1 (12.5%) 00:09:20 INFO - TinderboxPrint: Swap in / out
0 / 0 00:09:20 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 245284864; Read time: 0; Write time: 205600 00:09:20 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 4096; Write bytes: 288518144; Read time: 92; Write time: 185768 00:09:20 INFO - Running post-run listener: _upload_blobber_files 00:09:20 INFO - Blob upload gear active. 00:09:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 00:09:20 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 00:09:20 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'] 00:09:20 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 00:09:21 INFO - (blobuploader) - INFO - Open directory for files ... 00:09:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 00:09:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:09:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:09:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 00:09:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:09:22 INFO - (blobuploader) - INFO - Done attempting. 00:09:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 00:09:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:09:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:09:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 00:09:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:09:26 INFO - (blobuploader) - INFO - Done attempting. 00:09:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 00:09:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 00:09:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 00:09:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 00:09:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 00:09:26 INFO - (blobuploader) - INFO - Done attempting. 00:09:26 INFO - (blobuploader) - INFO - Iteration through files over. 00:09:26 INFO - Return code: 0 00:09:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 00:09:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 00:09:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/03a4c46a4298f6ba7562a082df9650d4269b37e466af8bf5d3f6862452d9d3f79f3cffb4462f01ce64d2a23b679175f62c6c55412ea172b4ed7383b89948cc87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9f3591e08595a8c0e809806e65a293103e6b95f71f89359c51c1ff41ee89b8bbacb5b327f3b7486602b7547fc820a26fb219d02ec6ef5bd35f3b60fa91a951dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/39f289637d4a7ba9da4acb752bd01b6350a9b6faad5ff977b7dbfe827799bb134f9e8527eb4cc8afae8eae2284f4dd49f8333ca75a88d9a387da152d6c2ba7e0"} 00:09:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 00:09:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 00:09:26 INFO - Contents: 00:09:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/03a4c46a4298f6ba7562a082df9650d4269b37e466af8bf5d3f6862452d9d3f79f3cffb4462f01ce64d2a23b679175f62c6c55412ea172b4ed7383b89948cc87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9f3591e08595a8c0e809806e65a293103e6b95f71f89359c51c1ff41ee89b8bbacb5b327f3b7486602b7547fc820a26fb219d02ec6ef5bd35f3b60fa91a951dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/39f289637d4a7ba9da4acb752bd01b6350a9b6faad5ff977b7dbfe827799bb134f9e8527eb4cc8afae8eae2284f4dd49f8333ca75a88d9a387da152d6c2ba7e0"} 00:09:26 INFO - Running post-run listener: copy_logs_to_upload_dir 00:09:26 INFO - Copying logs to upload dir... 00:09:26 INFO - mkdir: /builds/slave/test/build/upload/logs 00:09:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.513010 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-03 00:09:25.417075) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 00:09:25.421110) ========= 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=923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343 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/03a4c46a4298f6ba7562a082df9650d4269b37e466af8bf5d3f6862452d9d3f79f3cffb4462f01ce64d2a23b679175f62c6c55412ea172b4ed7383b89948cc87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9f3591e08595a8c0e809806e65a293103e6b95f71f89359c51c1ff41ee89b8bbacb5b327f3b7486602b7547fc820a26fb219d02ec6ef5bd35f3b60fa91a951dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/39f289637d4a7ba9da4acb752bd01b6350a9b6faad5ff977b7dbfe827799bb134f9e8527eb4cc8afae8eae2284f4dd49f8333ca75a88d9a387da152d6c2ba7e0"} build_url:https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011131 build_url: 'https://queue.taskcluster.net/v1/task/cQ9M3YcnS4aI-r_a4ztlaw/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/03a4c46a4298f6ba7562a082df9650d4269b37e466af8bf5d3f6862452d9d3f79f3cffb4462f01ce64d2a23b679175f62c6c55412ea172b4ed7383b89948cc87", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/9f3591e08595a8c0e809806e65a293103e6b95f71f89359c51c1ff41ee89b8bbacb5b327f3b7486602b7547fc820a26fb219d02ec6ef5bd35f3b60fa91a951dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Autoland-Non-PGO/sha512/39f289637d4a7ba9da4acb752bd01b6350a9b6faad5ff977b7dbfe827799bb134f9e8527eb4cc8afae8eae2284f4dd49f8333ca75a88d9a387da152d6c2ba7e0"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-03 00:09:25.446332) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 00:09:25.446673) ========= 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=923d835db2ba3686ebe126b700000192-1467528528.518113-1690793343 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-03 00:09:25.531127) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 00:09:25.531445) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-03 00:09:25.531768) ========= ========= Total master_lag: 0.17 =========