builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1467645672.28 results: success (0) buildid: 20160704074125 builduid: 709da44dfb6747f88321fcc03f3c45c9 revision: 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:12.279291) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:12.281332) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:12.281986) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:12.323284) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:12.323539) ========= 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=33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 08:21:12-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.0M=0s 2016-07-04 08:21:12 (43.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.096908 ========= master_lag: 0.07 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:12.492730) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:12.493229) ========= 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=33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018138 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:12.544594) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:12.544909) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 --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=33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 08:21:12,822 truncating revision to first 12 chars 2016-07-04 08:21:12,822 Setting DEBUG logging. 2016-07-04 08:21:12,822 attempt 1/10 2016-07-04 08:21:12,822 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/02f60237d69a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 08:21:13,125 unpacking tar archive at: fx-team-02f60237d69a/testing/mozharness/ program finished with exit code 0 elapsedTime=0.641882 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:13.217070) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:13.217392) ========= script_repo_revision: 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:13.217790) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:13.218057) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 08:21:13.227202) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-07-04 08:21:13.227577) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 08:21:13 INFO - MultiFileLogger online at 20160704 08:21:13 in /builds/slave/test 08:21:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 08:21:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 08:21:13 INFO - {'append_to_log': False, 08:21:13 INFO - 'base_work_dir': '/builds/slave/test', 08:21:13 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 08:21:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 08:21:13 INFO - 'branch': 'Fx-Team-Non-PGO', 08:21:13 INFO - 'buildbot_json_path': 'buildprops.json', 08:21:13 INFO - 'config_files': ('talos/linux_config.py',), 08:21:13 INFO - 'default_actions': ('clobber', 08:21:13 INFO - 'read-buildbot-config', 08:21:13 INFO - 'download-and-extract', 08:21:13 INFO - 'populate-webroot', 08:21:13 INFO - 'create-virtualenv', 08:21:13 INFO - 'install', 08:21:13 INFO - 'run-tests'), 08:21:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 08:21:13 INFO - 'download_minidump_stackwalk': True, 08:21:13 INFO - 'download_symbols': 'ondemand', 08:21:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 08:21:13 INFO - 'tooltool.py': '/tools/tooltool.py', 08:21:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 08:21:13 INFO - '/tools/misc-python/virtualenv.py')}, 08:21:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 08:21:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 08:21:13 INFO - 'installer_path': 'installer.exe', 08:21:13 INFO - 'log_level': 'info', 08:21:13 INFO - 'log_name': 'talos', 08:21:13 INFO - 'log_to_console': True, 08:21:13 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 08:21:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 08:21:13 INFO - 'opt_config_files': (), 08:21:13 INFO - 'pip_index': False, 08:21:13 INFO - 'sps_profile': False, 08:21:13 INFO - 'sps_profile_interval': 0, 08:21:13 INFO - 'suite': 'dromaeojs', 08:21:13 INFO - 'system_bits': '32', 08:21:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 08:21:13 INFO - 'title': 'talos-linux64-ix-063', 08:21:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 08:21:13 INFO - 'use_talos_json': True, 08:21:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 08:21:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 08:21:13 INFO - 'work_dir': 'build'} 08:21:13 INFO - ##### 08:21:13 INFO - ##### Running clobber step. 08:21:13 INFO - ##### 08:21:13 INFO - Running pre-action listener: _resource_record_pre_action 08:21:13 INFO - Running main action method: clobber 08:21:13 INFO - rmtree: /builds/slave/test/build 08:21:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 08:21:14 INFO - Running post-action listener: _resource_record_post_action 08:21:14 INFO - ##### 08:21:14 INFO - ##### Finished clobber step (success) 08:21:14 INFO - ##### 08:21:14 INFO - ##### 08:21:14 INFO - ##### Running read-buildbot-config step. 08:21:14 INFO - ##### 08:21:14 INFO - Running pre-action listener: _resource_record_pre_action 08:21:14 INFO - Running main action method: read_buildbot_config 08:21:14 INFO - Using buildbot properties: 08:21:14 INFO - { 08:21:14 INFO - "project": "", 08:21:14 INFO - "product": "firefox", 08:21:14 INFO - "script_repo_revision": "production", 08:21:14 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 08:21:14 INFO - "repository": "", 08:21:14 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 08:21:14 INFO - "buildid": "20160704074125", 08:21:14 INFO - "pgo_build": "False", 08:21:14 INFO - "basedir": "/builds/slave/test", 08:21:14 INFO - "buildnumber": 1789, 08:21:14 INFO - "slavename": "talos-linux64-ix-063", 08:21:14 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 08:21:14 INFO - "platform": "ubuntu64_hw", 08:21:14 INFO - "scheduler": "tests-fx-team-linux64-talos", 08:21:14 INFO - "branch": "fx-team", 08:21:14 INFO - "repo_path": "integration/fx-team", 08:21:14 INFO - "revision": "02f60237d69a4061c0f3c499239b7c13a9c4eeb3", 08:21:14 INFO - "stage_platform": "linux64", 08:21:14 INFO - "builduid": "709da44dfb6747f88321fcc03f3c45c9", 08:21:14 INFO - "slavebuilddir": "test" 08:21:14 INFO - } 08:21:14 INFO - Found installer url https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 08:21:14 INFO - Running post-action listener: _resource_record_post_action 08:21:14 INFO - ##### 08:21:14 INFO - ##### Finished read-buildbot-config step (success) 08:21:14 INFO - ##### 08:21:14 INFO - ##### 08:21:14 INFO - ##### Running download-and-extract step. 08:21:14 INFO - ##### 08:21:14 INFO - Running pre-action listener: _resource_record_pre_action 08:21:14 INFO - Running main action method: download_and_extract 08:21:14 INFO - mkdir: /builds/slave/test/build/tests 08:21:14 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')]} 08:21:14 INFO - https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 08:21:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:21:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:21:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/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 08:21:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/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 08:21:20 INFO - Downloaded 1361 bytes. 08:21:20 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 08:21:20 INFO - Using the following test package requirements: 08:21:20 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:20 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 08:21:20 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 08:21:20 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'jsshell-linux-x86_64.zip'], 08:21:20 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 08:21:20 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 08:21:20 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 08:21:20 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 08:21:20 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 08:21:20 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 08:21:20 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 08:21:20 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 08:21: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')]} 08:21:20 INFO - https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:21:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:21:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/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 08:21:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/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 08:21:24 INFO - Downloaded 22709741 bytes. 08:21:24 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'] 08:21:24 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 08:21:25 INFO - Return code: 0 08:21:25 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 08:21:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:25 INFO - https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 08:21:25 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:21:25 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 08:21:25 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/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 08:21:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/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 08:21:33 INFO - Downloaded 22709741 bytes. 08:21:33 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'] 08:21:33 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 08:21:35 INFO - Return code: 0 08:21:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:35 INFO - https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 08:21:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 08:21:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/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 08:21:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/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 08:21:36 INFO - Downloaded 14403333 bytes. 08:21:36 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'] 08:21:36 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 08:21:37 INFO - Return code: 0 08:21: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')]} 08:21:37 INFO - https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 08:21:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:21:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:21:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/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 08:21:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/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 08:21:38 INFO - Downloaded 56486547 bytes. 08:21:39 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:21:39 INFO - mkdir: /builds/slave/test/properties 08:21:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 08:21:39 INFO - Writing to file /builds/slave/test/properties/build_url 08:21:39 INFO - Contents: 08:21:39 INFO - build_url:https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 08:21:39 INFO - Running post-action listener: _resource_record_post_action 08:21:39 INFO - Running post-action listener: set_extra_try_arguments 08:21:39 INFO - ##### 08:21:39 INFO - ##### Finished download-and-extract step (success) 08:21:39 INFO - ##### 08:21:39 INFO - ##### 08:21:39 INFO - ##### Running populate-webroot step. 08:21:39 INFO - ##### 08:21:39 INFO - Running pre-action listener: _resource_record_pre_action 08:21:39 INFO - Running main action method: populate_webroot 08:21:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 08:21:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 08:21:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 08:21:39 INFO - '--tppagecycles', 08:21:39 INFO - '7'], 08:21:39 INFO - 'tests': ['tsvgm']}}, 08:21:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 08:21:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 08:21:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 08:21:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 08:21:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 08:21:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 08:21:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:39 INFO - 'talos_options': ['--disable-e10s'], 08:21:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 08:21:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:39 INFO - 'talos_options': ['--disable-e10s'], 08:21:39 INFO - 'tests': ['damp', 'tps']}, 08:21:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:39 INFO - 'tests': ['damp', 'tps']}, 08:21:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 08:21:39 INFO - 'tests': ['dromaeo_dom']}, 08:21:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 08:21:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 08:21:39 INFO - 'tests': ['basic_compositor_video']}, 08:21:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 08:21:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 08:21:39 INFO - 'tests': ['a11yr', 08:21:39 INFO - 'ts_paint', 08:21:39 INFO - 'tpaint', 08:21:39 INFO - 'sessionrestore', 08:21:39 INFO - 'sessionrestore_no_auto_restore', 08:21:39 INFO - 'tabpaint']}, 08:21:39 INFO - 'other-e10s': {'tests': ['a11yr', 08:21:39 INFO - 'ts_paint', 08:21:39 INFO - 'tpaint', 08:21:39 INFO - 'sessionrestore', 08:21:39 INFO - 'sessionrestore_no_auto_restore', 08:21:39 INFO - 'tabpaint']}, 08:21:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 08:21:39 INFO - 'ts_paint', 08:21:39 INFO - 'tpaint', 08:21:39 INFO - 'sessionrestore', 08:21:39 INFO - 'sessionrestore_no_auto_restore', 08:21:39 INFO - 'tabpaint']}, 08:21:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 08:21:39 INFO - 'ts_paint', 08:21:39 INFO - 'tpaint', 08:21:39 INFO - 'sessionrestore', 08:21:39 INFO - 'sessionrestore_no_auto_restore', 08:21:39 INFO - 'tabpaint']}, 08:21:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 08:21:39 INFO - 'tests': ['a11yr', 08:21:39 INFO - 'ts_paint', 08:21:39 INFO - 'tpaint', 08:21:39 INFO - 'sessionrestore', 08:21:39 INFO - 'sessionrestore_no_auto_restore', 08:21:39 INFO - 'tabpaint']}, 08:21:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 08:21:39 INFO - 'tests': ['a11yr', 08:21:39 INFO - 'ts_paint', 08:21:39 INFO - 'tpaint', 08:21:39 INFO - 'sessionrestore', 08:21:39 INFO - 'sessionrestore_no_auto_restore', 08:21:39 INFO - 'tabpaint']}, 08:21:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 08:21:39 INFO - 'tests': ['tsvgx', 08:21:39 INFO - 'tsvgr_opacity', 08:21:39 INFO - 'tart', 08:21:39 INFO - 'tscrollx', 08:21:39 INFO - 'cart']}, 08:21:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 08:21:39 INFO - 'tsvgr_opacity', 08:21:39 INFO - 'tart', 08:21:39 INFO - 'tscrollx', 08:21:39 INFO - 'cart']}, 08:21:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:39 INFO - 'talos_options': ['--disable-e10s'], 08:21:39 INFO - 'tests': ['tp5o']}, 08:21:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:39 INFO - 'tests': ['tp5o']}, 08:21:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:39 INFO - 'talos_options': ['--disable-e10s', 08:21:39 INFO - '--xperf_path', 08:21:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:39 INFO - 'tests': ['tp5n']}, 08:21:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 08:21:39 INFO - 'talos_options': ['--xperf_path', 08:21:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 08:21:39 INFO - 'tests': ['tp5n']}}, 08:21:39 INFO - 'talos.zip': {'path': '', 08:21:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 08:21:39 INFO - Running post-action listener: _resource_record_post_action 08:21:39 INFO - ##### 08:21:39 INFO - ##### Finished populate-webroot step (success) 08:21:39 INFO - ##### 08:21:39 INFO - ##### 08:21:39 INFO - ##### Running create-virtualenv step. 08:21:39 INFO - ##### 08:21:39 INFO - Running pre-action listener: _resource_record_pre_action 08:21:39 INFO - Running main action method: create_virtualenv 08:21:39 INFO - Creating virtualenv /builds/slave/test/build/venv 08:21:39 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 08:21:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 08:21:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 08:21:40 INFO - Using real prefix '/usr' 08:21:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 08:21:40 INFO - Installing distribute.............................................................................................................................................................................................done. 08:21:42 INFO - Installing pip.................done. 08:21:42 INFO - Return code: 0 08:21:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 08:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:42 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 0xd8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3b0>, '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 0x104d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d740>, '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': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', '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 08:21:42 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 08:21:42 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 08:21:42 INFO - Using env: {'DISPLAY': ':0', 08:21:42 INFO - 'HOME': '/home/cltbld', 08:21:42 INFO - 'LANG': 'en_US.UTF-8', 08:21:42 INFO - 'LANGUAGE': 'en_US:en', 08:21:42 INFO - 'LOGNAME': 'cltbld', 08:21:42 INFO - 'MAIL': '/var/mail/cltbld', 08:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:42 INFO - 'MOZ_NO_REMOTE': '1', 08:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:42 INFO - 'NO_EM_RESTART': '1', 08:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:42 INFO - 'PWD': '/builds/slave/test', 08:21:42 INFO - 'SHELL': '/bin/bash', 08:21:42 INFO - 'SHLVL': '1', 08:21:42 INFO - 'TERM': 'linux', 08:21:42 INFO - 'TMOUT': '86400', 08:21:42 INFO - 'USER': 'cltbld', 08:21:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', 08:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:42 INFO - '_': '/tools/buildbot/bin/python'} 08:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:42 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 08:21:42 INFO - Cleaning up... 08:21:42 INFO - Return code: 0 08:21:42 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 08:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:42 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 0xd8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3b0>, '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 0x104d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d740>, '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': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', '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 08:21:42 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 08:21:42 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 08:21:42 INFO - Using env: {'DISPLAY': ':0', 08:21:42 INFO - 'HOME': '/home/cltbld', 08:21:42 INFO - 'LANG': 'en_US.UTF-8', 08:21:42 INFO - 'LANGUAGE': 'en_US:en', 08:21:42 INFO - 'LOGNAME': 'cltbld', 08:21:42 INFO - 'MAIL': '/var/mail/cltbld', 08:21:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:42 INFO - 'MOZ_NO_REMOTE': '1', 08:21:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:42 INFO - 'NO_EM_RESTART': '1', 08:21:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:42 INFO - 'PWD': '/builds/slave/test', 08:21:42 INFO - 'SHELL': '/bin/bash', 08:21:42 INFO - 'SHLVL': '1', 08:21:42 INFO - 'TERM': 'linux', 08:21:42 INFO - 'TMOUT': '86400', 08:21:42 INFO - 'USER': 'cltbld', 08:21:42 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', 08:21:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:42 INFO - '_': '/tools/buildbot/bin/python'} 08:21:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:42 INFO - Downloading/unpacking psutil>=3.1.1 08:21:42 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 08:21:42 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 08:21:42 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 08:21:42 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 08:21:42 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 08:21:42 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 08:21:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 08:21:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:44 INFO - Installing collected packages: psutil 08:21:44 INFO - Running setup.py install for psutil 08:21:45 INFO - building 'psutil._psutil_linux' extension 08:21:45 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 08:21:45 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 08:21:45 INFO - building 'psutil._psutil_posix' extension 08:21:45 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 08:21:45 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 08:21:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 08:21:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 08:21:45 INFO - Successfully installed psutil 08:21:45 INFO - Cleaning up... 08:21:45 INFO - Return code: 0 08:21:45 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 08:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:45 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 0xd8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3b0>, '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 0x104d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d740>, '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': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', '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 08:21:45 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 08:21:45 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 08:21:45 INFO - Using env: {'DISPLAY': ':0', 08:21:45 INFO - 'HOME': '/home/cltbld', 08:21:45 INFO - 'LANG': 'en_US.UTF-8', 08:21:45 INFO - 'LANGUAGE': 'en_US:en', 08:21:45 INFO - 'LOGNAME': 'cltbld', 08:21:45 INFO - 'MAIL': '/var/mail/cltbld', 08:21:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:45 INFO - 'MOZ_NO_REMOTE': '1', 08:21:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:45 INFO - 'NO_EM_RESTART': '1', 08:21:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:45 INFO - 'PWD': '/builds/slave/test', 08:21:45 INFO - 'SHELL': '/bin/bash', 08:21:45 INFO - 'SHLVL': '1', 08:21:45 INFO - 'TERM': 'linux', 08:21:45 INFO - 'TMOUT': '86400', 08:21:45 INFO - 'USER': 'cltbld', 08:21:45 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', 08:21:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:45 INFO - '_': '/tools/buildbot/bin/python'} 08:21:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:45 INFO - Downloading/unpacking mozsystemmonitor==0.3 08:21:45 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 08:21:45 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 08:21:45 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 08:21:45 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 08:21:45 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 08:21:45 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 08:21:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 08:21:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 08:21:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 08:21:47 INFO - Installing collected packages: mozsystemmonitor 08:21:47 INFO - Running setup.py install for mozsystemmonitor 08:21:47 INFO - Successfully installed mozsystemmonitor 08:21:47 INFO - Cleaning up... 08:21:47 INFO - Return code: 0 08:21:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 08:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3b0>, '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 0x104d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d740>, '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': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', '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 08:21:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 08:21:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 08:21:47 INFO - Using env: {'DISPLAY': ':0', 08:21:47 INFO - 'HOME': '/home/cltbld', 08:21:47 INFO - 'LANG': 'en_US.UTF-8', 08:21:47 INFO - 'LANGUAGE': 'en_US:en', 08:21:47 INFO - 'LOGNAME': 'cltbld', 08:21:47 INFO - 'MAIL': '/var/mail/cltbld', 08:21:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:47 INFO - 'MOZ_NO_REMOTE': '1', 08:21:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:47 INFO - 'NO_EM_RESTART': '1', 08:21:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:47 INFO - 'PWD': '/builds/slave/test', 08:21:47 INFO - 'SHELL': '/bin/bash', 08:21:47 INFO - 'SHLVL': '1', 08:21:47 INFO - 'TERM': 'linux', 08:21:47 INFO - 'TMOUT': '86400', 08:21:47 INFO - 'USER': 'cltbld', 08:21:47 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', 08:21:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:47 INFO - '_': '/tools/buildbot/bin/python'} 08:21:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:48 INFO - Downloading/unpacking jsonschema==2.5.1 08:21:48 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 08:21:48 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 08:21:48 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 08:21:48 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 08:21:48 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 08:21:48 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 08:21:49 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 08:21:49 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 08:21:49 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 08:21:49 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 08:21:49 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 08:21:49 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 08:21:49 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 08:21:49 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 08:21:50 INFO - Downloading functools32-3.2.3-2.tar.gz 08:21:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 08:21:50 INFO - warning: no files found matching '*.txt' 08:21:50 INFO - no previously-included directories found matching 'build' 08:21:50 INFO - no previously-included directories found matching 'dist' 08:21:50 INFO - no previously-included directories found matching '.git*' 08:21:50 INFO - Installing collected packages: jsonschema, functools32 08:21:50 INFO - Running setup.py install for functools32 08:21:50 INFO - warning: no files found matching '*.txt' 08:21:50 INFO - no previously-included directories found matching 'build' 08:21:50 INFO - no previously-included directories found matching 'dist' 08:21:50 INFO - no previously-included directories found matching '.git*' 08:21:50 INFO - Successfully installed jsonschema functools32 08:21:50 INFO - Cleaning up... 08:21:50 INFO - Return code: 0 08:21:50 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:50 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xd8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3b0>, '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 0x104d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d740>, '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': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', '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 08:21:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 08:21:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 08:21:50 INFO - Using env: {'DISPLAY': ':0', 08:21:50 INFO - 'HOME': '/home/cltbld', 08:21:50 INFO - 'LANG': 'en_US.UTF-8', 08:21:50 INFO - 'LANGUAGE': 'en_US:en', 08:21:50 INFO - 'LOGNAME': 'cltbld', 08:21:50 INFO - 'MAIL': '/var/mail/cltbld', 08:21:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:50 INFO - 'MOZ_NO_REMOTE': '1', 08:21:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:50 INFO - 'NO_EM_RESTART': '1', 08:21:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:50 INFO - 'PWD': '/builds/slave/test', 08:21:50 INFO - 'SHELL': '/bin/bash', 08:21:50 INFO - 'SHLVL': '1', 08:21:50 INFO - 'TERM': 'linux', 08:21:50 INFO - 'TMOUT': '86400', 08:21:50 INFO - 'USER': 'cltbld', 08:21:50 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', 08:21:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:50 INFO - '_': '/tools/buildbot/bin/python'} 08:21:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:50 INFO - Downloading/unpacking blobuploader==1.2.4 08:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:52 INFO - Downloading blobuploader-1.2.4.tar.gz 08:21:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 08:21:52 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 08:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 08:21:53 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 08:21:53 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 08:21:53 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 08:21:53 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 08:21:53 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 08:21:53 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 08:21:53 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 08:21:53 INFO - Downloading docopt-0.6.1.tar.gz 08:21:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 08:21:53 INFO - Installing collected packages: blobuploader, requests, docopt 08:21:53 INFO - Running setup.py install for blobuploader 08:21:53 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 08:21:53 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 08:21:53 INFO - Running setup.py install for requests 08:21:54 INFO - Running setup.py install for docopt 08:21:54 INFO - Successfully installed blobuploader requests docopt 08:21:54 INFO - Cleaning up... 08:21:54 INFO - Return code: 0 08:21:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:21:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:54 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 0xd8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3b0>, '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 0x104d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d740>, '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': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', '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 08:21:54 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 08:21:54 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 08:21:54 INFO - Using env: {'DISPLAY': ':0', 08:21:54 INFO - 'HOME': '/home/cltbld', 08:21:54 INFO - 'LANG': 'en_US.UTF-8', 08:21:54 INFO - 'LANGUAGE': 'en_US:en', 08:21:54 INFO - 'LOGNAME': 'cltbld', 08:21:54 INFO - 'MAIL': '/var/mail/cltbld', 08:21:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:54 INFO - 'MOZ_NO_REMOTE': '1', 08:21:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:54 INFO - 'NO_EM_RESTART': '1', 08:21:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:54 INFO - 'PWD': '/builds/slave/test', 08:21:54 INFO - 'SHELL': '/bin/bash', 08:21:54 INFO - 'SHLVL': '1', 08:21:54 INFO - 'TERM': 'linux', 08:21:54 INFO - 'TMOUT': '86400', 08:21:54 INFO - 'USER': 'cltbld', 08:21:54 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', 08:21:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:54 INFO - '_': '/tools/buildbot/bin/python'} 08:21:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:54 INFO - Running setup.py (path:/tmp/pip-BQmBS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:54 INFO - Running setup.py (path:/tmp/pip-3H_eWN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:54 INFO - Running setup.py (path:/tmp/pip-tYHNnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:54 INFO - Running setup.py (path:/tmp/pip-n76HZz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:54 INFO - Running setup.py (path:/tmp/pip-U_RP2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:54 INFO - Running setup.py (path:/tmp/pip-20MQCq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:55 INFO - Running setup.py (path:/tmp/pip-fFgYu7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:55 INFO - Running setup.py (path:/tmp/pip-TJD6dF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:55 INFO - Running setup.py (path:/tmp/pip-tAooCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:55 INFO - Running setup.py (path:/tmp/pip-i0kVKf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:55 INFO - Running setup.py (path:/tmp/pip-0PhOPM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:55 INFO - Running setup.py (path:/tmp/pip-NNE2pX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:55 INFO - Running setup.py (path:/tmp/pip-KJn03_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:55 INFO - Running setup.py (path:/tmp/pip-I7fYOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:55 INFO - Running setup.py (path:/tmp/pip-YemO5s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:55 INFO - Running setup.py (path:/tmp/pip-cR07HQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:55 INFO - Running setup.py (path:/tmp/pip-Dv81o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 08:21:55 INFO - Running setup.py install for manifestparser 08:21:55 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 08:21:55 INFO - Running setup.py install for mozcrash 08:21:56 INFO - Running setup.py install for mozdebug 08:21:56 INFO - Running setup.py install for mozdevice 08:21:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 08:21:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 08:21:56 INFO - Running setup.py install for mozfile 08:21:56 INFO - Running setup.py install for mozhttpd 08:21:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 08:21:56 INFO - Running setup.py install for mozinfo 08:21:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 08:21:56 INFO - Running setup.py install for mozInstall 08:21:56 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 08:21:56 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 08:21:56 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 08:21:56 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 08:21:56 INFO - Running setup.py install for mozleak 08:21:56 INFO - Running setup.py install for mozlog 08:21:56 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 08:21:56 INFO - Running setup.py install for moznetwork 08:21:56 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 08:21:56 INFO - Running setup.py install for mozprocess 08:21:57 INFO - Running setup.py install for mozprofile 08:21:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 08:21:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 08:21:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 08:21:57 INFO - Running setup.py install for mozrunner 08:21:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 08:21:57 INFO - Running setup.py install for mozscreenshot 08:21:57 INFO - Running setup.py install for moztest 08:21:57 INFO - Running setup.py install for mozversion 08:21:57 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 08:21:57 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 08:21:57 INFO - Cleaning up... 08:21:57 INFO - Return code: 0 08:21:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:21: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')]} 08:21:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:21:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21: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')]} 08:21:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:21:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:21:57 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 0xd8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3b0>, '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 0x104d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d740>, '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': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', '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 08:21:57 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 08:21:57 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 08:21:57 INFO - Using env: {'DISPLAY': ':0', 08:21:57 INFO - 'HOME': '/home/cltbld', 08:21:57 INFO - 'LANG': 'en_US.UTF-8', 08:21:57 INFO - 'LANGUAGE': 'en_US:en', 08:21:57 INFO - 'LOGNAME': 'cltbld', 08:21:57 INFO - 'MAIL': '/var/mail/cltbld', 08:21:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:21:57 INFO - 'MOZ_NO_REMOTE': '1', 08:21:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:21:57 INFO - 'NO_EM_RESTART': '1', 08:21:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:21:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:21:57 INFO - 'PWD': '/builds/slave/test', 08:21:57 INFO - 'SHELL': '/bin/bash', 08:21:57 INFO - 'SHLVL': '1', 08:21:57 INFO - 'TERM': 'linux', 08:21:57 INFO - 'TMOUT': '86400', 08:21:57 INFO - 'USER': 'cltbld', 08:21:57 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', 08:21:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:21:57 INFO - '_': '/tools/buildbot/bin/python'} 08:21:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 08:21:57 INFO - Running setup.py (path:/tmp/pip-8jB4X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 08:21:57 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)) 08:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 08:21:57 INFO - Running setup.py (path:/tmp/pip-AcCsEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 08:21:57 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)) 08:21:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 08:21:57 INFO - Running setup.py (path:/tmp/pip-by2mBe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 08:21:58 INFO - Running setup.py (path:/tmp/pip-whIN2l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 08:21:58 INFO - Running setup.py (path:/tmp/pip-PaK_Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 08:21:58 INFO - Running setup.py (path:/tmp/pip-t2w6Ud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 08:21:58 INFO - Running setup.py (path:/tmp/pip-n9PhRy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 08:21:58 INFO - Running setup.py (path:/tmp/pip-0uK9Zc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 08:21:58 INFO - Running setup.py (path:/tmp/pip-E7tOiS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 08:21:58 INFO - Running setup.py (path:/tmp/pip-_F8DAp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 08:21:58 INFO - Running setup.py (path:/tmp/pip-gcXFSp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 08:21:58 INFO - Running setup.py (path:/tmp/pip-1vTCto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 08:21:58 INFO - Running setup.py (path:/tmp/pip-LM6pKw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 08:21:58 INFO - Running setup.py (path:/tmp/pip-XUoGtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:58 INFO - Running setup.py (path:/tmp/pip-oFo4Z1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 08:21:58 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)) 08:21:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 08:21:58 INFO - Running setup.py (path:/tmp/pip-w7TSZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 08:21:59 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)) 08:21:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 08:21:59 INFO - Running setup.py (path:/tmp/pip-Ut4Ydl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 08:21:59 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)) 08:21:59 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)) 08:21:59 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)) 08:21:59 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)) 08:21:59 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)) 08:21:59 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)) 08:21:59 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 08:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:21:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 08:21:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 08:21:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 08:22:00 INFO - Downloading blessings-1.6.tar.gz 08:22:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 08:22:01 INFO - Installing collected packages: blessings 08:22:01 INFO - Running setup.py install for blessings 08:22:01 INFO - Successfully installed blessings 08:22:01 INFO - Cleaning up... 08:22:01 INFO - Return code: 0 08:22:01 INFO - Done creating virtualenv /builds/slave/test/build/venv. 08:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:01 INFO - Reading from file tmpfile_stdout 08:22:01 INFO - Current package versions: 08:22:01 INFO - argparse == 1.2.1 08:22:01 INFO - blessings == 1.6 08:22:01 INFO - blobuploader == 1.2.4 08:22:01 INFO - docopt == 0.6.1 08:22:01 INFO - functools32 == 3.2.3-2 08:22:01 INFO - jsonschema == 2.5.1 08:22:01 INFO - manifestparser == 1.1 08:22:01 INFO - mozInstall == 1.12 08:22:01 INFO - mozcrash == 0.17 08:22:01 INFO - mozdebug == 0.1 08:22:01 INFO - mozdevice == 0.48 08:22:01 INFO - mozfile == 1.2 08:22:01 INFO - mozhttpd == 0.7 08:22:01 INFO - mozinfo == 0.9 08:22:01 INFO - mozleak == 0.1 08:22:01 INFO - mozlog == 3.2 08:22:01 INFO - moznetwork == 0.27 08:22:01 INFO - mozprocess == 0.22 08:22:01 INFO - mozprofile == 0.28 08:22:01 INFO - mozrunner == 6.11 08:22:01 INFO - mozscreenshot == 0.1 08:22:01 INFO - mozsystemmonitor == 0.3 08:22:01 INFO - moztest == 0.7 08:22:01 INFO - mozversion == 1.4 08:22:01 INFO - psutil == 3.1.1 08:22:01 INFO - requests == 1.2.3 08:22:01 INFO - wsgiref == 0.1.2 08:22:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 08:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:01 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 0xd8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3b0>, '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 0x104d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d740>, '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': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', '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 08:22:01 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 08:22:01 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 08:22:01 INFO - Using env: {'DISPLAY': ':0', 08:22:01 INFO - 'HOME': '/home/cltbld', 08:22:01 INFO - 'LANG': 'en_US.UTF-8', 08:22:01 INFO - 'LANGUAGE': 'en_US:en', 08:22:01 INFO - 'LOGNAME': 'cltbld', 08:22:01 INFO - 'MAIL': '/var/mail/cltbld', 08:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:01 INFO - 'MOZ_NO_REMOTE': '1', 08:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:01 INFO - 'NO_EM_RESTART': '1', 08:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:01 INFO - 'PWD': '/builds/slave/test', 08:22:01 INFO - 'SHELL': '/bin/bash', 08:22:01 INFO - 'SHLVL': '1', 08:22:01 INFO - 'TERM': 'linux', 08:22:01 INFO - 'TMOUT': '86400', 08:22:01 INFO - 'USER': 'cltbld', 08:22:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', 08:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:01 INFO - '_': '/tools/buildbot/bin/python'} 08:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:01 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)) 08:22:01 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)) 08:22:01 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)) 08:22:01 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)) 08:22:01 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)) 08:22:01 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)) 08:22:01 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)) 08:22:01 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)) 08:22:01 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)) 08:22:01 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)) 08:22:01 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)) 08:22:01 INFO - Cleaning up... 08:22:01 INFO - Return code: 0 08:22:01 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 08:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 08:22:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 08:22:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 08:22:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xd8d030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xef08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104e180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3b0>, '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 0x104d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d740>, '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': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', '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 08:22:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 08:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 08:22:01 INFO - Using env: {'DISPLAY': ':0', 08:22:01 INFO - 'HOME': '/home/cltbld', 08:22:01 INFO - 'LANG': 'en_US.UTF-8', 08:22:01 INFO - 'LANGUAGE': 'en_US:en', 08:22:01 INFO - 'LOGNAME': 'cltbld', 08:22:01 INFO - 'MAIL': '/var/mail/cltbld', 08:22:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:01 INFO - 'MOZ_NO_REMOTE': '1', 08:22:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:01 INFO - 'NO_EM_RESTART': '1', 08:22:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:01 INFO - 'PWD': '/builds/slave/test', 08:22:01 INFO - 'SHELL': '/bin/bash', 08:22:01 INFO - 'SHLVL': '1', 08:22:01 INFO - 'TERM': 'linux', 08:22:01 INFO - 'TMOUT': '86400', 08:22:01 INFO - 'USER': 'cltbld', 08:22:01 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', 08:22:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:01 INFO - '_': '/tools/buildbot/bin/python'} 08:22:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 08:22:01 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 08:22:01 INFO - Cleaning up... 08:22:01 INFO - Return code: 0 08:22:01 INFO - Running post-action listener: _resource_record_post_action 08:22:01 INFO - Running post-action listener: _start_resource_monitoring 08:22:01 INFO - Starting resource monitoring. 08:22:01 INFO - ##### 08:22:01 INFO - ##### Finished create-virtualenv step (success) 08:22:01 INFO - ##### 08:22:01 INFO - ##### 08:22:01 INFO - ##### Running install step. 08:22:01 INFO - ##### 08:22:01 INFO - Running pre-action listener: _resource_record_pre_action 08:22:01 INFO - Running main action method: install 08:22:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 08:22:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 08:22:02 INFO - Reading from file tmpfile_stdout 08:22:02 INFO - Detecting whether we're running mozinstall >=1.0... 08:22:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 08:22:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 08:22:02 INFO - Reading from file tmpfile_stdout 08:22:02 INFO - Output received: 08:22:02 INFO - Usage: mozinstall [options] installer 08:22:02 INFO - Options: 08:22:02 INFO - -h, --help show this help message and exit 08:22:02 INFO - -d DEST, --destination=DEST 08:22:02 INFO - Directory to install application into. [default: 08:22:02 INFO - "/builds/slave/test"] 08:22:02 INFO - --app=APP Application being installed. [default: firefox] 08:22:02 INFO - mkdir: /builds/slave/test/build/application 08:22:02 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'] 08:22:02 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 08:22:25 INFO - Reading from file tmpfile_stdout 08:22:27 INFO - Output received: 08:22:27 INFO - /builds/slave/test/build/application/firefox/firefox 08:22:27 INFO - Running post-action listener: _resource_record_post_action 08:22:27 INFO - ##### 08:22:27 INFO - ##### Finished install step (success) 08:22:27 INFO - ##### 08:22:27 INFO - ##### 08:22:27 INFO - ##### Running run-tests step. 08:22:27 INFO - ##### 08:22:27 INFO - Running pre-action listener: _resource_record_pre_action 08:22:27 INFO - Running main action method: run_tests 08:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 08:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 08:22:27 INFO - Python 2.7.3 08:22:27 INFO - Return code: 0 08:22:27 INFO - grabbing minidump binary from tooltool 08:22:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 08:22:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104c3b0>, '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 0x104d2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 08:22:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 08:22:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 08:22:27 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 08:22:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 08:22:27 INFO - Return code: 0 08:22:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 08:22:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 08:22:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 08:22:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 08:22:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 08:22:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 08:22:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --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 08:22:27 INFO - Using env: {'DISPLAY': ':0', 08:22:27 INFO - 'HOME': '/home/cltbld', 08:22:27 INFO - 'LANG': 'en_US.UTF-8', 08:22:27 INFO - 'LANGUAGE': 'en_US:en', 08:22:27 INFO - 'LOGNAME': 'cltbld', 08:22:27 INFO - 'MAIL': '/var/mail/cltbld', 08:22:27 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 08:22:27 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 08:22:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 08:22:27 INFO - 'MOZ_NO_REMOTE': '1', 08:22:27 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 08:22:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 08:22:27 INFO - 'NO_EM_RESTART': '1', 08:22:27 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 08:22:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 08:22:27 INFO - 'PWD': '/builds/slave/test', 08:22:27 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 08:22:27 INFO - 'SHELL': '/bin/bash', 08:22:27 INFO - 'SHLVL': '1', 08:22:27 INFO - 'TERM': 'linux', 08:22:27 INFO - 'TMOUT': '86400', 08:22:27 INFO - 'USER': 'cltbld', 08:22:27 INFO - 'XDG_SESSION_COOKIE': '33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337', 08:22:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 08:22:27 INFO - '_': '/tools/buildbot/bin/python'} 08:22:27 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--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 08:22:28 INFO - mozversion application_buildid: 20160704074125 08:22:28 INFO - mozversion application_changeset: 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 08:22:28 INFO - mozversion application_display_name: Nightly 08:22:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 08:22:28 INFO - mozversion application_name: Firefox 08:22:28 INFO - mozversion application_remotingname: firefox 08:22:28 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 08:22:28 INFO - mozversion application_vendor: Mozilla 08:22:28 INFO - mozversion application_version: 50.0a1 08:22:28 INFO - mozversion platform_buildid: 20160704074125 08:22:28 INFO - mozversion platform_changeset: 02f60237d69a4061c0f3c499239b7c13a9c4eeb3 08:22:28 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 08:22:28 INFO - mozversion platform_version: 50.0a1 08:22:28 INFO - using testdate: 1467645748 08:22:28 INFO - actual date: 1467645748 08:22:28 INFO - starting webserver on 'localhost:47579' 08:22:28 INFO - SUITE-START | Running 2 tests 08:22:28 INFO - TEST-START | dromaeo_css 08:22:28 INFO - operating with platform_type : linux_ 08:22:28 INFO - Initialising browser for dromaeo_css test... 08:22:28 INFO - TEST-INFO | started process 20886 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVwvK2w/profile http://localhost:47579/getInfo.html) 08:22:34 INFO - PROCESS | 20886 | __metrics Screen width/height:1600/1200 08:22:34 INFO - PROCESS | 20886 | colorDepth:24 08:22:34 INFO - PROCESS | 20886 | Browser inner width/height: 1024/697 08:22:34 INFO - PROCESS | 20886 | __metrics 08:22:36 INFO - PROCESS | 20886 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:22:37 INFO - TEST-INFO | 20886: exit 0 08:22:37 INFO - Browser initialized. 08:22:37 INFO - Running cycle 1/1 for dromaeo_css test... 08:22:37 INFO - TEST-INFO | started process 20969 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpVwvK2w/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:22:49 INFO - PROCESS | 20969 | RSS: Main: 158285824 08:22:49 INFO - PROCESS | 20969 | 08:23:40 INFO - PROCESS | 20969 | 1467645820850 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 08:25:54 INFO - PROCESS | 20969 | Cycle 1(1): loaded http://localhost:47579/tests/dromaeo/cssquery-dojo.html (next: http://localhost:47579/tests/dromaeo/cssquery-ext.html) 08:25:56 INFO - PROCESS | 20969 | RSS: Main: 270561280 08:25:56 INFO - PROCESS | 20969 | 08:28:58 INFO - PROCESS | 20969 | Cycle 1(1): loaded http://localhost:47579/tests/dromaeo/cssquery-ext.html (next: http://localhost:47579/tests/dromaeo/cssquery-jquery.html) 08:28:59 INFO - PROCESS | 20969 | RSS: Main: 241115136 08:28:59 INFO - PROCESS | 20969 | 08:32:01 INFO - PROCESS | 20969 | Cycle 1(1): loaded http://localhost:47579/tests/dromaeo/cssquery-jquery.html (next: http://localhost:47579/tests/dromaeo/cssquery-mootools.html) 08:32:02 INFO - PROCESS | 20969 | RSS: Main: 244023296 08:32:02 INFO - PROCESS | 20969 | 08:35:04 INFO - PROCESS | 20969 | Cycle 1(1): loaded http://localhost:47579/tests/dromaeo/cssquery-mootools.html (next: http://localhost:47579/tests/dromaeo/cssquery-prototype.html) 08:35:04 INFO - PROCESS | 20969 | RSS: Main: 238759936 08:35:04 INFO - PROCESS | 20969 | 08:38:07 INFO - PROCESS | 20969 | Cycle 1(1): loaded http://localhost:47579/tests/dromaeo/cssquery-prototype.html (next: http://localhost:47579/tests/dromaeo/cssquery-yui.html) 08:38:08 INFO - PROCESS | 20969 | RSS: Main: 217071616 08:38:08 INFO - PROCESS | 20969 | 08:41:11 INFO - PROCESS | 20969 | Cycle 1(1): loaded http://localhost:47579/tests/dromaeo/cssquery-yui.html (next: http://localhost:47579/tests/dromaeo/cssquery-dojo.html) 08:41:11 INFO - PROCESS | 20969 | RSS: Main: 293158912 08:41:11 INFO - PROCESS | 20969 | 08:41:11 INFO - PROCESS | 20969 | __start_tp_report 08:41:11 INFO - PROCESS | 20969 | _x_x_mozilla_page_load 08:41:11 INFO - PROCESS | 20969 | _x_x_mozilla_page_load_details 08:41:11 INFO - PROCESS | 20969 | |i|pagename|runs| 08:41:11 INFO - PROCESS | 20969 | |0;dojo.html;2593.364625666712;2600.258926206031;2600.8309459885104;2635.907743228986;2642.39224978255;4625.745583992879;4671.9766401168035;4697.8120875165;4698.577128058474;4722.220833562458;4668.18306796311;4678.53214678532;4687.90624187516;4721.457032441271;4738.620910327174;4291.3777502262155;4293.313069908815;4327.372530983005;4352.869413917571;4369.126174765044;4425.291953287475;4489.124620698965;4500.932486012696;4521.5930566249035;4525.411696479469;4270.338097594878;4318.157959197958;4327.848525301631;4390.319500477431;4425.1149770045795;4279.614834664895;4301;4329.805158767832;4333.804978775963;4336.4145840311785;4321.503027151886;4331.6534677225745;4374.34384842273;4377.824887004516;4416.514183439819;4805.495422980606;4817.181079216542;4831.637627177941;4834.395700537433;4845.370101886732;4959.107360675077;5040.42035165957;5103.18349064148;5107.642465027449;5116.386033675945;5109.310243117169;5128.487151284841;5172.870678233036;5177.042247184283;5183.766730497136;4620.976895115503;4784.091022705745;4824.541668541483;4830.154722923509;4843.903121937541;5155.072087024297;5174.223866420067;5226.268322434862;5247.868803279948;5285.947140528546;5031.119554078095;5038.521340472649;5082.517160869711;5083.110455670317;5084.51697088776;4958.6776859504735;5037.773300201499;5114.002769459994;5141.3830340358645;5168.3797944246935;5046.21783623539;5071.03650306448;5093.18509038552;5134.820281290137;5139.897202055938;5069.822556210589;5081.034603425337;5088.0078384714625;5089.592832573459;5138.100832354397;4251.4685664291965;4284.10033892886;4398.890027749268;4416.873697207256;4451.465824101064;3762.266358060152;3787.14789172434;3802.3155831950517;3811.2377524495214;3840.519935008124;4378.408914796525;4380.145871555016;4387.341898715218;4388.166248412856;4430.091831174602;4972.477889821589;4996.400431948189;5104.464031276737;5104.9489505104475;5141.562967147759;4330.17726631939;4335.891602709894;4344.022594916119;4382.474103107584;4383.079553293844;4536.364908912755;4561.429821272341;4567.611753000966;4570.657200709894;4618.237990731492;4639.721616702874;4702.177119004229;4711.363965864564;4717.4339079311385;4741.668083234141;5072.949270507248;5093.592512598909;5093.847184584469;5096.05722941257;5139.203423469368;4764.023375208005;4766.761661916821;4766.833160839493;4769;4796.928046079382;4939.160342741814;5001.824936127218;5020.196768517166;5026.271190677405;5069.138246498031;5120.897582048413;5139;5142.614303927146;5146.4338922717725;5152.4847515248175;5003.924941125813;5005.024020316004;5009.323741294878;5010.148274793367;5046.57104146137;4839.2983017462975;4860.343853579721;4904.386951631046;4917.901641967069;4922.704637721748;4826.300186473012;4839.2983017462975;4862.805487780449;4883.560479556857;4895.853124406273;4866.95133048665;4939.382577177853;4943.752812359439;4944.406671199479;4946;4857.149998750134;4875.171220892527;4884.462709102067;4926.926096108489;4931.901361972668 08:41:11 INFO - PROCESS | 20969 | |1;ext.html;580.2253990922119;583.399098928104;595.4373117404052;609.4301827791015;623.4077626255059;28170.718292817066;43713;44724.329135063;44834.32748508767;45157.77421112898;41772.16455670885;42014;42146.7892660537;42163.78918105405;42177;7762.805929851743;7913.643886025114;7914.089879663826;7932.643031063616;8041.155678653716;7914.445988780788;7996.920030799704;8003.719869804558;8008.199180082003;8009.199080092002;8037.517748935083;8054.073781515113;8090.514569125842;8093;8099.757007289791;8018.719344822933;8060.113387527367;8064.959675201645;8066.677332906676;8072.354211663082;7828.882566761503;7924.286814186693;7931.603419828985;7934.365250779923;7942.364610831178;38673;38999;39008.80495597532;39053.804730976444;39131.217375652326;2973.2418233350572;3032.9545056824163;3196.888108916177;3220.0500852248642;3537.7877327360443;30031.849840750656;30163.245918851986;30346.848265758752;30956.226094347596;31269.218269543217;3412.0224141630424;3414.834987673055;3424.2124311408265;3424.332255210235;3511.490833829106;257233;260952;261060;261109;261398;32204.19489512734;52524.212136817216;53714.46285537095;53719;53737.731311343196;32630.83684581562;34262.14344641354;34490.82754586211;34506.82746586301;34557.30885382278;13928;14085.647858803406;14090.365933533016;14091.506797262047;14104.929475352557;11463.484143213574;11464.885351146548;11495.597654082067;11498.827517587242;11520.654380368602;7972;7985.441019128722;7993.480423772437;8045.396595255379;8076.313513351431;3027.818330900109;3043.5586839908087;3058.1131471873355;3073.139520934142;3103.20868178613;861.3869219510236;866.6186877773886;876.5354362188051;1004.8542961270575;1006.9980369532362;28587.57118643222;28906.855465722536;28926;29425.55861662077;29511;804.8430556041516;962.7352478068588;974.1865542272282;986.4475893499663;1028.6091285311534;14364.35360408784;15056.698866022618;15091.924540377227;15187;15317.310721017358;402436;404847;407537;407819;408006;50344.24483632748;50723;50761;50838.23742643863;50841;1055.9524821383056;1126.4649291586595;1153.7000379901285;1175.905927525813;1204.1570900369777;28347.716522834507;29319.706802931698;29614;29768.255793605334;30194.547081793353;42144.78927605342;42167.789161053995;42619.14761704687;42720.35919461273;42788.35817462678;325931;326604.30280637904;326658;326841;326887;22611.886940565193;23308;24653.876730616234;25189.87405062963;25244.49511009806;41130.38304425376;41221;41357.79321103496;41741.37387939244;42415.57584424116;36518;36637.63362366342;36793;37003;37183.6281637191;36684.633153668125;36760.81619591885;37015.629843701216;37244.81377593095;37307.440388393654;35045;35958;36474;36735.81632091929;36857.63142368542;31765.205869852514;32392.352152956337;32561.511577325884;32628.83685581557;32738.672613274513;25226.747732523174;25373.111941081974;25423.23730288094;25517.489650207262;25764.61353079743 08:41:11 INFO - PROCESS | 20969 | |2;jquery.html;346.1968233697822;361.62210490037916;361.7503922293617;367.41764303578844;373.94203898395756;12664.11351205416;16883.24025418856;17885.195166217534;18182.636347273048;19899.30352437665;16371.836281637181;16917.49247522576;18106.45680629583;18109.366172183974;18146;5139.640225184229;5404.0272750905015;5409.594280428964;5409.891802163955;5412.052890744124;3785.867494637688;5215.061288967984;5868.471837534621;6200.4729597984;6202.658853763041;6190.226221722285;6190.3190649028575;6192.473639740605;6217.160683307741;6235.314115447297;6451.387118223761;6782.355676210752;6817.0796942412635;6830.316968303179;6834.863302733942;6462.1276127723095;6600.174978127734;6604.768833090819;6613.272540020594;6613.801585952429;22325;23074.192403265806;24009.159679411136;24146.154884578955;24187.153449629353;1775.334249656379;1897.9240830366768;1937.3994061840874;1948.6979518174705;2049.2008116834445;13572.864271357259;14323.928380358137;14570.271486425743;14842.183679897602;15123.621909452351;1813.945581632553;1901.876378035437;1964.2339487599847;1965.9901700491548;1989.8905560194185;80247.5987620064;84354.57822710909;84680.57659711724;87062;87077.56461217717;14155.363008664635;14386.903362332454;16710.4151354702;16752.329906803592;16975.74536381955;11421.543138274375;28522.572161417596;28620.9965302431;28635.14094577166;28713.85643071813;6981.197162326296;7296.233895440902;7332.450066245053;7393.667284972189;7447.962760186165;7429.405647548183;7433.182349941502;7523.774286771406;7586.772396828104;7595.848083038309;3768.340540405418;3813.771173729585;3846.2307538492414;3904.2821158690085;3980.920381592352;1797.667431525172;1824.206470185447;1857.9502581041668;1869.7195420687005;1929.0644037641732;815.1685281013333;865.9870101948476;916.5234078279258;920.8618707193974;934.6822080492665;17033.659326813395;17173.31306747716;17542.21060052301;17974.91012544929;18038.188281527102;839.9664013439516;845.3068483843313;919.995400023009;932.0845662164318;961.3606951377255;9437.292203084797;9978.650747223812;10017.754237708496;10029.448380339152;10127.392356458637;397090;402366;421299;421940;422684;80687;80960;81048.59475702702;82125;82249.58875205586;856.5417501636595;885.4377470306273;886.7916039730787;888.1340692824444;889.0664801957919;12438.564650237198;15576.610584735472;15620;16479.83520164783;16680.582985425463;29648.703512965458;34609.48085778665;36738.8163059183;37831.62168378281;37839.24321513609;45426.772866135456;49476;50331.24503132529;50938.74530627323;52052.47947520476;7460.552366858006;7739.264769846855;7804.2585954334245;7868.84262314762;7903.9209607903185;10370.481475926324;11282.774344513227;12097.274163550215;12106.152569320064;12508.562200322946;10605.734856628646;10819.513121909376;10839.783204335712;10968.780624387628;11053.944730276296;10538.315009524356;10676.572937082741;10789;10996.230263881771;11063.723406914569;10914.23600347968;11065.391403472886;11067.72330691739;11086.889131108586;11237.831432528355;7645.350145237717;7814.492058016211;7847.8038049046945;8012.919870801217;8106.675732970851;10712.089472394933;10779.407132607781;10789.62236321725;10855.40295283767;10868 08:41:11 INFO - PROCESS | 20969 | |3;mootools.html;1373.162370953718;1404.6979899321643;1478.1500637133645;1650.6286085630727;1697.3041053168197;7537.660805263763;7943.165967573408;8005.279524842763;8019.5188288702575;8028.157043510435;6750.831229219272;7365.11618605768;7608.087029556447;7627.542347459156;7921.881171782428;2150.8924553772326;2178.0525471419905;2180.7928246816527;2183.8689678619253;2188.803007729304;2199.25225423356;2208.293346129239;2246.2475070851283;2247.685324054634;2248.033345661365;1907.2943011085918;2078.6050650376455;2149.387424583994;2158.417227348615;2180.084364566878;2177.2270843850365;2212.811910987568;2216.024949022441;2232.2521955145044;2249.156566287642;2199.164317559333;2199.417154454071;2204.272590045281;2204.900779464928;2205.9669104963436;7790.532568045879;7908.367330613537;7910.406719496061;7917.604119793988;7919.3268572170855;4545.477270113913;4662.836800711959;4673.672842900998;4675;4679.204535229019;2932.530795072778;2951.5277555591215;3011.1869795155185;3052.1759125036338;3053.2672158681758;999.8300288950895;1020.6325722739808;1022.2639699416409;1024.5850430575629;1033.2405681823852;10863.02232799044;10925.890741092568;10938.671839844817;10948.34309941406;10955.17836162291;4055.7769322686945;4159.521655009652;4317.805698743564;4319.503257125408;4326.286162783105;9214.815703685888;9248.352615316997;9299.53502324881;9309.069093090773;9335.626574937063;4547.295169248771;4626.375439315717;4643.303504474288;4647.953520464752;4650.558196971282;4211.599898009684;4252.425922500484;4252.914941701149;4257.233697934402;4304.849330273425;3663.5237419135874;3692.4276737105793;3741.401375779862;3767.2465506898184;3770.71719621024;1087.6845714742635;1182.7043239190202;1184.603157942082;1186.5431808753692;1213.8725433829497;795.5385876191795;796.2316364708084;821.2116368286512;831.9750407487785;851.0595791650261;5263.526282634504;5270.540782044763;5341.839744807662;5472.452754724496;5592.356878958972;868.6481974800216;877.3989816975393;897.6005677473462;915.844306467902;920.3879420185635;3602.2975519773395;3707.536557930259;3710.091027698177;3721.3673675475234;3783;9424.62301507932;9775.217982561378;9904.55429505674;9904.653337133166;9920.603175873028;8566.100559441293;8793.648254069894;9771.364861283993;9774.266929980138;9783.510824458748;7117.4306055515435;7317.451191160684;7518;7540.0951885772965;7554.697812087565;5253.605979551472;5307.124324486416;5482.780688772564;5484.478974497416;5507.311586051744;8851.822963540822;8964;9020.233280171258;9208.585613647268;9249.583768730288;9145;9409.247260219028;9421.434713917188;9421.764455888657;9476.810463790824;7488.588127653032;7498.437617178624;7610.124835643972;7651.081870175614;7660.846783064419;7463.104427468738;7469.14104877946;7543.434242431949;7559.811004724926;7588.924110758821;5218.373795144607;6690.531662783558;6881.552699074544;6891.27641597625;7002.544834585736;6579.17760279965;6628.767993120217;6647.567908085959;6808.5914845109455;6873.278305778022;6363.459105975859;6387.904181437375;6446.258680251643;6454.838629034311;6455.741770329134;4560.5895469407915;4630.143423466669;4668.439787225555;4727.2436410174205;4753.548412900769;4676.649251306234;4712.458067322302;4737.298871786681;4747.098051370229;4777.689450185727 08:41:11 INFO - PROCESS | 20969 | |4;prototype.html;293.4014610195202;300.55367778848404;309.58051839757127;311.18779984241115;313.9967802869831;4796.424429068512;4852.150873597116;4859.927101093477;4862.124817532843;4873.317735517026;4593.173228818811;4657.604103651185;4741.596964258042;4746.928796068053;4844.83043093491;3828.2917660232947;3839.36650452675;3864.3623802072625;3880.2821478026585;3881.126746482033;3837.906196733931;3839.232153569283;3844.1735026969195;3844.4041173618134;3860.1507668312925;3605.7656252343645;3694.353488139578;3824.827882745283;3828.272628200633;3835.9808200959096;3807.1053302473897;3818.3508803503332;3820.9426858597144;3848.557415897166;3854.2676891390547;3401.234722187513;3409.2499650076943;3410.931781364384;3427.143214196451;3427.9828600857086;4521.932171017437;4752.857414277542;4771.403574553181;4772.7613619319245;4818.71087734737;4294.441722576076;4357.999999999968;4366.812227074253;4373.518912919576;4378.627816635558;5105.310783044279;5105.566026887719;5144.56271216947;5150.253213284091;5156.303898973628;3552.7335449841366;3627.1838836261895;3635.563732352108;3638.9621811785487;3654.9817250913575;5294.955400644606;5298.225094593316;5305;5309.283246761676;5321.840344789663;3706.09200745819;3707.684846788053;3738.682212011955;3755.3240416725253;3763.1344790698295;3772.434134879735;3779.905502362463;3788.791616461066;3826.655600995868;3828.157805282833;4222.831086756495;4232.851850185229;4266.360045993064;4290.420793192879;4355;5027.366106015559;5041.2438134280155;5070.264811602297;5070.65627608684;5079.6698214615935;1217.5069097015723;1261.9621411357673;1285.4536821850863;1305.4386613756176;1307.6338625184962;878.6030211963009;884.0584777212376;900.9324300677475;902.6615019367737;908.1100521488846;4441.578050085237;4451.087527056946;4451.532589078165;4452.065066336106;4458.79289751575;5140.717260550706;5147.485251474823;5151.5621172200035;5154.175331946871;5173.456787037307;4418.204723149864;4433.827424561941;4436.201483732959;4449.57729015743;4465.59809617136;2328.860268383902;2472.5796614575565;2473.9257822265363;2484.478259565475;2484.503099380131;4267.957320426756;4312.827486900552;4315.5900189481945;4325.740455572675;4342.392065110887;4678.5496496086325;4691.976540117345;4737.9052418952115;4749.26386410107;4827.565519103297;4443.488998765119;4565.680402371802;4979.3526841510375;4980.800767969241;4981.676191047571;5285.735713214247;5288.180332048539;5295.602829787705;5297.020051290524;5303.549198318186;5239.790408383622;5248.553872920845;5261.184516399964;5278.102722537101;5290.206469029523;4717.599004084691;4919.4834542373965;4962.42932062803;4966.970148209662;4970.403551573834;3727.7576957497677;3770.132869440099;3776.905577360588;3787.4886890269463;3789.1853251551047;5060.734816295926;5288.57208553696;5302.655327403706;5308.150695888639;5317.867053323698;4730.810767569259;5078.263651770399;5083.974580127076;5086.593072554261;5098.490150984871;5028.371453568304;5077.339945807022;5088.363954505687;5094.51602097815;5112.36095488064;5019.297298378157;5040.823571174991;5041.495850414929;5055.545000949932;5057.747112644427;4853.587445067067;5116.616253781056;5126.359205099363;5126.589872810241;5139.974300128475;5013.548780609763;5034.572061374824;5035.320231768665;5047.384836852172;5048.167052436307 08:41:11 INFO - PROCESS | 20969 | |5;yui.html;614.226075145317;651.9022146677997;670.614396721885;722.9178872526137;758.5827794712908;12664.873351266484;13100.672483187926;13105.541306054267;13120.6719832004;13126.868731312685;13285.535006274782;13337.866621333784;13389.531366402178;13397.531086411978;13405.731885362287;617.9598326108811;764.8929149919015;770.1643716567517;788.1566723605715;789.3645615279697;776.2819392062348;794.3168874767695;794.3803833010232;795.3517882925427;795.8845967334732;841.2092632925062;842.7682387343499;845.6279237135672;847.588919374103;849.7280870121564;643.5559463969869;798.9400794940344;827.0406328658727;835.5070508400042;836.1095433363479;599.1521996375124;603.8822429626225;604.3714536881638;604.7550741949517;605.9606125601866;12448.315342656151;12460.003199743998;12493.312867792269;12503.187292826027;12514.31171285579;12286.447109880077;13024.804627930589;13036.478540858354;13043.630418806079;13067.281299528522;11637.301761894314;11678.883211167864;11755.05959523236;11759.412029398496;12167.209131406518;4095.651869591088;4177.206330797138;4203.390508376299;4232.386303985935;4280.379344994958;59640;60947;61542;61567.99999999955;61895.07157392688;10230.130438912627;10296.176305895511;10352.912944140908;10464.162866970624;10516.263861529773;18949.33677321287;19045.428637140907;19142.712859306845;19158.71261931072;19160.137793799313;6786.76246331376;6875.48433867462;6904.585724856524;6929.064576282138;7025.89461158083;3711.5731690855896;3720.6651401374006;3763.9059023524082;3767.7550959187565;3780.584135745066;2864.4414339203654;2935.4716151093007;2937.500624893773;2954.482965481075;2960.644722633298;504.553470178887;519.283388923291;523.0062880527029;526.8998890210925;529.2881074954181;502.52009331089454;541.8591166296791;581.5841673203595;584.4097461563852;627.3068259573197;8386.958065209636;8633.179847914438;8637.913620863837;8737.519436431057;8964.32767542424;552.9834104976857;564.1425033948376;626.5207116555838;633.6768248193455;640.4044238857907;3958.5051868516434;4268.679849011337;4400.22995975703;4426.070525189746;4498.415206023196;52412.73793631008;54428;57118.42881571131;57514.71242643844;58216;83410.16589834024;84547.5772621133;84584.57707711423;84906;85389;67034.66482667555;71039.6448017767;72824.63587682134;74384;76672;9051.230645394951;9368.859467108136;9399.389039712396;9449.102335278138;9731.61073557078;32409;42217.57782422259;43766.56233437625;44945;47731.28403073887;58374.708126459096;60792.39207607867;65447.34552654412;65926.34073659201;69099.65450172717;10538.420386878795;11262.436878156223;11619.825702614637;11654.30074195551;11848.28910265387;13039.413226404646;13298.468061277441;13424.328783560979;13444.59666209976;14692.559223223321;9073.546322683707;11108.944455277671;11142.331460112418;12062.215955962834;12415.875841241472;11166.720831979266;11815.527378904748;11838.230515016496;11944.761104777683;12614.49542018309;11547.191696581158;11967.521299148284;11971.042316614825;12344.259344439362;13267.800982985456;10551.630692925712;10631.627893023708;10864.239503234698;10914.399708016135;11018.779624407627;9969.575246579898;10514.369137851754;10730.785384292427;10784.784304313713;10918.454077296263 08:41:11 INFO - PROCESS | 20969 | __end_tp_report 08:41:11 INFO - PROCESS | 20969 | __start_cc_report 08:41:11 INFO - PROCESS | 20969 | _x_x_mozilla_cycle_collect,1044 08:41:11 INFO - PROCESS | 20969 | __end_cc_report 08:41:11 INFO - PROCESS | 20969 | __startTimestamp1467646871620__endTimestamp 08:41:11 INFO - PROCESS | 20969 | 08:41:11 INFO - PROCESS | 20969 | ------- Summary: start ------- 08:41:11 INFO - PROCESS | 20969 | Number of tests: 6 08:41:11 INFO - PROCESS | 20969 | 08:41:11 INFO - PROCESS | 20969 | [#0] dojo.html Cycles:165 Average:4699.54 Median:4831.64 stddev:499.52 (10.3%) stddev-sans-first:472.93 08:41:11 INFO - PROCESS | 20969 | Values: 2593.4 2600.3 2600.8 2635.9 2642.4 4625.7 4672.0 4697.8 4698.6 4722.2 4668.2 4678.5 4687.9 4721.5 4738.6 4291.4 4293.3 4327.4 4352.9 4369.1 4425.3 4489.1 4500.9 4521.6 4525.4 4270.3 4318.2 4327.8 4390.3 4425.1 4279.6 4301.0 4329.8 4333.8 4336.4 4321.5 4331.7 4374.3 4377.8 4416.5 4805.5 4817.2 4831.6 4834.4 4845.4 4959.1 5040.4 5103.2 5107.6 5116.4 5109.3 5128.5 5172.9 5177.0 5183.8 4621.0 4784.1 4824.5 4830.2 4843.9 5155.1 5174.2 5226.3 5247.9 5285.9 5031.1 5038.5 5082.5 5083.1 5084.5 4958.7 5037.8 5114.0 5141.4 5168.4 5046.2 5071.0 5093.2 5134.8 5139.9 5069.8 5081.0 5088.0 5089.6 5138.1 4251.5 4284.1 4398.9 4416.9 4451.5 3762.3 3787.1 3802.3 3811.2 3840.5 4378.4 4380.1 4387.3 4388.2 4430.1 4972.5 4996.4 5104.5 5104.9 5141.6 4330.2 4335.9 4344.0 4382.5 4383.1 4536.4 4561.4 4567.6 4570.7 4618.2 4639.7 4702.2 4711.4 4717.4 4741.7 5072.9 5093.6 5093.8 5096.1 5139.2 4764.0 4766.8 4766.8 4769.0 4796.9 4939.2 5001.8 5020.2 5026.3 5069.1 5120.9 5139.0 5142.6 5146.4 5152.5 5003.9 5005.0 5009.3 5010.1 5046.6 4839.3 4860.3 4904.4 4917.9 4922.7 4826.3 4839.3 4862.8 4883.6 4895.9 4867.0 4939.4 4943.8 4944.4 4946.0 4857.1 4875.2 4884.5 4926.9 4931.9 08:41:11 INFO - PROCESS | 20969 | 08:41:11 INFO - PROCESS | 20969 | [#1] ext.html Cycles:180 Average:47679.40 Median:36710.22 stddev:88798.27 (241.9%) stddev-sans-first:88976.96 08:41:11 INFO - PROCESS | 20969 | Values: 580.2 583.4 595.4 609.4 623.4 28170.7 43713.0 44724.3 44834.3 45157.8 41772.2 42014.0 42146.8 42163.8 42177.0 7762.8 7913.6 7914.1 7932.6 8041.2 7914.4 7996.9 8003.7 8008.2 8009.2 8037.5 8054.1 8090.5 8093.0 8099.8 8018.7 8060.1 8065.0 8066.7 8072.4 7828.9 7924.3 7931.6 7934.4 7942.4 38673.0 38999.0 39008.8 39053.8 39131.2 2973.2 3033.0 3196.9 3220.1 3537.8 30031.8 30163.2 30346.8 30956.2 31269.2 3412.0 3414.8 3424.2 3424.3 3511.5 257233.0 260952.0 261060.0 261109.0 261398.0 32204.2 52524.2 53714.5 53719.0 53737.7 32630.8 34262.1 34490.8 34506.8 34557.3 13928.0 14085.6 14090.4 14091.5 14104.9 11463.5 11464.9 11495.6 11498.8 11520.7 7972.0 7985.4 7993.5 8045.4 8076.3 3027.8 3043.6 3058.1 3073.1 3103.2 861.4 866.6 876.5 1004.9 1007.0 28587.6 28906.9 28926.0 29425.6 29511.0 804.8 962.7 974.2 986.4 1028.6 14364.4 15056.7 15091.9 15187.0 15317.3 402436.0 404847.0 407537.0 407819.0 408006.0 50344.2 50723.0 50761.0 50838.2 50841.0 1056.0 1126.5 1153.7 1175.9 1204.2 28347.7 29319.7 29614.0 29768.3 30194.5 42144.8 42167.8 42619.1 42720.4 42788.4 325931.0 326604.3 326658.0 326841.0 326887.0 22611.9 23308.0 24653.9 25189.9 25244.5 41130.4 41221.0 41357.8 41741.4 42415.6 36518.0 36637.6 36793.0 37003.0 37183.6 36684.6 36760.8 37015.6 37244.8 37307.4 35045.0 35958.0 36474.0 36735.8 36857.6 31765.2 32392.4 32561.5 32628.8 32738.7 25226.7 25373.1 25423.2 25517.5 25764.6 08:41:11 INFO - PROCESS | 20969 | 08:41:11 INFO - PROCESS | 20969 | [#2] jquery.html Cycles:180 Average:26367.53 Median:2071.14 stddev:68353.63 (3300.3%) stddev-sans-first:68517.45 08:41:11 INFO - PROCESS | 20969 | Values: 346.2 361.6 361.8 367.4 373.9 12664.1 16883.2 17885.2 18182.6 19899.3 16371.8 16917.5 18106.5 18109.4 18146.0 5139.6 5404.0 5409.6 5409.9 5412.1 3785.9 5215.1 5868.5 6200.5 6202.7 6190.2 6190.3 6192.5 6217.2 6235.3 6451.4 6782.4 6817.1 6830.3 6834.9 6462.1 6600.2 6604.8 6613.3 6613.8 22325.0 23074.2 24009.2 24146.2 24187.2 1775.3 1897.9 1937.4 1948.7 2049.2 13572.9 14323.9 14570.3 14842.2 15123.6 1813.9 1901.9 1964.2 1966.0 1989.9 80247.6 84354.6 84680.6 87062.0 87077.6 14155.4 14386.9 16710.4 16752.3 16975.7 11421.5 28522.6 28621.0 28635.1 28713.9 6981.2 7296.2 7332.5 7393.7 7448.0 7429.4 7433.2 7523.8 7586.8 7595.8 3768.3 3813.8 3846.2 3904.3 3980.9 1797.7 1824.2 1858.0 1869.7 1929.1 815.2 866.0 916.5 920.9 934.7 17033.7 17173.3 17542.2 17974.9 18038.2 840.0 845.3 920.0 932.1 961.4 9437.3 9978.7 10017.8 10029.4 10127.4 397090.0 402366.0 421299.0 421940.0 422684.0 80687.0 80960.0 81048.6 82125.0 82249.6 856.5 885.4 886.8 888.1 889.1 12438.6 15576.6 15620.0 16479.8 16680.6 29648.7 34609.5 36738.8 37831.6 37839.2 45426.8 49476.0 50331.2 50938.7 52052.5 7460.6 7739.3 7804.3 7868.8 7903.9 10370.5 11282.8 12097.3 12106.2 12508.6 10605.7 10819.5 10839.8 10968.8 11053.9 10538.3 10676.6 10789.0 10996.2 11063.7 10914.2 11065.4 11067.7 11086.9 11237.8 7645.4 7814.5 7847.8 8012.9 8106.7 10712.1 10779.4 10789.6 10855.4 10868.0 08:41:11 INFO - PROCESS | 20969 | 08:41:11 INFO - PROCESS | 20969 | [#3] mootools.html Cycles:180 Average:5220.39 Median:5258.57 stddev:2918.50 (55.5%) stddev-sans-first:2912.37 08:41:11 INFO - PROCESS | 20969 | Values: 1373.2 1404.7 1478.2 1650.6 1697.3 7537.7 7943.2 8005.3 8019.5 8028.2 6750.8 7365.1 7608.1 7627.5 7921.9 2150.9 2178.1 2180.8 2183.9 2188.8 2199.3 2208.3 2246.2 2247.7 2248.0 1907.3 2078.6 2149.4 2158.4 2180.1 2177.2 2212.8 2216.0 2232.3 2249.2 2199.2 2199.4 2204.3 2204.9 2206.0 7790.5 7908.4 7910.4 7917.6 7919.3 4545.5 4662.8 4673.7 4675.0 4679.2 2932.5 2951.5 3011.2 3052.2 3053.3 999.8 1020.6 1022.3 1024.6 1033.2 10863.0 10925.9 10938.7 10948.3 10955.2 4055.8 4159.5 4317.8 4319.5 4326.3 9214.8 9248.4 9299.5 9309.1 9335.6 4547.3 4626.4 4643.3 4648.0 4650.6 4211.6 4252.4 4252.9 4257.2 4304.8 3663.5 3692.4 3741.4 3767.2 3770.7 1087.7 1182.7 1184.6 1186.5 1213.9 795.5 796.2 821.2 832.0 851.1 5263.5 5270.5 5341.8 5472.5 5592.4 868.6 877.4 897.6 915.8 920.4 3602.3 3707.5 3710.1 3721.4 3783.0 9424.6 9775.2 9904.6 9904.7 9920.6 8566.1 8793.6 9771.4 9774.3 9783.5 7117.4 7317.5 7518.0 7540.1 7554.7 5253.6 5307.1 5482.8 5484.5 5507.3 8851.8 8964.0 9020.2 9208.6 9249.6 9145.0 9409.2 9421.4 9421.8 9476.8 7488.6 7498.4 7610.1 7651.1 7660.8 7463.1 7469.1 7543.4 7559.8 7588.9 5218.4 6690.5 6881.6 6891.3 7002.5 6579.2 6628.8 6647.6 6808.6 6873.3 6363.5 6387.9 6446.3 6454.8 6455.7 4560.6 4630.1 4668.4 4727.2 4753.5 4676.6 4712.5 4737.3 4747.1 4777.7 08:41:11 INFO - PROCESS | 20969 | 08:41:11 INFO - PROCESS | 20969 | [#4] prototype.html Cycles:180 Average:4189.66 Median:4685.26 stddev:1216.74 (26.0%) stddev-sans-first:1184.49 08:41:11 INFO - PROCESS | 20969 | Values: 293.4 300.6 309.6 311.2 314.0 4796.4 4852.2 4859.9 4862.1 4873.3 4593.2 4657.6 4741.6 4746.9 4844.8 3828.3 3839.4 3864.4 3880.3 3881.1 3837.9 3839.2 3844.2 3844.4 3860.2 3605.8 3694.4 3824.8 3828.3 3836.0 3807.1 3818.4 3820.9 3848.6 3854.3 3401.2 3409.2 3410.9 3427.1 3428.0 4521.9 4752.9 4771.4 4772.8 4818.7 4294.4 4358.0 4366.8 4373.5 4378.6 5105.3 5105.6 5144.6 5150.3 5156.3 3552.7 3627.2 3635.6 3639.0 3655.0 5295.0 5298.2 5305.0 5309.3 5321.8 3706.1 3707.7 3738.7 3755.3 3763.1 3772.4 3779.9 3788.8 3826.7 3828.2 4222.8 4232.9 4266.4 4290.4 4355.0 5027.4 5041.2 5070.3 5070.7 5079.7 1217.5 1262.0 1285.5 1305.4 1307.6 878.6 884.1 900.9 902.7 908.1 4441.6 4451.1 4451.5 4452.1 4458.8 5140.7 5147.5 5151.6 5154.2 5173.5 4418.2 4433.8 4436.2 4449.6 4465.6 2328.9 2472.6 2473.9 2484.5 2484.5 4268.0 4312.8 4315.6 4325.7 4342.4 4678.5 4692.0 4737.9 4749.3 4827.6 4443.5 4565.7 4979.4 4980.8 4981.7 5285.7 5288.2 5295.6 5297.0 5303.5 5239.8 5248.6 5261.2 5278.1 5290.2 4717.6 4919.5 4962.4 4967.0 4970.4 3727.8 3770.1 3776.9 3787.5 3789.2 5060.7 5288.6 5302.7 5308.2 5317.9 4730.8 5078.3 5084.0 5086.6 5098.5 5028.4 5077.3 5088.4 5094.5 5112.4 5019.3 5040.8 5041.5 5055.5 5057.7 4853.6 5116.6 5126.4 5126.6 5140.0 5013.5 5034.6 5035.3 5047.4 5048.2 08:41:11 INFO - PROCESS | 20969 | 08:41:11 INFO - PROCESS | 20969 | [#5] yui.html Cycles:180 Average:16697.12 Median:24721.71 stddev:22212.56 (89.9%) stddev-sans-first:22242.04 08:41:11 INFO - PROCESS | 20969 | Values: 614.2 651.9 670.6 722.9 758.6 12664.9 13100.7 13105.5 13120.7 13126.9 13285.5 13337.9 13389.5 13397.5 13405.7 618.0 764.9 770.2 788.2 789.4 776.3 794.3 794.4 795.4 795.9 841.2 842.8 845.6 847.6 849.7 643.6 798.9 827.0 835.5 836.1 599.2 603.9 604.4 604.8 606.0 12448.3 12460.0 12493.3 12503.2 12514.3 12286.4 13024.8 13036.5 13043.6 13067.3 11637.3 11678.9 11755.1 11759.4 12167.2 4095.7 4177.2 4203.4 4232.4 4280.4 59640.0 60947.0 61542.0 61568.0 61895.1 10230.1 10296.2 10352.9 10464.2 10516.3 18949.3 19045.4 19142.7 19158.7 19160.1 6786.8 6875.5 6904.6 6929.1 7025.9 3711.6 3720.7 3763.9 3767.8 3780.6 2864.4 2935.5 2937.5 2954.5 2960.6 504.6 519.3 523.0 526.9 529.3 502.5 541.9 581.6 584.4 627.3 8387.0 8633.2 8637.9 8737.5 8964.3 553.0 564.1 626.5 633.7 640.4 3958.5 4268.7 4400.2 4426.1 4498.4 52412.7 54428.0 57118.4 57514.7 58216.0 83410.2 84547.6 84584.6 84906.0 85389.0 67034.7 71039.6 72824.6 74384.0 76672.0 9051.2 9368.9 9399.4 9449.1 9731.6 32409.0 42217.6 43766.6 44945.0 47731.3 58374.7 60792.4 65447.3 65926.3 69099.7 10538.4 11262.4 11619.8 11654.3 11848.3 13039.4 13298.5 13424.3 13444.6 14692.6 9073.5 11108.9 11142.3 12062.2 12415.9 11166.7 11815.5 11838.2 11944.8 12614.5 11547.2 11967.5 11971.0 12344.3 13267.8 10551.6 10631.6 10864.2 10914.4 11018.8 9969.6 10514.4 10730.8 10784.8 10918.5 08:41:11 INFO - PROCESS | 20969 | -------- Summary: end -------- 08:41:11 INFO - PROCESS | 20969 | 08:41:12 INFO - TEST-INFO | 20969: exit 0 08:41:12 INFO - TEST-OK | dromaeo_css | took 1124276ms 08:41:12 INFO - TEST-START | kraken 08:41:12 INFO - operating with platform_type : linux_ 08:41:12 INFO - Initialising browser for kraken test... 08:41:12 INFO - TEST-INFO | started process 21162 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmAkqVi/profile http://localhost:47579/getInfo.html) 08:41:19 INFO - PROCESS | 21162 | __metrics Screen width/height:1600/1200 08:41:19 INFO - PROCESS | 21162 | colorDepth:24 08:41:19 INFO - PROCESS | 21162 | Browser inner width/height: 1024/697 08:41:19 INFO - PROCESS | 21162 | __metrics 08:41:21 INFO - PROCESS | 21162 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:41:21 INFO - PROCESS | 21162 | console.error: PushService: 08:41:21 INFO - PROCESS | 21162 | stateChangeProcessEnqueue: Error transitioning state 08:41:21 INFO - PROCESS | 21162 | UnknownError 08:41:22 INFO - TEST-INFO | 21162: exit 0 08:41:22 INFO - Browser initialized. 08:41:22 INFO - Running cycle 1/1 for kraken test... 08:41:22 INFO - TEST-INFO | started process 21245 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmAkqVi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:41:34 INFO - PROCESS | 21245 | RSS: Main: 159014912 08:41:34 INFO - PROCESS | 21245 | 08:41:37 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:47579/tests/kraken/driver.html?testName=audio-beat-detection) 08:41:37 INFO - PROCESS | 21245 | RSS: Main: 216158208 08:41:37 INFO - PROCESS | 21245 | 08:41:40 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:47579/tests/kraken/driver.html?testName=audio-dft) 08:41:41 INFO - PROCESS | 21245 | RSS: Main: 203128832 08:41:41 INFO - PROCESS | 21245 | 08:41:44 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:47579/tests/kraken/driver.html?testName=audio-fft) 08:41:45 INFO - PROCESS | 21245 | RSS: Main: 271618048 08:41:45 INFO - PROCESS | 21245 | 08:41:47 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:47579/tests/kraken/driver.html?testName=audio-oscillator) 08:41:47 INFO - PROCESS | 21245 | RSS: Main: 181821440 08:41:47 INFO - PROCESS | 21245 | 08:41:50 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:47579/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:41:50 INFO - PROCESS | 21245 | RSS: Main: 185843712 08:41:50 INFO - PROCESS | 21245 | 08:41:54 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:47579/tests/kraken/driver.html?testName=imaging-darkroom) 08:41:54 INFO - PROCESS | 21245 | RSS: Main: 221401088 08:41:54 INFO - PROCESS | 21245 | 08:41:58 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:47579/tests/kraken/driver.html?testName=imaging-desaturate) 08:41:58 INFO - PROCESS | 21245 | RSS: Main: 217673728 08:41:58 INFO - PROCESS | 21245 | 08:42:01 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:47579/tests/kraken/driver.html?testName=json-parse-financial) 08:42:02 INFO - PROCESS | 21245 | RSS: Main: 220602368 08:42:02 INFO - PROCESS | 21245 | 08:42:04 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:47579/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:42:04 INFO - PROCESS | 21245 | RSS: Main: 207466496 08:42:04 INFO - PROCESS | 21245 | 08:42:06 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:47579/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:42:07 INFO - PROCESS | 21245 | RSS: Main: 211267584 08:42:07 INFO - PROCESS | 21245 | 08:42:09 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:47579/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:42:09 INFO - PROCESS | 21245 | RSS: Main: 212156416 08:42:09 INFO - PROCESS | 21245 | 08:42:12 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:47579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:42:13 INFO - PROCESS | 21245 | RSS: Main: 223453184 08:42:13 INFO - PROCESS | 21245 | 08:42:16 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:47579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:42:16 INFO - PROCESS | 21245 | RSS: Main: 225255424 08:42:16 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | Cycle 1(1): loaded http://localhost:47579/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:47579/tests/kraken/driver.html?testName=ai-astar) 08:42:18 INFO - PROCESS | 21245 | RSS: Main: 267739136 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | __start_tp_report 08:42:18 INFO - PROCESS | 21245 | _x_x_mozilla_page_load 08:42:18 INFO - PROCESS | 21245 | _x_x_mozilla_page_load_details 08:42:18 INFO - PROCESS | 21245 | |i|pagename|runs| 08:42:18 INFO - PROCESS | 21245 | |0;ai-astar;104;112;112;112;113;113;112;112;111;114 08:42:18 INFO - PROCESS | 21245 | |1;audio-beat-detection;149;121;127;183;123;149;150;125;179;121 08:42:18 INFO - PROCESS | 21245 | |2;audio-dft;161;161;162;165;161;163;162;161;161;162 08:42:18 INFO - PROCESS | 21245 | |3;audio-fft;76;75;79;118;77;76;75;74;107;77 08:42:18 INFO - PROCESS | 21245 | |4;audio-oscillator;85;87;129;84;85;85;123;85;85;128 08:42:18 INFO - PROCESS | 21245 | |5;imaging-gaussian-blur;117;116;117;117;117;117;117;117;117;116 08:42:18 INFO - PROCESS | 21245 | |6;imaging-darkroom;146;147;147;146;146;147;146;148;146;146 08:42:18 INFO - PROCESS | 21245 | |7;imaging-desaturate;95;96;95;95;95;96;96;94;95;95 08:42:18 INFO - PROCESS | 21245 | |8;json-parse-financial;63;64;63;64;64;65;64;63;64;64 08:42:18 INFO - PROCESS | 21245 | |9;json-stringify-tinderbox;64;64;64;64;64;64;65;64;65;63 08:42:18 INFO - PROCESS | 21245 | |10;stanford-crypto-aes;88;82;78;82;79;78;85;79;79;79 08:42:18 INFO - PROCESS | 21245 | |11;stanford-crypto-ccm;130;142;126;126;129;126;126;127;210;139 08:42:18 INFO - PROCESS | 21245 | |12;stanford-crypto-pbkdf2;172;168;167;169;175;170;166;169;171;170 08:42:18 INFO - PROCESS | 21245 | |13;stanford-crypto-sha256-iterative;67;68;70;70;67;67;67;67;67;67 08:42:18 INFO - PROCESS | 21245 | __end_tp_report 08:42:18 INFO - PROCESS | 21245 | __start_cc_report 08:42:18 INFO - PROCESS | 21245 | _x_x_mozilla_cycle_collect,1887 08:42:18 INFO - PROCESS | 21245 | __end_cc_report 08:42:18 INFO - PROCESS | 21245 | __startTimestamp1467646938894__endTimestamp 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | ------- Summary: start ------- 08:42:18 INFO - PROCESS | 21245 | Number of tests: 14 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#0] ai-astar Cycles:10 Average:111.50 Median:112.00 stddev:2.76 (2.5%) stddev-sans-first:0.87 08:42:18 INFO - PROCESS | 21245 | Values: 104.0 112.0 112.0 112.0 113.0 113.0 112.0 112.0 111.0 114.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:149.00 stddev:23.49 (15.8%) stddev-sans-first:24.80 08:42:18 INFO - PROCESS | 21245 | Values: 149.0 121.0 127.0 183.0 123.0 149.0 150.0 125.0 179.0 121.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.29 (0.8%) stddev-sans-first:1.32 08:42:18 INFO - PROCESS | 21245 | Values: 161.0 161.0 162.0 165.0 161.0 163.0 162.0 161.0 161.0 162.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#3] audio-fft Cycles:10 Average:83.40 Median:76.00 stddev:15.61 (20.5%) stddev-sans-first:16.33 08:42:18 INFO - PROCESS | 21245 | Values: 76.0 75.0 79.0 118.0 77.0 76.0 75.0 74.0 107.0 77.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#4] audio-oscillator Cycles:10 Average:97.60 Median:85.00 stddev:20.13 (23.7%) stddev-sans-first:20.83 08:42:18 INFO - PROCESS | 21245 | Values: 85.0 87.0 129.0 84.0 85.0 85.0 123.0 85.0 85.0 128.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#5] imaging-gaussian-blur Cycles:10 Average:116.80 Median:117.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 08:42:18 INFO - PROCESS | 21245 | Values: 117.0 116.0 117.0 117.0 117.0 117.0 117.0 117.0 117.0 116.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 08:42:18 INFO - PROCESS | 21245 | Values: 146.0 147.0 147.0 146.0 146.0 147.0 146.0 148.0 146.0 146.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.63 (0.7%) stddev-sans-first:0.67 08:42:18 INFO - PROCESS | 21245 | Values: 95.0 96.0 95.0 95.0 95.0 96.0 96.0 94.0 95.0 95.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#8] json-parse-financial Cycles:10 Average:63.80 Median:64.00 stddev:0.63 (1.0%) stddev-sans-first:0.60 08:42:18 INFO - PROCESS | 21245 | Values: 63.0 64.0 63.0 64.0 64.0 65.0 64.0 63.0 64.0 64.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#9] json-stringify-tinderbox Cycles:10 Average:64.10 Median:64.00 stddev:0.57 (0.9%) stddev-sans-first:0.60 08:42:18 INFO - PROCESS | 21245 | Values: 64.0 64.0 64.0 64.0 64.0 64.0 65.0 64.0 65.0 63.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#10] stanford-crypto-aes Cycles:10 Average:80.90 Median:80.50 stddev:3.35 (4.2%) stddev-sans-first:2.37 08:42:18 INFO - PROCESS | 21245 | Values: 88.0 82.0 78.0 82.0 79.0 78.0 85.0 79.0 79.0 79.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#11] stanford-crypto-ccm Cycles:10 Average:138.10 Median:129.50 stddev:25.91 (20.0%) stddev-sans-first:27.32 08:42:18 INFO - PROCESS | 21245 | Values: 130.0 142.0 126.0 126.0 129.0 126.0 126.0 127.0 210.0 139.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:169.70 Median:170.00 stddev:2.58 (1.5%) stddev-sans-first:2.60 08:42:18 INFO - PROCESS | 21245 | Values: 172.0 168.0 167.0 169.0 175.0 170.0 166.0 169.0 171.0 170.0 08:42:18 INFO - PROCESS | 21245 | 08:42:18 INFO - PROCESS | 21245 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:67.00 stddev:1.25 (1.9%) stddev-sans-first:1.30 08:42:18 INFO - PROCESS | 21245 | Values: 67.0 68.0 70.0 70.0 67.0 67.0 67.0 67.0 67.0 67.0 08:42:18 INFO - PROCESS | 21245 | -------- Summary: end -------- 08:42:18 INFO - PROCESS | 21245 | 08:42:20 INFO - TEST-INFO | 21245: exit 0 08:42:20 INFO - TEST-OK | kraken | took 67604ms 08:42:20 INFO - SUITE-END | took 1191s 08:42:20 INFO - Completed test suite (00:19:52) 08:42:20 INFO - javascript benchmark 08:42:20 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2593.364625666712, 2600.258926206031, 2600.8309459885104, 2635.907743228986, 2642.39224978255, 4625.745583992879, 4671.9766401168035, 4697.8120875165, 4698.577128058474, 4722.220833562458, 4668.18306796311, 4678.53214678532, 4687.90624187516, 4721.457032441271, 4738.620910327174, 4291.3777502262155, 4293.313069908815, 4327.372530983005, 4352.869413917571, 4369.126174765044, 4425.291953287475, 4489.124620698965, 4500.932486012696, 4521.5930566249035, 4525.411696479469, 4270.338097594878, 4318.157959197958, 4327.848525301631, 4390.319500477431, 4425.1149770045795, 4279.614834664895, 4301.0, 4329.805158767832, 4333.804978775963, 4336.4145840311785, 4321.503027151886, 4331.6534677225745, 4374.34384842273, 4377.824887004516, 4416.514183439819, 4805.495422980606, 4817.181079216542, 4831.637627177941, 4834.395700537433, 4845.370101886732, 4959.107360675077, 5040.42035165957, 5103.18349064148, 5107.642465027449, 5116.386033675945, 5109.310243117169, 5128.487151284841, 5172.870678233036, 5177.042247184283, 5183.766730497136, 4620.976895115503, 4784.091022705745, 4824.541668541483, 4830.154722923509, 4843.903121937541, 5155.072087024297, 5174.223866420067, 5226.268322434862, 5247.868803279948, 5285.947140528546, 5031.119554078095, 5038.521340472649, 5082.517160869711, 5083.110455670317, 5084.51697088776, 4958.6776859504735, 5037.773300201499, 5114.002769459994, 5141.3830340358645, 5168.3797944246935, 5046.21783623539, 5071.03650306448, 5093.18509038552, 5134.820281290137, 5139.897202055938, 5069.822556210589, 5081.034603425337, 5088.0078384714625, 5089.592832573459, 5138.100832354397, 4251.4685664291965, 4284.10033892886, 4398.890027749268, 4416.873697207256, 4451.465824101064, 3762.266358060152, 3787.14789172434, 3802.3155831950517, 3811.2377524495214, 3840.519935008124, 4378.408914796525, 4380.145871555016, 4387.341898715218, 4388.166248412856, 4430.091831174602, 4972.477889821589, 4996.400431948189, 5104.464031276737, 5104.9489505104475, 5141.562967147759, 4330.17726631939, 4335.891602709894, 4344.022594916119, 4382.474103107584, 4383.079553293844, 4536.364908912755, 4561.429821272341, 4567.611753000966, 4570.657200709894, 4618.237990731492, 4639.721616702874, 4702.177119004229, 4711.363965864564, 4717.4339079311385, 4741.668083234141, 5072.949270507248, 5093.592512598909, 5093.847184584469, 5096.05722941257, 5139.203423469368, 4764.023375208005, 4766.761661916821, 4766.833160839493, 4769.0, 4796.928046079382, 4939.160342741814, 5001.824936127218, 5020.196768517166, 5026.271190677405, 5069.138246498031, 5120.897582048413, 5139.0, 5142.614303927146, 5146.4338922717725, 5152.4847515248175, 5003.924941125813, 5005.024020316004, 5009.323741294878, 5010.148274793367, 5046.57104146137, 4839.2983017462975, 4860.343853579721, 4904.386951631046, 4917.901641967069, 4922.704637721748, 4826.300186473012, 4839.2983017462975, 4862.805487780449, 4883.560479556857, 4895.853124406273, 4866.95133048665, 4939.382577177853, 4943.752812359439, 4944.406671199479, 4946.0, 4857.149998750134, 4875.171220892527, 4884.462709102067, 4926.926096108489, 4931.901361972668], "value": 4666.946217796393, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [580.2253990922119, 583.399098928104, 595.4373117404052, 609.4301827791015, 623.4077626255059, 28170.718292817066, 43713.0, 44724.329135063, 44834.32748508767, 45157.77421112898, 41772.16455670885, 42014.0, 42146.7892660537, 42163.78918105405, 42177.0, 7762.805929851743, 7913.643886025114, 7914.089879663826, 7932.643031063616, 8041.155678653716, 7914.445988780788, 7996.920030799704, 8003.719869804558, 8008.199180082003, 8009.199080092002, 8037.517748935083, 8054.073781515113, 8090.514569125842, 8093.0, 8099.757007289791, 8018.719344822933, 8060.113387527367, 8064.959675201645, 8066.677332906676, 8072.354211663082, 7828.882566761503, 7924.286814186693, 7931.603419828985, 7934.365250779923, 7942.364610831178, 38673.0, 38999.0, 39008.80495597532, 39053.804730976444, 39131.217375652326, 2973.2418233350572, 3032.9545056824163, 3196.888108916177, 3220.0500852248642, 3537.7877327360443, 30031.849840750656, 30163.245918851986, 30346.848265758752, 30956.226094347596, 31269.218269543217, 3412.0224141630424, 3414.834987673055, 3424.2124311408265, 3424.332255210235, 3511.490833829106, 257233.0, 260952.0, 261060.0, 261109.0, 261398.0, 32204.19489512734, 52524.212136817216, 53714.46285537095, 53719.0, 53737.731311343196, 32630.83684581562, 34262.14344641354, 34490.82754586211, 34506.82746586301, 34557.30885382278, 13928.0, 14085.647858803406, 14090.365933533016, 14091.506797262047, 14104.929475352557, 11463.484143213574, 11464.885351146548, 11495.597654082067, 11498.827517587242, 11520.654380368602, 7972.0, 7985.441019128722, 7993.480423772437, 8045.396595255379, 8076.313513351431, 3027.818330900109, 3043.5586839908087, 3058.1131471873355, 3073.139520934142, 3103.20868178613, 861.3869219510236, 866.6186877773886, 876.5354362188051, 1004.8542961270575, 1006.9980369532362, 28587.57118643222, 28906.855465722536, 28926.0, 29425.55861662077, 29511.0, 804.8430556041516, 962.7352478068588, 974.1865542272282, 986.4475893499663, 1028.6091285311534, 14364.35360408784, 15056.698866022618, 15091.924540377227, 15187.0, 15317.310721017358, 402436.0, 404847.0, 407537.0, 407819.0, 408006.0, 50344.24483632748, 50723.0, 50761.0, 50838.23742643863, 50841.0, 1055.9524821383056, 1126.4649291586595, 1153.7000379901285, 1175.905927525813, 1204.1570900369777, 28347.716522834507, 29319.706802931698, 29614.0, 29768.255793605334, 30194.547081793353, 42144.78927605342, 42167.789161053995, 42619.14761704687, 42720.35919461273, 42788.35817462678, 325931.0, 326604.30280637904, 326658.0, 326841.0, 326887.0, 22611.886940565193, 23308.0, 24653.876730616234, 25189.87405062963, 25244.49511009806, 41130.38304425376, 41221.0, 41357.79321103496, 41741.37387939244, 42415.57584424116, 36518.0, 36637.63362366342, 36793.0, 37003.0, 37183.6281637191, 36684.633153668125, 36760.81619591885, 37015.629843701216, 37244.81377593095, 37307.440388393654, 35045.0, 35958.0, 36474.0, 36735.81632091929, 36857.63142368542, 31765.205869852514, 32392.352152956337, 32561.511577325884, 32628.83685581557, 32738.672613274513, 25226.747732523174, 25373.111941081974, 25423.23730288094, 25517.489650207262, 25764.61353079743], "value": 16750.05819761607, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.1968233697822, 361.62210490037916, 361.7503922293617, 367.41764303578844, 373.94203898395756, 12664.11351205416, 16883.24025418856, 17885.195166217534, 18182.636347273048, 19899.30352437665, 16371.836281637181, 16917.49247522576, 18106.45680629583, 18109.366172183974, 18146.0, 5139.640225184229, 5404.0272750905015, 5409.594280428964, 5409.891802163955, 5412.052890744124, 3785.867494637688, 5215.061288967984, 5868.471837534621, 6200.4729597984, 6202.658853763041, 6190.226221722285, 6190.3190649028575, 6192.473639740605, 6217.160683307741, 6235.314115447297, 6451.387118223761, 6782.355676210752, 6817.0796942412635, 6830.316968303179, 6834.863302733942, 6462.1276127723095, 6600.174978127734, 6604.768833090819, 6613.272540020594, 6613.801585952429, 22325.0, 23074.192403265806, 24009.159679411136, 24146.154884578955, 24187.153449629353, 1775.334249656379, 1897.9240830366768, 1937.3994061840874, 1948.6979518174705, 2049.2008116834445, 13572.864271357259, 14323.928380358137, 14570.271486425743, 14842.183679897602, 15123.621909452351, 1813.945581632553, 1901.876378035437, 1964.2339487599847, 1965.9901700491548, 1989.8905560194185, 80247.5987620064, 84354.57822710909, 84680.57659711724, 87062.0, 87077.56461217717, 14155.363008664635, 14386.903362332454, 16710.4151354702, 16752.329906803592, 16975.74536381955, 11421.543138274375, 28522.572161417596, 28620.9965302431, 28635.14094577166, 28713.85643071813, 6981.197162326296, 7296.233895440902, 7332.450066245053, 7393.667284972189, 7447.962760186165, 7429.405647548183, 7433.182349941502, 7523.774286771406, 7586.772396828104, 7595.848083038309, 3768.340540405418, 3813.771173729585, 3846.2307538492414, 3904.2821158690085, 3980.920381592352, 1797.667431525172, 1824.206470185447, 1857.9502581041668, 1869.7195420687005, 1929.0644037641732, 815.1685281013333, 865.9870101948476, 916.5234078279258, 920.8618707193974, 934.6822080492665, 17033.659326813395, 17173.31306747716, 17542.21060052301, 17974.91012544929, 18038.188281527102, 839.9664013439516, 845.3068483843313, 919.995400023009, 932.0845662164318, 961.3606951377255, 9437.292203084797, 9978.650747223812, 10017.754237708496, 10029.448380339152, 10127.392356458637, 397090.0, 402366.0, 421299.0, 421940.0, 422684.0, 80687.0, 80960.0, 81048.59475702702, 82125.0, 82249.58875205586, 856.5417501636595, 885.4377470306273, 886.7916039730787, 888.1340692824444, 889.0664801957919, 12438.564650237198, 15576.610584735472, 15620.0, 16479.83520164783, 16680.582985425463, 29648.703512965458, 34609.48085778665, 36738.8163059183, 37831.62168378281, 37839.24321513609, 45426.772866135456, 49476.0, 50331.24503132529, 50938.74530627323, 52052.47947520476, 7460.552366858006, 7739.264769846855, 7804.2585954334245, 7868.84262314762, 7903.9209607903185, 10370.481475926324, 11282.774344513227, 12097.274163550215, 12106.152569320064, 12508.562200322946, 10605.734856628646, 10819.513121909376, 10839.783204335712, 10968.780624387628, 11053.944730276296, 10538.315009524356, 10676.572937082741, 10789.0, 10996.230263881771, 11063.723406914569, 10914.23600347968, 11065.391403472886, 11067.72330691739, 11086.889131108586, 11237.831432528355, 7645.350145237717, 7814.492058016211, 7847.8038049046945, 8012.919870801217, 8106.675732970851, 10712.089472394933, 10779.407132607781, 10789.62236321725, 10855.40295283767, 10868.0], "value": 8920.906902256447, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1373.162370953718, 1404.6979899321643, 1478.1500637133645, 1650.6286085630727, 1697.3041053168197, 7537.660805263763, 7943.165967573408, 8005.279524842763, 8019.5188288702575, 8028.157043510435, 6750.831229219272, 7365.11618605768, 7608.087029556447, 7627.542347459156, 7921.881171782428, 2150.8924553772326, 2178.0525471419905, 2180.7928246816527, 2183.8689678619253, 2188.803007729304, 2199.25225423356, 2208.293346129239, 2246.2475070851283, 2247.685324054634, 2248.033345661365, 1907.2943011085918, 2078.6050650376455, 2149.387424583994, 2158.417227348615, 2180.084364566878, 2177.2270843850365, 2212.811910987568, 2216.024949022441, 2232.2521955145044, 2249.156566287642, 2199.164317559333, 2199.417154454071, 2204.272590045281, 2204.900779464928, 2205.9669104963436, 7790.532568045879, 7908.367330613537, 7910.406719496061, 7917.604119793988, 7919.3268572170855, 4545.477270113913, 4662.836800711959, 4673.672842900998, 4675.0, 4679.204535229019, 2932.530795072778, 2951.5277555591215, 3011.1869795155185, 3052.1759125036338, 3053.2672158681758, 999.8300288950895, 1020.6325722739808, 1022.2639699416409, 1024.5850430575629, 1033.2405681823852, 10863.02232799044, 10925.890741092568, 10938.671839844817, 10948.34309941406, 10955.17836162291, 4055.7769322686945, 4159.521655009652, 4317.805698743564, 4319.503257125408, 4326.286162783105, 9214.815703685888, 9248.352615316997, 9299.53502324881, 9309.069093090773, 9335.626574937063, 4547.295169248771, 4626.375439315717, 4643.303504474288, 4647.953520464752, 4650.558196971282, 4211.599898009684, 4252.425922500484, 4252.914941701149, 4257.233697934402, 4304.849330273425, 3663.5237419135874, 3692.4276737105793, 3741.401375779862, 3767.2465506898184, 3770.71719621024, 1087.6845714742635, 1182.7043239190202, 1184.603157942082, 1186.5431808753692, 1213.8725433829497, 795.5385876191795, 796.2316364708084, 821.2116368286512, 831.9750407487785, 851.0595791650261, 5263.526282634504, 5270.540782044763, 5341.839744807662, 5472.452754724496, 5592.356878958972, 868.6481974800216, 877.3989816975393, 897.6005677473462, 915.844306467902, 920.3879420185635, 3602.2975519773395, 3707.536557930259, 3710.091027698177, 3721.3673675475234, 3783.0, 9424.62301507932, 9775.217982561378, 9904.55429505674, 9904.653337133166, 9920.603175873028, 8566.100559441293, 8793.648254069894, 9771.364861283993, 9774.266929980138, 9783.510824458748, 7117.4306055515435, 7317.451191160684, 7518.0, 7540.0951885772965, 7554.697812087565, 5253.605979551472, 5307.124324486416, 5482.780688772564, 5484.478974497416, 5507.311586051744, 8851.822963540822, 8964.0, 9020.233280171258, 9208.585613647268, 9249.583768730288, 9145.0, 9409.247260219028, 9421.434713917188, 9421.764455888657, 9476.810463790824, 7488.588127653032, 7498.437617178624, 7610.124835643972, 7651.081870175614, 7660.846783064419, 7463.104427468738, 7469.14104877946, 7543.434242431949, 7559.811004724926, 7588.924110758821, 5218.373795144607, 6690.531662783558, 6881.552699074544, 6891.27641597625, 7002.544834585736, 6579.17760279965, 6628.767993120217, 6647.567908085959, 6808.5914845109455, 6873.278305778022, 6363.459105975859, 6387.904181437375, 6446.258680251643, 6454.838629034311, 6455.741770329134, 4560.5895469407915, 4630.143423466669, 4668.439787225555, 4727.2436410174205, 4753.548412900769, 4676.649251306234, 4712.458067322302, 4737.298871786681, 4747.098051370229, 4777.689450185727], "value": 4210.256032071119, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [293.4014610195202, 300.55367778848404, 309.58051839757127, 311.18779984241115, 313.9967802869831, 4796.424429068512, 4852.150873597116, 4859.927101093477, 4862.124817532843, 4873.317735517026, 4593.173228818811, 4657.604103651185, 4741.596964258042, 4746.928796068053, 4844.83043093491, 3828.2917660232947, 3839.36650452675, 3864.3623802072625, 3880.2821478026585, 3881.126746482033, 3837.906196733931, 3839.232153569283, 3844.1735026969195, 3844.4041173618134, 3860.1507668312925, 3605.7656252343645, 3694.353488139578, 3824.827882745283, 3828.272628200633, 3835.9808200959096, 3807.1053302473897, 3818.3508803503332, 3820.9426858597144, 3848.557415897166, 3854.2676891390547, 3401.234722187513, 3409.2499650076943, 3410.931781364384, 3427.143214196451, 3427.9828600857086, 4521.932171017437, 4752.857414277542, 4771.403574553181, 4772.7613619319245, 4818.71087734737, 4294.441722576076, 4357.999999999968, 4366.812227074253, 4373.518912919576, 4378.627816635558, 5105.310783044279, 5105.566026887719, 5144.56271216947, 5150.253213284091, 5156.303898973628, 3552.7335449841366, 3627.1838836261895, 3635.563732352108, 3638.9621811785487, 3654.9817250913575, 5294.955400644606, 5298.225094593316, 5305.0, 5309.283246761676, 5321.840344789663, 3706.09200745819, 3707.684846788053, 3738.682212011955, 3755.3240416725253, 3763.1344790698295, 3772.434134879735, 3779.905502362463, 3788.791616461066, 3826.655600995868, 3828.157805282833, 4222.831086756495, 4232.851850185229, 4266.360045993064, 4290.420793192879, 4355.0, 5027.366106015559, 5041.2438134280155, 5070.264811602297, 5070.65627608684, 5079.6698214615935, 1217.5069097015723, 1261.9621411357673, 1285.4536821850863, 1305.4386613756176, 1307.6338625184962, 878.6030211963009, 884.0584777212376, 900.9324300677475, 902.6615019367737, 908.1100521488846, 4441.578050085237, 4451.087527056946, 4451.532589078165, 4452.065066336106, 4458.79289751575, 5140.717260550706, 5147.485251474823, 5151.5621172200035, 5154.175331946871, 5173.456787037307, 4418.204723149864, 4433.827424561941, 4436.201483732959, 4449.57729015743, 4465.59809617136, 2328.860268383902, 2472.5796614575565, 2473.9257822265363, 2484.478259565475, 2484.503099380131, 4267.957320426756, 4312.827486900552, 4315.5900189481945, 4325.740455572675, 4342.392065110887, 4678.5496496086325, 4691.976540117345, 4737.9052418952115, 4749.26386410107, 4827.565519103297, 4443.488998765119, 4565.680402371802, 4979.3526841510375, 4980.800767969241, 4981.676191047571, 5285.735713214247, 5288.180332048539, 5295.602829787705, 5297.020051290524, 5303.549198318186, 5239.790408383622, 5248.553872920845, 5261.184516399964, 5278.102722537101, 5290.206469029523, 4717.599004084691, 4919.4834542373965, 4962.42932062803, 4966.970148209662, 4970.403551573834, 3727.7576957497677, 3770.132869440099, 3776.905577360588, 3787.4886890269463, 3789.1853251551047, 5060.734816295926, 5288.57208553696, 5302.655327403706, 5308.150695888639, 5317.867053323698, 4730.810767569259, 5078.263651770399, 5083.974580127076, 5086.593072554261, 5098.490150984871, 5028.371453568304, 5077.339945807022, 5088.363954505687, 5094.51602097815, 5112.36095488064, 5019.297298378157, 5040.823571174991, 5041.495850414929, 5055.545000949932, 5057.747112644427, 4853.587445067067, 5116.616253781056, 5126.359205099363, 5126.589872810241, 5139.974300128475, 5013.548780609763, 5034.572061374824, 5035.320231768665, 5047.384836852172, 5048.167052436307], "value": 3806.1143885600454, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [614.226075145317, 651.9022146677997, 670.614396721885, 722.9178872526137, 758.5827794712908, 12664.873351266484, 13100.672483187926, 13105.541306054267, 13120.6719832004, 13126.868731312685, 13285.535006274782, 13337.866621333784, 13389.531366402178, 13397.531086411978, 13405.731885362287, 617.9598326108811, 764.8929149919015, 770.1643716567517, 788.1566723605715, 789.3645615279697, 776.2819392062348, 794.3168874767695, 794.3803833010232, 795.3517882925427, 795.8845967334732, 841.2092632925062, 842.7682387343499, 845.6279237135672, 847.588919374103, 849.7280870121564, 643.5559463969869, 798.9400794940344, 827.0406328658727, 835.5070508400042, 836.1095433363479, 599.1521996375124, 603.8822429626225, 604.3714536881638, 604.7550741949517, 605.9606125601866, 12448.315342656151, 12460.003199743998, 12493.312867792269, 12503.187292826027, 12514.31171285579, 12286.447109880077, 13024.804627930589, 13036.478540858354, 13043.630418806079, 13067.281299528522, 11637.301761894314, 11678.883211167864, 11755.05959523236, 11759.412029398496, 12167.209131406518, 4095.651869591088, 4177.206330797138, 4203.390508376299, 4232.386303985935, 4280.379344994958, 59640.0, 60947.0, 61542.0, 61567.99999999955, 61895.07157392688, 10230.130438912627, 10296.176305895511, 10352.912944140908, 10464.162866970624, 10516.263861529773, 18949.33677321287, 19045.428637140907, 19142.712859306845, 19158.71261931072, 19160.137793799313, 6786.76246331376, 6875.48433867462, 6904.585724856524, 6929.064576282138, 7025.89461158083, 3711.5731690855896, 3720.6651401374006, 3763.9059023524082, 3767.7550959187565, 3780.584135745066, 2864.4414339203654, 2935.4716151093007, 2937.500624893773, 2954.482965481075, 2960.644722633298, 504.553470178887, 519.283388923291, 523.0062880527029, 526.8998890210925, 529.2881074954181, 502.52009331089454, 541.8591166296791, 581.5841673203595, 584.4097461563852, 627.3068259573197, 8386.958065209636, 8633.179847914438, 8637.913620863837, 8737.519436431057, 8964.32767542424, 552.9834104976857, 564.1425033948376, 626.5207116555838, 633.6768248193455, 640.4044238857907, 3958.5051868516434, 4268.679849011337, 4400.22995975703, 4426.070525189746, 4498.415206023196, 52412.73793631008, 54428.0, 57118.42881571131, 57514.71242643844, 58216.0, 83410.16589834024, 84547.5772621133, 84584.57707711423, 84906.0, 85389.0, 67034.66482667555, 71039.6448017767, 72824.63587682134, 74384.0, 76672.0, 9051.230645394951, 9368.859467108136, 9399.389039712396, 9449.102335278138, 9731.61073557078, 32409.0, 42217.57782422259, 43766.56233437625, 44945.0, 47731.28403073887, 58374.708126459096, 60792.39207607867, 65447.34552654412, 65926.34073659201, 69099.65450172717, 10538.420386878795, 11262.436878156223, 11619.825702614637, 11654.30074195551, 11848.28910265387, 13039.413226404646, 13298.468061277441, 13424.328783560979, 13444.59666209976, 14692.559223223321, 9073.546322683707, 11108.944455277671, 11142.331460112418, 12062.215955962834, 12415.875841241472, 11166.720831979266, 11815.527378904748, 11838.230515016496, 11944.761104777683, 12614.49542018309, 11547.191696581158, 11967.521299148284, 11971.042316614825, 12344.259344439362, 13267.800982985456, 10551.630692925712, 10631.627893023708, 10864.239503234698, 10914.399708016135, 11018.779624407627, 9969.575246579898, 10514.369137851754, 10730.785384292427, 10784.784304313713, 10918.454077296263], "value": 6615.122875094445, "unit": "score"}], "name": "dromaeo_css", "value": 6478.470029933385, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 112.0, 112.0, 112.0, 113.0, 113.0, 112.0, 112.0, 111.0, 114.0], "value": 111.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 121.0, 127.0, 183.0, 123.0, 149.0, 150.0, 125.0, 179.0, 121.0], "value": 142.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 162.0, 165.0, 161.0, 163.0, 162.0, 161.0, 161.0, 162.0], "value": 161.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 79.0, 118.0, 77.0, 76.0, 75.0, 74.0, 107.0, 77.0], "value": 83.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 87.0, 129.0, 84.0, 85.0, 85.0, 123.0, 85.0, 85.0, 128.0], "value": 97.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 116.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 117.0, 116.0], "value": 116.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 148.0, 146.0, 146.0], "value": 146.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 94.0, 95.0, 95.0], "value": 95.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 64.0, 63.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 64.0], "value": 63.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 64.0, 64.0, 64.0, 64.0, 64.0, 65.0, 64.0, 65.0, 63.0], "value": 64.1, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 82.0, 78.0, 82.0, 79.0, 78.0, 85.0, 79.0, 79.0, 79.0], "value": 80.9, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [130.0, 142.0, 126.0, 126.0, 129.0, 126.0, 126.0, 127.0, 210.0, 139.0], "value": 138.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 168.0, 167.0, 169.0, 175.0, 170.0, 166.0, 169.0, 171.0, 170.0], "value": 169.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 70.0, 70.0, 67.0, 67.0, 67.0, 67.0, 67.0, 67.0], "value": 67.7, "unit": "score"}], "name": "kraken", "value": 1539.9, "alertThreshold": 2.0}]} 08:42:20 INFO - Return code: 0 08:42:20 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:42:20 INFO - # TBPL SUCCESS # 08:42:20 INFO - Running post-action listener: _resource_record_post_action 08:42:20 INFO - ##### 08:42:20 INFO - ##### Finished run-tests step (success) 08:42:20 INFO - ##### 08:42:20 INFO - Running post-run listener: _resource_record_post_run 08:42:20 INFO - Total resource usage - Wall time: 1218s; CPU: 13.0%; Read bytes: 139264; Write bytes: 536428544; Read time: 28; Write time: 3257316 08:42:20 INFO - TinderboxPrint: CPU usage
13.3% 08:42:20 INFO - TinderboxPrint: I/O read bytes / time
139,264 / 28 08:42:20 INFO - TinderboxPrint: I/O write bytes / time
536,428,544 / 3,257,316 08:42:20 INFO - TinderboxPrint: CPU idle
8,430.5 (86.7%) 08:42:20 INFO - TinderboxPrint: CPU user
1,201.7 (12.4%) 08:42:20 INFO - TinderboxPrint: Swap in / out
0 / 0 08:42:20 INFO - install - Wall time: 26s; CPU: 20.0%; Read bytes: 0; Write bytes: 244305920; Read time: 0; Write time: 2162824 08:42:20 INFO - run-tests - Wall time: 1193s; CPU: 13.0%; Read bytes: 139264; Write bytes: 281657344; Read time: 28; Write time: 994460 08:42:21 INFO - Running post-run listener: _upload_blobber_files 08:42:21 INFO - Blob upload gear active. 08:42:21 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:42:21 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 08:42:21 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', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 08:42:21 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 Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 08:42:21 INFO - (blobuploader) - INFO - Open directory for files ... 08:42:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:42:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:22 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:42:22 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:22 INFO - (blobuploader) - INFO - Done attempting. 08:42:22 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:42:22 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:22 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:26 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:42:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:26 INFO - (blobuploader) - INFO - Done attempting. 08:42:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:42:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:42:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:42:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:42:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:42:27 INFO - (blobuploader) - INFO - Done attempting. 08:42:27 INFO - (blobuploader) - INFO - Iteration through files over. 08:42:27 INFO - Return code: 0 08:42:27 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:42:27 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:42:27 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b224f4c622b703817a23aa3fdd3d9a3b2c9366b7d93a6d6c14cd90af607c81fe45a3eb93baf1fc33272e940fefd11ef8bf8fed4266607746324ee4bf9ba3af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a275eac2def5c2bf74781a1d0f8ce5f9a02ac0467f3acf5242b32cea662e78484271606347c8f81078e6febe559deaf3159aec5c9f0fe6e2089e3f8a410e66cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9d53884c982926d1d58b5290b4bfde589ec1b994b239ef29d3e047a9e34fc88397de473b35235a0eb840c882fe5d69f1e97c2150f2ea869220fb6f0a492d03a"} 08:42:27 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:42:27 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:42:27 INFO - Contents: 08:42:27 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b224f4c622b703817a23aa3fdd3d9a3b2c9366b7d93a6d6c14cd90af607c81fe45a3eb93baf1fc33272e940fefd11ef8bf8fed4266607746324ee4bf9ba3af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a275eac2def5c2bf74781a1d0f8ce5f9a02ac0467f3acf5242b32cea662e78484271606347c8f81078e6febe559deaf3159aec5c9f0fe6e2089e3f8a410e66cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9d53884c982926d1d58b5290b4bfde589ec1b994b239ef29d3e047a9e34fc88397de473b35235a0eb840c882fe5d69f1e97c2150f2ea869220fb6f0a492d03a"} 08:42:27 INFO - Running post-run listener: copy_logs_to_upload_dir 08:42:27 INFO - Copying logs to upload dir... 08:42:27 INFO - mkdir: /builds/slave/test/build/upload/logs 08:42:27 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.941051 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2016-07-04 08:42:27.181756) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 08:42:27.185690) ========= 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=33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7b224f4c622b703817a23aa3fdd3d9a3b2c9366b7d93a6d6c14cd90af607c81fe45a3eb93baf1fc33272e940fefd11ef8bf8fed4266607746324ee4bf9ba3af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a275eac2def5c2bf74781a1d0f8ce5f9a02ac0467f3acf5242b32cea662e78484271606347c8f81078e6febe559deaf3159aec5c9f0fe6e2089e3f8a410e66cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9d53884c982926d1d58b5290b4bfde589ec1b994b239ef29d3e047a9e34fc88397de473b35235a0eb840c882fe5d69f1e97c2150f2ea869220fb6f0a492d03a"} build_url:https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011291 build_url: 'https://queue.taskcluster.net/v1/task/H5DyUTowTNu_UK8ZXPqGJQ/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/Fx-Team-Non-PGO/sha512/7b224f4c622b703817a23aa3fdd3d9a3b2c9366b7d93a6d6c14cd90af607c81fe45a3eb93baf1fc33272e940fefd11ef8bf8fed4266607746324ee4bf9ba3af1", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/a275eac2def5c2bf74781a1d0f8ce5f9a02ac0467f3acf5242b32cea662e78484271606347c8f81078e6febe559deaf3159aec5c9f0fe6e2089e3f8a410e66cf", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9d53884c982926d1d58b5290b4bfde589ec1b994b239ef29d3e047a9e34fc88397de473b35235a0eb840c882fe5d69f1e97c2150f2ea869220fb6f0a492d03a"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 08:42:27.210984) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:42:27.211298) ========= 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=33d5923976266a1c518c4bf7000001ab-1467644971.476873-1855392337 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004484 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 08:42:27.296320) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 08:42:27.296673) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 08:42:27.296975) ========= ========= Total master_lag: 0.24 =========