builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-054 starttime: 1467649371.98 results: success (0) buildid: 20160704085124 builduid: 7b72c404321348da98ffe837fb77673e revision: 7eef107d8d310cc5c0419d3fd3bf7f74590da3db ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:51.980478) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:51.981539) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:51.982442) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:52.001184) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:52.001798) ========= 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=cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-04 09:22:53-- 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% 50.0M=0s 2016-07-04 09:22:53 (50.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118115 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:52.138681) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:52.139490) ========= 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=cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015793 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:52.194060) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:52.194892) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 7eef107d8d310cc5c0419d3fd3bf7f74590da3db --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 7eef107d8d310cc5c0419d3fd3bf7f74590da3db --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=cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-04 09:22:53,495 truncating revision to first 12 chars 2016-07-04 09:22:53,495 Setting DEBUG logging. 2016-07-04 09:22:53,495 attempt 1/10 2016-07-04 09:22:53,495 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/7eef107d8d31?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-04 09:22:53,794 unpacking tar archive at: fx-team-7eef107d8d31/testing/mozharness/ program finished with exit code 0 elapsedTime=0.663391 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:52.872975) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:52.873386) ========= script_repo_revision: 7eef107d8d310cc5c0419d3fd3bf7f74590da3db ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:52.873905) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:52.874232) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-04 09:22:52.885259) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-04 09:22:52.885585) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:22:54 INFO - MultiFileLogger online at 20160704 09:22:54 in /builds/slave/test 09:22:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 09:22:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:22:54 INFO - {'append_to_log': False, 09:22:54 INFO - 'base_work_dir': '/builds/slave/test', 09:22:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:22:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:22:54 INFO - 'branch': 'Fx-Team-Non-PGO', 09:22:54 INFO - 'buildbot_json_path': 'buildprops.json', 09:22:54 INFO - 'config_files': ('talos/linux_config.py',), 09:22:54 INFO - 'default_actions': ('clobber', 09:22:54 INFO - 'read-buildbot-config', 09:22:54 INFO - 'download-and-extract', 09:22:54 INFO - 'populate-webroot', 09:22:54 INFO - 'create-virtualenv', 09:22:54 INFO - 'install', 09:22:54 INFO - 'run-tests'), 09:22:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:22:54 INFO - 'download_minidump_stackwalk': True, 09:22:54 INFO - 'download_symbols': 'ondemand', 09:22:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:22:54 INFO - 'tooltool.py': '/tools/tooltool.py', 09:22:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:22:54 INFO - '/tools/misc-python/virtualenv.py')}, 09:22:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:22:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:22:54 INFO - 'installer_path': 'installer.exe', 09:22:54 INFO - 'log_level': 'info', 09:22:54 INFO - 'log_name': 'talos', 09:22:54 INFO - 'log_to_console': True, 09:22:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:22:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:22:54 INFO - 'opt_config_files': (), 09:22:54 INFO - 'pip_index': False, 09:22:54 INFO - 'sps_profile': False, 09:22:54 INFO - 'sps_profile_interval': 0, 09:22:54 INFO - 'suite': 'dromaeojs-e10s', 09:22:54 INFO - 'system_bits': '32', 09:22:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:22:54 INFO - 'title': 'talos-linux64-ix-054', 09:22:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:22:54 INFO - 'use_talos_json': True, 09:22:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:22:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:22:54 INFO - 'work_dir': 'build'} 09:22:54 INFO - ##### 09:22:54 INFO - ##### Running clobber step. 09:22:54 INFO - ##### 09:22:54 INFO - Running pre-action listener: _resource_record_pre_action 09:22:54 INFO - Running main action method: clobber 09:22:54 INFO - rmtree: /builds/slave/test/build 09:22:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:22:54 INFO - Running post-action listener: _resource_record_post_action 09:22:54 INFO - ##### 09:22:54 INFO - ##### Finished clobber step (success) 09:22:54 INFO - ##### 09:22:54 INFO - ##### 09:22:54 INFO - ##### Running read-buildbot-config step. 09:22:54 INFO - ##### 09:22:54 INFO - Running pre-action listener: _resource_record_pre_action 09:22:54 INFO - Running main action method: read_buildbot_config 09:22:54 INFO - Using buildbot properties: 09:22:54 INFO - { 09:22:54 INFO - "project": "", 09:22:54 INFO - "product": "firefox", 09:22:54 INFO - "script_repo_revision": "production", 09:22:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:22:54 INFO - "repository": "", 09:22:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:22:54 INFO - "buildid": "20160704085124", 09:22:54 INFO - "pgo_build": "False", 09:22:54 INFO - "basedir": "/builds/slave/test", 09:22:54 INFO - "buildnumber": 1456, 09:22:54 INFO - "slavename": "talos-linux64-ix-054", 09:22:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:22:54 INFO - "platform": "ubuntu64_hw", 09:22:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:22:54 INFO - "branch": "fx-team", 09:22:54 INFO - "repo_path": "integration/fx-team", 09:22:54 INFO - "revision": "7eef107d8d310cc5c0419d3fd3bf7f74590da3db", 09:22:54 INFO - "stage_platform": "linux64", 09:22:54 INFO - "builduid": "7b72c404321348da98ffe837fb77673e", 09:22:54 INFO - "slavebuilddir": "test" 09:22:54 INFO - } 09:22:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:22:54 INFO - Running post-action listener: _resource_record_post_action 09:22:54 INFO - ##### 09:22:54 INFO - ##### Finished read-buildbot-config step (success) 09:22:54 INFO - ##### 09:22:54 INFO - ##### 09:22:54 INFO - ##### Running download-and-extract step. 09:22:54 INFO - ##### 09:22:54 INFO - Running pre-action listener: _resource_record_pre_action 09:22:54 INFO - Running main action method: download_and_extract 09:22:54 INFO - mkdir: /builds/slave/test/build/tests 09:22: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')]} 09:22:54 INFO - https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:22:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:22:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:22:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:22:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:22:55 INFO - Downloaded 1361 bytes. 09:22:55 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:22:55 INFO - Using the following test package requirements: 09:22:55 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:22:55 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:22:55 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:22:55 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:55 INFO - u'jsshell-linux-x86_64.zip'], 09:22:55 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:22:55 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:22:55 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:22:55 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:22:55 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:22:55 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:22:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:22:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:22:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:22:55 INFO - https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:22:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:22:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:22:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:22:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:22:56 INFO - Downloaded 22710212 bytes. 09:22:56 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'] 09:22:56 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 09:22:57 INFO - Return code: 0 09:22:57 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 09:22: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')]} 09:22:57 INFO - https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:22:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:22:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:22:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:22:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:22:58 INFO - Downloaded 22710212 bytes. 09:22:58 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'] 09:22:58 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 09:23:00 INFO - Return code: 0 09:23:00 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')]} 09:23:00 INFO - https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:23:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:23:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:23:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:23:01 INFO - Downloaded 14403333 bytes. 09:23:01 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'] 09:23:01 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 09:23:01 INFO - Return code: 0 09:23: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')]} 09:23:01 INFO - https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:23:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:23:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:23:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:23:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/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 09:23:03 INFO - Downloaded 56486765 bytes. 09:23:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:23:03 INFO - mkdir: /builds/slave/test/properties 09:23:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:23:03 INFO - Writing to file /builds/slave/test/properties/build_url 09:23:03 INFO - Contents: 09:23:03 INFO - build_url:https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:23:04 INFO - Running post-action listener: _resource_record_post_action 09:23:04 INFO - Running post-action listener: set_extra_try_arguments 09:23:04 INFO - ##### 09:23:04 INFO - ##### Finished download-and-extract step (success) 09:23:04 INFO - ##### 09:23:04 INFO - ##### 09:23:04 INFO - ##### Running populate-webroot step. 09:23:04 INFO - ##### 09:23:04 INFO - Running pre-action listener: _resource_record_pre_action 09:23:04 INFO - Running main action method: populate_webroot 09:23:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:23:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:23:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:23:04 INFO - '--tppagecycles', 09:23:04 INFO - '7'], 09:23:04 INFO - 'tests': ['tsvgm']}}, 09:23:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:23:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:23:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:23:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:23:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:23:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:23:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:04 INFO - 'talos_options': ['--disable-e10s'], 09:23:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:23:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:04 INFO - 'talos_options': ['--disable-e10s'], 09:23:04 INFO - 'tests': ['damp', 'tps']}, 09:23:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:04 INFO - 'tests': ['damp', 'tps']}, 09:23:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:23:04 INFO - 'tests': ['dromaeo_dom']}, 09:23:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:23:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:23:04 INFO - 'tests': ['basic_compositor_video']}, 09:23:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:23:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:23:04 INFO - 'tests': ['a11yr', 09:23:04 INFO - 'ts_paint', 09:23:04 INFO - 'tpaint', 09:23:04 INFO - 'sessionrestore', 09:23:04 INFO - 'sessionrestore_no_auto_restore', 09:23:04 INFO - 'tabpaint']}, 09:23:04 INFO - 'other-e10s': {'tests': ['a11yr', 09:23:04 INFO - 'ts_paint', 09:23:04 INFO - 'tpaint', 09:23:04 INFO - 'sessionrestore', 09:23:04 INFO - 'sessionrestore_no_auto_restore', 09:23:04 INFO - 'tabpaint']}, 09:23:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:23:04 INFO - 'ts_paint', 09:23:04 INFO - 'tpaint', 09:23:04 INFO - 'sessionrestore', 09:23:04 INFO - 'sessionrestore_no_auto_restore', 09:23:04 INFO - 'tabpaint']}, 09:23:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:23:04 INFO - 'ts_paint', 09:23:04 INFO - 'tpaint', 09:23:04 INFO - 'sessionrestore', 09:23:04 INFO - 'sessionrestore_no_auto_restore', 09:23:04 INFO - 'tabpaint']}, 09:23:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:23:04 INFO - 'tests': ['a11yr', 09:23:04 INFO - 'ts_paint', 09:23:04 INFO - 'tpaint', 09:23:04 INFO - 'sessionrestore', 09:23:04 INFO - 'sessionrestore_no_auto_restore', 09:23:04 INFO - 'tabpaint']}, 09:23:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:23:04 INFO - 'tests': ['a11yr', 09:23:04 INFO - 'ts_paint', 09:23:04 INFO - 'tpaint', 09:23:04 INFO - 'sessionrestore', 09:23:04 INFO - 'sessionrestore_no_auto_restore', 09:23:04 INFO - 'tabpaint']}, 09:23:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:23:04 INFO - 'tests': ['tsvgx', 09:23:04 INFO - 'tsvgr_opacity', 09:23:04 INFO - 'tart', 09:23:04 INFO - 'tscrollx', 09:23:04 INFO - 'cart']}, 09:23:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:23:04 INFO - 'tsvgr_opacity', 09:23:04 INFO - 'tart', 09:23:04 INFO - 'tscrollx', 09:23:04 INFO - 'cart']}, 09:23:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:04 INFO - 'talos_options': ['--disable-e10s'], 09:23:04 INFO - 'tests': ['tp5o']}, 09:23:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:04 INFO - 'tests': ['tp5o']}, 09:23:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:04 INFO - 'talos_options': ['--disable-e10s', 09:23:04 INFO - '--xperf_path', 09:23:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:04 INFO - 'tests': ['tp5n']}, 09:23:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:23:04 INFO - 'talos_options': ['--xperf_path', 09:23:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:23:04 INFO - 'tests': ['tp5n']}}, 09:23:04 INFO - 'talos.zip': {'path': '', 09:23:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:23:04 INFO - Running post-action listener: _resource_record_post_action 09:23:04 INFO - ##### 09:23:04 INFO - ##### Finished populate-webroot step (success) 09:23:04 INFO - ##### 09:23:04 INFO - ##### 09:23:04 INFO - ##### Running create-virtualenv step. 09:23:04 INFO - ##### 09:23:04 INFO - Running pre-action listener: _resource_record_pre_action 09:23:04 INFO - Running main action method: create_virtualenv 09:23:04 INFO - Creating virtualenv /builds/slave/test/build/venv 09:23:04 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 09:23:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:23:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:23:04 INFO - Using real prefix '/usr' 09:23:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:23:05 INFO - Installing distribute.............................................................................................................................................................................................done. 09:23:07 INFO - Installing pip.................done. 09:23:07 INFO - Return code: 0 09:23:07 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb570>, '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 0x1bbc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc900>, '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': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', '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 09:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:23:07 INFO - Using env: {'DISPLAY': ':0', 09:23:07 INFO - 'HOME': '/home/cltbld', 09:23:07 INFO - 'LANG': 'en_US.UTF-8', 09:23:07 INFO - 'LANGUAGE': 'en_US:en', 09:23:07 INFO - 'LOGNAME': 'cltbld', 09:23:07 INFO - 'MAIL': '/var/mail/cltbld', 09:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:07 INFO - 'MOZ_NO_REMOTE': '1', 09:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:07 INFO - 'NO_EM_RESTART': '1', 09:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:07 INFO - 'PWD': '/builds/slave/test', 09:23:07 INFO - 'SHELL': '/bin/bash', 09:23:07 INFO - 'SHLVL': '1', 09:23:07 INFO - 'TERM': 'linux', 09:23:07 INFO - 'TMOUT': '86400', 09:23:07 INFO - 'USER': 'cltbld', 09:23:07 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', 09:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:07 INFO - '_': '/tools/buildbot/bin/python'} 09:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:07 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 09:23:07 INFO - Cleaning up... 09:23:07 INFO - Return code: 0 09:23:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x18fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb570>, '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 0x1bbc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc900>, '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': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', '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 09:23:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:23:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:23:07 INFO - Using env: {'DISPLAY': ':0', 09:23:07 INFO - 'HOME': '/home/cltbld', 09:23:07 INFO - 'LANG': 'en_US.UTF-8', 09:23:07 INFO - 'LANGUAGE': 'en_US:en', 09:23:07 INFO - 'LOGNAME': 'cltbld', 09:23:07 INFO - 'MAIL': '/var/mail/cltbld', 09:23:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:07 INFO - 'MOZ_NO_REMOTE': '1', 09:23:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:07 INFO - 'NO_EM_RESTART': '1', 09:23:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:07 INFO - 'PWD': '/builds/slave/test', 09:23:07 INFO - 'SHELL': '/bin/bash', 09:23:07 INFO - 'SHLVL': '1', 09:23:07 INFO - 'TERM': 'linux', 09:23:07 INFO - 'TMOUT': '86400', 09:23:07 INFO - 'USER': 'cltbld', 09:23:07 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', 09:23:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:07 INFO - '_': '/tools/buildbot/bin/python'} 09:23:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:07 INFO - Downloading/unpacking psutil>=3.1.1 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:23:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:09 INFO - Installing collected packages: psutil 09:23:09 INFO - Running setup.py install for psutil 09:23:09 INFO - building 'psutil._psutil_linux' extension 09:23:09 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 09:23:10 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 09:23:10 INFO - building 'psutil._psutil_posix' extension 09:23:10 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 09:23:10 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 09:23:10 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:23:10 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:23:10 INFO - Successfully installed psutil 09:23:10 INFO - Cleaning up... 09:23:10 INFO - Return code: 0 09:23:10 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb570>, '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 0x1bbc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc900>, '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': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', '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 09:23:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:23:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:23:10 INFO - Using env: {'DISPLAY': ':0', 09:23:10 INFO - 'HOME': '/home/cltbld', 09:23:10 INFO - 'LANG': 'en_US.UTF-8', 09:23:10 INFO - 'LANGUAGE': 'en_US:en', 09:23:10 INFO - 'LOGNAME': 'cltbld', 09:23:10 INFO - 'MAIL': '/var/mail/cltbld', 09:23:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:10 INFO - 'MOZ_NO_REMOTE': '1', 09:23:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:10 INFO - 'NO_EM_RESTART': '1', 09:23:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:10 INFO - 'PWD': '/builds/slave/test', 09:23:10 INFO - 'SHELL': '/bin/bash', 09:23:10 INFO - 'SHLVL': '1', 09:23:10 INFO - 'TERM': 'linux', 09:23:10 INFO - 'TMOUT': '86400', 09:23:10 INFO - 'USER': 'cltbld', 09:23:10 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', 09:23:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:10 INFO - '_': '/tools/buildbot/bin/python'} 09:23:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:23:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:23:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:23:12 INFO - Installing collected packages: mozsystemmonitor 09:23:12 INFO - Running setup.py install for mozsystemmonitor 09:23:12 INFO - Successfully installed mozsystemmonitor 09:23:12 INFO - Cleaning up... 09:23:12 INFO - Return code: 0 09:23:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:23:12 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')]} 09:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:12 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')]} 09:23:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:12 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 0x18fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb570>, '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 0x1bbc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc900>, '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': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', '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 09:23:12 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 09:23:12 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 09:23:12 INFO - Using env: {'DISPLAY': ':0', 09:23:12 INFO - 'HOME': '/home/cltbld', 09:23:12 INFO - 'LANG': 'en_US.UTF-8', 09:23:12 INFO - 'LANGUAGE': 'en_US:en', 09:23:12 INFO - 'LOGNAME': 'cltbld', 09:23:12 INFO - 'MAIL': '/var/mail/cltbld', 09:23:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:12 INFO - 'MOZ_NO_REMOTE': '1', 09:23:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:12 INFO - 'NO_EM_RESTART': '1', 09:23:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:12 INFO - 'PWD': '/builds/slave/test', 09:23:12 INFO - 'SHELL': '/bin/bash', 09:23:12 INFO - 'SHLVL': '1', 09:23:12 INFO - 'TERM': 'linux', 09:23:12 INFO - 'TMOUT': '86400', 09:23:12 INFO - 'USER': 'cltbld', 09:23:12 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', 09:23:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:12 INFO - '_': '/tools/buildbot/bin/python'} 09:23:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:12 INFO - Downloading/unpacking jsonschema==2.5.1 09:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:23:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:23:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:23:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:23:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:23:14 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 09:23:14 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 09:23:14 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 09:23:14 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 09:23:14 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 09:23:14 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 09:23:14 INFO - Downloading functools32-3.2.3-2.tar.gz 09:23:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:23:14 INFO - warning: no files found matching '*.txt' 09:23:14 INFO - no previously-included directories found matching 'build' 09:23:14 INFO - no previously-included directories found matching 'dist' 09:23:14 INFO - no previously-included directories found matching '.git*' 09:23:14 INFO - Installing collected packages: jsonschema, functools32 09:23:15 INFO - Running setup.py install for functools32 09:23:15 INFO - warning: no files found matching '*.txt' 09:23:15 INFO - no previously-included directories found matching 'build' 09:23:15 INFO - no previously-included directories found matching 'dist' 09:23:15 INFO - no previously-included directories found matching '.git*' 09:23:15 INFO - Successfully installed jsonschema functools32 09:23:15 INFO - Cleaning up... 09:23:15 INFO - Return code: 0 09:23:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:15 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 0x18fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb570>, '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 0x1bbc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc900>, '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': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', '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 09:23:15 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 09:23:15 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 09:23:15 INFO - Using env: {'DISPLAY': ':0', 09:23:15 INFO - 'HOME': '/home/cltbld', 09:23:15 INFO - 'LANG': 'en_US.UTF-8', 09:23:15 INFO - 'LANGUAGE': 'en_US:en', 09:23:15 INFO - 'LOGNAME': 'cltbld', 09:23:15 INFO - 'MAIL': '/var/mail/cltbld', 09:23:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:15 INFO - 'MOZ_NO_REMOTE': '1', 09:23:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:15 INFO - 'NO_EM_RESTART': '1', 09:23:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:15 INFO - 'PWD': '/builds/slave/test', 09:23:15 INFO - 'SHELL': '/bin/bash', 09:23:15 INFO - 'SHLVL': '1', 09:23:15 INFO - 'TERM': 'linux', 09:23:15 INFO - 'TMOUT': '86400', 09:23:15 INFO - 'USER': 'cltbld', 09:23:15 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', 09:23:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:15 INFO - '_': '/tools/buildbot/bin/python'} 09:23:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:15 INFO - Downloading/unpacking blobuploader==1.2.4 09:23:15 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 09:23:15 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 09:23:15 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 09:23:15 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 09:23:15 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 09:23:15 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 09:23:17 INFO - Downloading blobuploader-1.2.4.tar.gz 09:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:23:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:23:17 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 09:23:17 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 09:23:17 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 09:23:17 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 09:23:17 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 09:23:17 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 09:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:23:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:23:17 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 09:23:17 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 09:23:17 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 09:23:17 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 09:23:17 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 09:23:17 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 09:23:17 INFO - Downloading docopt-0.6.1.tar.gz 09:23:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:23:18 INFO - Installing collected packages: blobuploader, requests, docopt 09:23:18 INFO - Running setup.py install for blobuploader 09:23:18 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:23:18 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:23:18 INFO - Running setup.py install for requests 09:23:18 INFO - Running setup.py install for docopt 09:23:18 INFO - Successfully installed blobuploader requests docopt 09:23:18 INFO - Cleaning up... 09:23:18 INFO - Return code: 0 09:23:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:18 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')]} 09:23:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:18 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')]} 09:23:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:18 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 0x18fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb570>, '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 0x1bbc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc900>, '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': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', '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 09:23:18 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 09:23:18 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 09:23:18 INFO - Using env: {'DISPLAY': ':0', 09:23:18 INFO - 'HOME': '/home/cltbld', 09:23:18 INFO - 'LANG': 'en_US.UTF-8', 09:23:18 INFO - 'LANGUAGE': 'en_US:en', 09:23:18 INFO - 'LOGNAME': 'cltbld', 09:23:18 INFO - 'MAIL': '/var/mail/cltbld', 09:23:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:18 INFO - 'MOZ_NO_REMOTE': '1', 09:23:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:18 INFO - 'NO_EM_RESTART': '1', 09:23:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:18 INFO - 'PWD': '/builds/slave/test', 09:23:18 INFO - 'SHELL': '/bin/bash', 09:23:18 INFO - 'SHLVL': '1', 09:23:18 INFO - 'TERM': 'linux', 09:23:18 INFO - 'TMOUT': '86400', 09:23:18 INFO - 'USER': 'cltbld', 09:23:18 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', 09:23:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:18 INFO - '_': '/tools/buildbot/bin/python'} 09:23:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:18 INFO - Running setup.py (path:/tmp/pip-ihoGIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:18 INFO - Running setup.py (path:/tmp/pip-Jzs_IP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:19 INFO - Running setup.py (path:/tmp/pip-WqAe1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:19 INFO - Running setup.py (path:/tmp/pip-N2ttZa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:19 INFO - Running setup.py (path:/tmp/pip-2CWHLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:19 INFO - Running setup.py (path:/tmp/pip-JeahuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:19 INFO - Running setup.py (path:/tmp/pip-kYhwKz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:19 INFO - Running setup.py (path:/tmp/pip-MvAZVH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:19 INFO - Running setup.py (path:/tmp/pip-IrSlyX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:19 INFO - Running setup.py (path:/tmp/pip-7IsCmf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:19 INFO - Running setup.py (path:/tmp/pip-sf7TVy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:19 INFO - Running setup.py (path:/tmp/pip-sU2fRF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:19 INFO - Running setup.py (path:/tmp/pip-apreYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:19 INFO - Running setup.py (path:/tmp/pip-Igf_va-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:19 INFO - Running setup.py (path:/tmp/pip-FE8_AE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:19 INFO - Running setup.py (path:/tmp/pip-HvNF2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:20 INFO - Running setup.py (path:/tmp/pip-0v1Y0j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:23:20 INFO - Running setup.py install for manifestparser 09:23:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:23:20 INFO - Running setup.py install for mozcrash 09:23:20 INFO - Running setup.py install for mozdebug 09:23:20 INFO - Running setup.py install for mozdevice 09:23:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:23:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:23:20 INFO - Running setup.py install for mozfile 09:23:20 INFO - Running setup.py install for mozhttpd 09:23:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:23:20 INFO - Running setup.py install for mozinfo 09:23:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:23:20 INFO - Running setup.py install for mozInstall 09:23:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:23:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:23:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:23:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:23:20 INFO - Running setup.py install for mozleak 09:23:20 INFO - Running setup.py install for mozlog 09:23:21 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for moznetwork 09:23:21 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozprocess 09:23:21 INFO - Running setup.py install for mozprofile 09:23:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozrunner 09:23:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Running setup.py install for mozscreenshot 09:23:21 INFO - Running setup.py install for moztest 09:23:21 INFO - Running setup.py install for mozversion 09:23:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:23:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:23:21 INFO - Cleaning up... 09:23:21 INFO - Return code: 0 09:23:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:21 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 0x18fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb570>, '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 0x1bbc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc900>, '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': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', '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 09:23:21 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 09:23:21 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 09:23:21 INFO - Using env: {'DISPLAY': ':0', 09:23:21 INFO - 'HOME': '/home/cltbld', 09:23:21 INFO - 'LANG': 'en_US.UTF-8', 09:23:21 INFO - 'LANGUAGE': 'en_US:en', 09:23:21 INFO - 'LOGNAME': 'cltbld', 09:23:21 INFO - 'MAIL': '/var/mail/cltbld', 09:23:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:21 INFO - 'MOZ_NO_REMOTE': '1', 09:23:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:21 INFO - 'NO_EM_RESTART': '1', 09:23:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:21 INFO - 'PWD': '/builds/slave/test', 09:23:21 INFO - 'SHELL': '/bin/bash', 09:23:21 INFO - 'SHLVL': '1', 09:23:21 INFO - 'TERM': 'linux', 09:23:21 INFO - 'TMOUT': '86400', 09:23:21 INFO - 'USER': 'cltbld', 09:23:21 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', 09:23:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:21 INFO - '_': '/tools/buildbot/bin/python'} 09:23:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:23:22 INFO - Running setup.py (path:/tmp/pip-9quF6z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:23:22 INFO - Running setup.py (path:/tmp/pip-3N_eSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:23:22 INFO - Running setup.py (path:/tmp/pip-iTRmZf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:23:22 INFO - Running setup.py (path:/tmp/pip-NXk3cA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:23:22 INFO - Running setup.py (path:/tmp/pip-aVVJ2y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:23:22 INFO - Running setup.py (path:/tmp/pip-GKuxq5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:23:22 INFO - Running setup.py (path:/tmp/pip-bayqCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:23:22 INFO - Running setup.py (path:/tmp/pip-5T4hqh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:23:22 INFO - Running setup.py (path:/tmp/pip-qQ_dAH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:23:22 INFO - Running setup.py (path:/tmp/pip-pTnHNR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:23:22 INFO - Running setup.py (path:/tmp/pip-O1OZ8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:23:22 INFO - Running setup.py (path:/tmp/pip-ekcXqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:23:22 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)) 09:23:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:23:22 INFO - Running setup.py (path:/tmp/pip-dmT3bL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:23:23 INFO - Running setup.py (path:/tmp/pip-PX5Rx4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:23 INFO - Running setup.py (path:/tmp/pip-GIJta5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:23:23 INFO - Running setup.py (path:/tmp/pip-Cqy8jo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:23:23 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)) 09:23:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:23:23 INFO - Running setup.py (path:/tmp/pip-VyKSKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:23:23 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)) 09:23:23 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)) 09:23:23 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)) 09:23:23 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)) 09:23:23 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)) 09:23:23 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)) 09:23:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:23:23 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 09:23:23 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 09:23:23 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 09:23:23 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 09:23:23 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 09:23:23 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 09:23:25 INFO - Downloading blessings-1.6.tar.gz 09:23:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:23:25 INFO - Installing collected packages: blessings 09:23:25 INFO - Running setup.py install for blessings 09:23:25 INFO - Successfully installed blessings 09:23:25 INFO - Cleaning up... 09:23:25 INFO - Return code: 0 09:23:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:23:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:25 INFO - Reading from file tmpfile_stdout 09:23:25 INFO - Current package versions: 09:23:25 INFO - argparse == 1.2.1 09:23:25 INFO - blessings == 1.6 09:23:25 INFO - blobuploader == 1.2.4 09:23:25 INFO - docopt == 0.6.1 09:23:25 INFO - functools32 == 3.2.3-2 09:23:25 INFO - jsonschema == 2.5.1 09:23:25 INFO - manifestparser == 1.1 09:23:25 INFO - mozInstall == 1.12 09:23:25 INFO - mozcrash == 0.17 09:23:25 INFO - mozdebug == 0.1 09:23:25 INFO - mozdevice == 0.48 09:23:25 INFO - mozfile == 1.2 09:23:25 INFO - mozhttpd == 0.7 09:23:25 INFO - mozinfo == 0.9 09:23:25 INFO - mozleak == 0.1 09:23:25 INFO - mozlog == 3.2 09:23:25 INFO - moznetwork == 0.27 09:23:25 INFO - mozprocess == 0.22 09:23:25 INFO - mozprofile == 0.28 09:23:25 INFO - mozrunner == 6.11 09:23:25 INFO - mozscreenshot == 0.1 09:23:25 INFO - mozsystemmonitor == 0.3 09:23:25 INFO - moztest == 0.7 09:23:25 INFO - mozversion == 1.4 09:23:25 INFO - psutil == 3.1.1 09:23:25 INFO - requests == 1.2.3 09:23:25 INFO - wsgiref == 0.1.2 09:23:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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')]} 09:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:25 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 0x18fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb570>, '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 0x1bbc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc900>, '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': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', '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 09:23:25 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 09:23:25 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 09:23:25 INFO - Using env: {'DISPLAY': ':0', 09:23:25 INFO - 'HOME': '/home/cltbld', 09:23:25 INFO - 'LANG': 'en_US.UTF-8', 09:23:25 INFO - 'LANGUAGE': 'en_US:en', 09:23:25 INFO - 'LOGNAME': 'cltbld', 09:23:25 INFO - 'MAIL': '/var/mail/cltbld', 09:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:25 INFO - 'MOZ_NO_REMOTE': '1', 09:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:25 INFO - 'NO_EM_RESTART': '1', 09:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:25 INFO - 'PWD': '/builds/slave/test', 09:23:25 INFO - 'SHELL': '/bin/bash', 09:23:25 INFO - 'SHLVL': '1', 09:23:25 INFO - 'TERM': 'linux', 09:23:25 INFO - 'TMOUT': '86400', 09:23:25 INFO - 'USER': 'cltbld', 09:23:25 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', 09:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:25 INFO - '_': '/tools/buildbot/bin/python'} 09:23:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:25 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)) 09:23:25 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)) 09:23:25 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)) 09:23:25 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)) 09:23:25 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)) 09:23:25 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)) 09:23:25 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)) 09:23:25 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)) 09:23:25 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)) 09:23:25 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)) 09:23:25 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)) 09:23:25 INFO - Cleaning up... 09:23:25 INFO - Return code: 0 09:23:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:23: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')]} 09:23:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:23:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23: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')]} 09:23:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:23:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:23:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x18fd030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1a608a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1b2c400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1bbb570>, '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 0x1bbc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc900>, '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': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', '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 09:23:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:23:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:23:25 INFO - Using env: {'DISPLAY': ':0', 09:23:25 INFO - 'HOME': '/home/cltbld', 09:23:25 INFO - 'LANG': 'en_US.UTF-8', 09:23:25 INFO - 'LANGUAGE': 'en_US:en', 09:23:25 INFO - 'LOGNAME': 'cltbld', 09:23:25 INFO - 'MAIL': '/var/mail/cltbld', 09:23:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:25 INFO - 'MOZ_NO_REMOTE': '1', 09:23:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:25 INFO - 'NO_EM_RESTART': '1', 09:23:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:25 INFO - 'PWD': '/builds/slave/test', 09:23:25 INFO - 'SHELL': '/bin/bash', 09:23:25 INFO - 'SHLVL': '1', 09:23:25 INFO - 'TERM': 'linux', 09:23:25 INFO - 'TMOUT': '86400', 09:23:25 INFO - 'USER': 'cltbld', 09:23:25 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', 09:23:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:25 INFO - '_': '/tools/buildbot/bin/python'} 09:23:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:23:26 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:23:26 INFO - Cleaning up... 09:23:26 INFO - Return code: 0 09:23:26 INFO - Running post-action listener: _resource_record_post_action 09:23:26 INFO - Running post-action listener: _start_resource_monitoring 09:23:26 INFO - Starting resource monitoring. 09:23:26 INFO - ##### 09:23:26 INFO - ##### Finished create-virtualenv step (success) 09:23:26 INFO - ##### 09:23:26 INFO - ##### 09:23:26 INFO - ##### Running install step. 09:23:26 INFO - ##### 09:23:26 INFO - Running pre-action listener: _resource_record_pre_action 09:23:26 INFO - Running main action method: install 09:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:23:26 INFO - Reading from file tmpfile_stdout 09:23:26 INFO - Detecting whether we're running mozinstall >=1.0... 09:23:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:23:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:23:26 INFO - Reading from file tmpfile_stdout 09:23:26 INFO - Output received: 09:23:26 INFO - Usage: mozinstall [options] installer 09:23:26 INFO - Options: 09:23:26 INFO - -h, --help show this help message and exit 09:23:26 INFO - -d DEST, --destination=DEST 09:23:26 INFO - Directory to install application into. [default: 09:23:26 INFO - "/builds/slave/test"] 09:23:26 INFO - --app=APP Application being installed. [default: firefox] 09:23:26 INFO - mkdir: /builds/slave/test/build/application 09:23:26 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'] 09:23:26 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 09:23:42 INFO - Reading from file tmpfile_stdout 09:23:42 INFO - Output received: 09:23:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:23:42 INFO - Running post-action listener: _resource_record_post_action 09:23:42 INFO - ##### 09:23:42 INFO - ##### Finished install step (success) 09:23:42 INFO - ##### 09:23:42 INFO - ##### 09:23:42 INFO - ##### Running run-tests step. 09:23:42 INFO - ##### 09:23:42 INFO - Running pre-action listener: _resource_record_pre_action 09:23:42 INFO - Running main action method: run_tests 09:23:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:23:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:23:42 INFO - Python 2.7.3 09:23:42 INFO - Return code: 0 09:23:42 INFO - grabbing minidump binary from tooltool 09:23: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')]} 09:23:42 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 0x1bbb570>, '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 0x1bbc470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1bbc900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:23:42 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 09:23:42 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 09:23:42 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 09:23:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:23:42 INFO - Return code: 0 09:23:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:23:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:23:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:23:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:23:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:23:42 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:23:42 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-054 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:23:42 INFO - Using env: {'DISPLAY': ':0', 09:23:42 INFO - 'HOME': '/home/cltbld', 09:23:42 INFO - 'LANG': 'en_US.UTF-8', 09:23:42 INFO - 'LANGUAGE': 'en_US:en', 09:23:42 INFO - 'LOGNAME': 'cltbld', 09:23:42 INFO - 'MAIL': '/var/mail/cltbld', 09:23:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:23:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:23:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:23:42 INFO - 'MOZ_NO_REMOTE': '1', 09:23:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:23:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:23:42 INFO - 'NO_EM_RESTART': '1', 09:23:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:23:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:23:42 INFO - 'PWD': '/builds/slave/test', 09:23:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:23:42 INFO - 'SHELL': '/bin/bash', 09:23:42 INFO - 'SHLVL': '1', 09:23:42 INFO - 'TERM': 'linux', 09:23:42 INFO - 'TMOUT': '86400', 09:23:42 INFO - 'USER': 'cltbld', 09:23:42 INFO - 'XDG_SESSION_COOKIE': 'cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163', 09:23:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:23:42 INFO - '_': '/tools/buildbot/bin/python'} 09:23:42 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-054', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:23:42 INFO - mozversion application_buildid: 20160704085124 09:23:42 INFO - mozversion application_changeset: 7eef107d8d310cc5c0419d3fd3bf7f74590da3db 09:23:42 INFO - mozversion application_display_name: Nightly 09:23:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:23:42 INFO - mozversion application_name: Firefox 09:23:43 INFO - mozversion application_remotingname: firefox 09:23:43 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:23:43 INFO - mozversion application_vendor: Mozilla 09:23:43 INFO - mozversion application_version: 50.0a1 09:23:43 INFO - mozversion platform_buildid: 20160704085124 09:23:43 INFO - mozversion platform_changeset: 7eef107d8d310cc5c0419d3fd3bf7f74590da3db 09:23:43 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:23:43 INFO - mozversion platform_version: 50.0a1 09:23:43 INFO - using testdate: 1467649422 09:23:43 INFO - actual date: 1467649422 09:23:43 INFO - starting webserver on 'localhost:53857' 09:23:43 INFO - SUITE-START | Running 2 tests 09:23:43 INFO - TEST-START | dromaeo_css 09:23:43 INFO - operating with platform_type : linux_ 09:23:43 INFO - Initialising browser for dromaeo_css test... 09:23:43 INFO - TEST-INFO | started process 18975 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW6oPe5/profile http://localhost:53857/getInfo.html) 09:23:47 INFO - PROCESS | 18975 | __metrics Screen width/height:1600/1200 09:23:47 INFO - PROCESS | 18975 | colorDepth:24 09:23:47 INFO - PROCESS | 18975 | Browser inner width/height: 1024/697 09:23:47 INFO - PROCESS | 18975 | __metrics 09:23:48 ERROR - PROCESS | 18975 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:23:49 INFO - TEST-INFO | 18975: exit 0 09:23:49 INFO - Browser initialized. 09:23:49 INFO - Running cycle 1/1 for dromaeo_css test... 09:23:49 INFO - TEST-INFO | started process 19096 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpW6oPe5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:01 INFO - PROCESS | 19096 | RSS: Main: 169713664 09:24:01 INFO - PROCESS | 19096 | 09:24:51 INFO - PROCESS | 19096 | 1467649491135 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] 09:27:03 INFO - PROCESS | 19096 | Cycle 1(1): loaded http://localhost:53857/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53857/tests/dromaeo/cssquery-ext.html) 09:27:04 INFO - PROCESS | 19096 | RSS: Main: 169287680 09:27:04 INFO - PROCESS | 19096 | 09:30:06 INFO - PROCESS | 19096 | Cycle 1(1): loaded http://localhost:53857/tests/dromaeo/cssquery-ext.html (next: http://localhost:53857/tests/dromaeo/cssquery-jquery.html) 09:30:07 INFO - PROCESS | 19096 | RSS: Main: 169525248 09:30:07 INFO - PROCESS | 19096 | 09:33:09 INFO - PROCESS | 19096 | Cycle 1(1): loaded http://localhost:53857/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53857/tests/dromaeo/cssquery-mootools.html) 09:33:09 INFO - PROCESS | 19096 | RSS: Main: 171802624 09:33:09 INFO - PROCESS | 19096 | 09:36:11 INFO - PROCESS | 19096 | Cycle 1(1): loaded http://localhost:53857/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53857/tests/dromaeo/cssquery-prototype.html) 09:36:12 INFO - PROCESS | 19096 | RSS: Main: 167825408 09:36:12 INFO - PROCESS | 19096 | 09:39:14 INFO - PROCESS | 19096 | Cycle 1(1): loaded http://localhost:53857/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53857/tests/dromaeo/cssquery-yui.html) 09:39:15 INFO - PROCESS | 19096 | RSS: Main: 169275392 09:39:15 INFO - PROCESS | 19096 | 09:42:18 INFO - PROCESS | 19096 | Cycle 1(1): loaded http://localhost:53857/tests/dromaeo/cssquery-yui.html (next: http://localhost:53857/tests/dromaeo/cssquery-dojo.html) 09:42:18 INFO - PROCESS | 19096 | RSS: Main: 170438656 09:42:18 INFO - PROCESS | 19096 | 09:42:18 INFO - PROCESS | 19096 | __start_tp_report 09:42:18 INFO - PROCESS | 19096 | _x_x_mozilla_page_load 09:42:18 INFO - PROCESS | 19096 | _x_x_mozilla_page_load_details 09:42:18 INFO - PROCESS | 19096 | |i|pagename|runs| 09:42:18 INFO - PROCESS | 19096 | |0;dojo.html;2623.1737002844106;2650.2446802661234;2661.9866900665493;2663.2010396880937;2675.78593712503;4727.763611819412;4771.069641419925;4797.280407938811;4817.735024573647;4825.662203645742;4768.141734487791;4808.350872632193;4811.783469743861;4817.807287708488;4827.951720482794;4388.824447022115;4423.6601365968645;4543.204939135655;4546.477155127153;4553.066621342617;555.736233821767;4352.455943007124;4400.471943366801;4448.599626033656;4494.1910456117885;4445.044315472157;4471.35165401015;4493.168763778679;4500.887477813081;4503.707259028152;4458.977705111453;4480.171168333869;4486.618637415823;4493.820247190109;4531.637469002472;4356.760378179199;4374.431323927869;4411.051623900845;4411.42651455312;4411.6250118739945;4772.069446457942;4811.855644330676;4835.975820120877;4853.417589889201;4924.8276310328965;5182.818601348935;5186.688798672092;5195.922061169085;5197.428282888879;5260.289860868772;5154.407243167008;5177.119889618773;5178.6116041297055;5187.19598462239;5207.270982062477;4802.399700037496;4826.493218212107;4830.830920917786;4851.466338702739;4885.755712214446;5257.894842103213;5297.894042119136;5304.549113325411;5309.681419114865;5313.1764576490705;5086.847394578169;5106.46382129871;5107.54032137102;5107.87230319245;5151.768170432265;5199.7140157291715;5200.895982080413;5209.921851172236;5221.216817477332;5247.711375874287;5000.2749601307605;5007.37407824022;5027.798888044437;5045.990801839646;5153.17549192135;5006.3491746073505;5034.421041580192;5037.647364684437;5047;5094.108531007133;4377.16833801583;4385.912281754411;4391.3412988051405;4393.406890069799;4433;3785.848566057382;3818.9427158592644;3820.2168555446065;3827.0623697194364;3878.7866667333005;4411.933820992687;4426.557344265548;4426.889327766768;4428.070105277863;4460.107978404332;5147;5154.690718556823;5156.432792392834;5168.715720635401;5196.68819870809;4385.342198670225;4433.556644335541;4450.688451808407;4463.04044630406;4505.662075344362;4711.316859055418;4719.905601888012;4728.290756386501;4768.356271903318;4779.402574678165;4829.975850120727;4851.296561998561;4856.5871900887405;4868.440129385166;4914.582260507826;5069.797208111634;5174.97412512935;5219.817306394258;5220.243064755665;5283.550898173698;4856.028794241237;4874.439439464507;4888.60891128716;4894.2658601210105;4935.481774413634;5120.103981803244;5161.277421160966;5166.2767212589515;5178.922316165336;5208.479152084761;5089.414717307557;5168.198929165986;5174.922376164285;5234.241035049972;5246.554042906396;5077.492250774893;5078.771455284447;5079.16193828029;5083.46623604531;5128.358955130609;5044.672096313728;5071.568916642127;5078.390593128848;5083.059633967728;5087.3132127163835;4871.610271178368;4887.731174785421;4943.307936888767;4954.8761280968265;4997.800087996439;5019.67372120811;5035;5047.4952504749235;5061.797528098982;5118.590512759045;4965.900681986268;4985.7257850817105;4990.47600002009;4993.500649934977;5030.974845125751 09:42:18 INFO - PROCESS | 19096 | |1;ext.html;546.2352706211304;559.1305519916531;561.1806762127294;566.2412367427647;586.809286981731;34939.301213975705;38635.227295454075;38713.22573548527;38761.612383876185;38908.22183556331;39253.411198832044;39405.802970985176;39739.801300993524;39789.204215915735;39879.60120398802;7791.571463569516;7875.763727088168;7925.841483170333;7937.166597507266;7951.960240198791;7890.64492097857;7913.485623434487;7977.760667179994;7984.800379990517;7992.48048876824;7896.091949425803;7918;7937.682492700314;7939.245771651684;7981.840363192733;7963.8805417918775;7968.7609371718945;7980.082290536605;7980.640871160812;7987.880181797249;7819.726309579138;7866.252705992922;7894.526328420313;7901.644426000844;7940.285374316281;37798.43302350467;38012;38211.235775284615;38325.616743832485;38345.61654383448;2487.7263501014872;2919.4453053919688;2944.661363943131;3007.3534190149003;3097.0399176255432;25606.359841003938;26979;28107.437851243067;28272.43455130886;28651.71348286532;3314.5193946877807;3377.5102610121394;3399.8980030599123;3487.808170550619;3497.877574284888;282441.5877920618;282963;282970;284015;284854;31936;32946;56326.43673563294;57043.71478142666;57098.714506427204;34005.489917651255;34021.31957360839;34111.14722131917;34138.14654633654;34205.657943420745;13159.407826647825;13235.073544851768;13283.867161328457;13287.601371958857;13328.733425331438;10823.56705731762;10890.61882834097;10948.671539853816;10982.670519884416;11020.228583999044;7942.483738556975;7985.760427187193;7986.241307075818;8035.357171426272;8068.556229407322;3095.5666206731075;3110.3623757129735;3111.844407779602;3124.8281344525813;3157.494800831856;887.6759982606302;891.8127193289482;908.3232991421434;930.5579849571535;970.5632465390603;27715.307117322227;28235.858820705766;28577.570476576166;28654;28928;934.6448349627234;951.9190868776093;970.2480577552312;971.7619183299995;1002.8946960569181;14843.165895080874;15068.773968390484;15245.16151611672;15310.923445382925;15371.538853834403;123411;124785.37607312087;409556;410207;412184;48504.7574762131;49518.75240623846;49684.50315496871;49803.01181929096;49817.25274120891;1130.4121856634504;1135.0805847263744;1154.0594415551132;1154.1228666213738;1159.9594014209463;26825.195244142706;27866.44267114606;27973.30066748266;28344.71655283421;28514;41819.7909010453;41919.161616768106;42017.15965680731;42152;42195.3670694946;323914;331035;332337;333134;333205;24793.504129917663;25200.621990669788;25393.365165870262;25428.49143017092;25521.48957020886;40828.1834363317;42136.789316053226;42425.57574424216;42467.1506569873;42485.362719558616;36920;37192.256154877294;37341;37596.2480750378;37887.62112378951;36894;36952.81523592365;37133.442998354505;37275.81362093172;37647.623523765506;35578.8221058893;35637.64362356447;35752.64247357493;35906.8204658975;35979;31699.20751981219;32592.837035814668;33189.50215746718;33207.501887471226;33466.83266583652;25334.239972800846;25335.87332063328;25359.746402535737;26181.73818261793;26228.8688556556 09:42:18 INFO - PROCESS | 19096 | |2;jquery.html;373.34291646701803;376.17242067451616;380.16363999201764;383.8407061069656;394.63101999630345;16606.584835379123;17087.23107460164;17619.91190044051;17966.550836229086;18128.999999999967;10887.455627218647;11179.66461006171;11183.776324473505;11200.887991120086;11233.60682376117;4442.644588432918;4687.460941991663;5297.205419187114;5317.3619165700175;5342.0651386007485;5150.639455238135;5232.136697444917;5236.4763523647525;5259.6055295852775;5272.024675435056;5057.848264552069;5180.378354597435;5185.351831021122;5214.713190774506;5232.869178270555;5176.0683077046115;5181.4300426953005;5227.085260079471;5229.999999999981;5247.10799164143;4695.413073365829;4902.166631672624;5198.714070726109;5233.764480598382;5264.842054738364;12896.677583060406;12921.160124591872;12959.092863499558;12969.610911672666;13042.608721738363;1825.4158669225853;1828.8902665840092;1858.9907050464797;1899.6105798311312;2370.431096536836;9318;9467.763305917339;9540.904590954071;9756;9783.36408133469;1673.8242484539069;1712.469134568288;1712.9379784533544;1717.9484615461556;1762.34740285646;56838;62611.37388626146;69096.6545167271;69737.3026269741;69822.30177698209;9966.501674916226;10085.092341689136;10103.54534045955;10178.847317290247;10562.577496900038;13353.265570393722;13424.93287533556;13430.798538021938;13442.260675662932;13481.59555213345;7233.168185658611;7588.886166707503;7722.266384693445;7773.183815699384;7775.455718099679;7434.405247580181;7444.8883266751045;7558.168601453835;7562.168161502341;7609.201033891472;4387.298032314814;4399.868003959887;4408.933865992013;4500.537325369268;4584.564466375689;1886.8867867927968;1889.6976483762533;1905.1902941249914;1925.2876435718874;1930.8165724256173;755.4258763339901;778.8909552662632;829.6639860856363;869.0527325215545;918.1186061381148;16773.412930547373;17055.147242638068;17216.655666886592;17555.73666395005;17780.3776867809;845.2097289034772;850.6129710981488;856.9785755356166;877.1623099939543;905.8822353094056;9484.715458536255;9529.332946693803;9679.274054445945;9718.368306060083;9985.850212246822;406830;417320.4803855889;419318;419882;419915;70757.64621176862;76430.23569764342;77235;77272.22727772762;77372.61313693396;969.9078587534173;976.9999999999858;981.0826876870007;1019.5768755966191;1020.7805321855836;16685;16837.41069062577;16914;17025;17293.65412691764;32756.508652369757;37618.81190594139;38851.805740972246;39786.403203951384;40744.79627601843;54470.18294725503;56036.719816402285;56476;56657.71671141618;56771.432285676616;7679.424043196671;7790.220977902164;7830.099538552911;7982.880256796268;8036.357091432788;12095.879041209475;12290.385480725748;12425.13024088305;12466.376681166086;12529.749405012031;10777.137828973506;10796.190285728444;10821.51303191374;11095.667129986114;11207.495662695035;10401;10508.78982420332;10638.361698298128;10839.566417343218;11038.448077595927;10384.221183411124;10538.736531586772;10652.946735266274;10846.728831779268;10904.236703430684;6625.304343043911;6927.7228910845015;7038.929610704033;7153.105861767279;8010.879836802569;7465.58939258346;8702.433561958907;9223.815523689354;9400.388974716896;9485.952570237381 09:42:18 INFO - PROCESS | 19096 | |3;mootools.html;1383.5849245226436;1410.612081677539;1497.6779992301654;1685.6851655708535;1727.4213138598577;6884.139482564679;7455.0681164854395;7672.347850432713;8159.265666090051;8167.264946154853;7721.266479684435;8017.7594672159785;8049.557274349909;8056.0735515415745;8069.072056713465;2209.9005544750526;2240.8879556022216;2259.954800903981;2261.072960086365;2267.875266860322;2198.857074290166;2207.1612787140866;2221.9888900555475;2229.7658745831695;2231.631780756173;2254.413852398372;2256.8194544436487;2258.0741895822716;2265.3090807303765;2272.4318920269934;2123.4160605833363;2136.7222261106112;2143.9999999999923;2146.1844499090403;2149.720536330275;2163.3077415227135;2165.4261620670536;2172.424307558498;2178.9782102178933;2193.9561208775895;7964.920350796534;8006.9199308006755;8007.559584222866;8037.879431808527;8096.635651395702;4406.317020861739;4459.487158976727;4512.142692888341;4513.909721805546;4513.932291015604;2885.4851203118533;3017.215523963785;3049.1005153479555;3065.524843649238;3070.3245286037036;996.1781530237511;1025.574386629548;1032.0659802878406;1037.2272656870605;1052.2476429352973;10241.795164096677;10247.6413325534;10334.276600637959;10350.689479315633;10370.844437333446;3978.1049263915966;4067.613576710208;4198.097409057067;4210.368444733314;4238.830446782094;8921.063288354759;8957.955210223907;9007.414518056436;9015.098490150933;9033.77415564603;4560.110778398247;4572.0627271409285;4608.5621865922685;4619.930701039487;4620.214563524209;3599.9100022499647;4076.286649836267;4215.768132752728;4230.5769423057445;4275.337322714984;3669.339518886626;3718.5537735471917;3781.640744129303;3796.0699628591174;3932.842686292516;1197.3414621957888;1210.1105687319814;1216.3370962825281;1218.9085818563642;1221.3709939381226;706.427793487277;860.6858496648678;863.8099618084011;865.4504389712578;875.6584931876573;5212.374515058142;5264.473552644705;5295.4969277918535;5365.678059316453;5480.3971563128025;406.61371696888074;411.57402088838506;412.23736088236524;420.926337890874;422.54154242646456;3702.0559757261726;3726.1988672435555;3753.7935413551972;3756.567994680592;3784.8864534064023;9205.217556507638;9642.180414664692;9646.842378914575;9653.806923861483;9738.415695058178;9519.571619277149;9521.381110227812;9598.32811703174;9600.66397676078;9617.374870633386;7268.38218751412;7353.6323183840595;7375;7384.261573842573;7422.703091876372;5099.1331473648825;5166.767495462638;5225.843224703265;5236.633435659467;5300.70846103468;9007.054259302678;9044.547772611475;9061.637534498546;9075.2286055686;9090.318226132935;8540.530270835165;8947.150020748019;8962.641494340414;9185.357025008452;9259.074092590687;6066.878662426815;6611.603303801788;6713.597184168965;6813.3527314905;6875.449964002768;7784.026996625422;7791.766247012599;7798.298153166243;7813.1796161402235;7814.296713295831;6679.098321726505;6877.793666190022;6896.103506544117;6907.240203577502;7052.365287124184;7062.858742825218;7086.433085353263;7100.467464940253;7163.8567228656175;7227.27727227273;6373.235211774617;6401.519886008475;6408.327125651926;6431.260405053479;6457.61254324742;4513.909721805479;4518.457785065813;4542.1824071667415;4602.539746025371;4612;4639.164950308842;4701.247800351927;4701.670883038155;4711.269753188261;4772.355731976278 09:42:18 INFO - PROCESS | 19096 | |4;prototype.html;304.5842425089753;307.41744394372665;314.64759469394284;317.6347200719171;318.0585467017628;4981.850544483671;5073.061483625532;5172.215585622958;5225.372955245366;5238.7642556084975;5121.487851214877;5164.122099243138;5176.689398636075;5177.792888284464;5182.352205974254;4058.2289365020697;4068.41008053832;4077.103037331782;4080.795960201993;4088.8364465421346;3940.290747665419;4077.2864748669012;4085.8978525536804;4093.89765255868;4098.97950510247;4022;4024.5170579530495;4039.7172197946156;4046.858359957402;4059.9188016239805;4044.090079732066;4045.170739998308;4048.251073551388;4052.1895620875944;4059.411385349108;3333.1333853198344;3435.793852368841;3475.4091804393315;3476.739244556643;3600.6219346968455;5017.9247311290355;5034.270030845507;5036.345275114211;5038.622103342264;5068.290439338495;4550.749708766017;4568.977155114237;4571.702839315467;4573.954260457386;4584.381108550337;5072.467390923936;5341.599380046512;5410.215518749798;5414.7834086636485;5433.212184233304;3778.1688028633657;3797.9810100949317;3801.657850793414;3808.315137827825;3809.5428548574073;5639.943600563983;5643.520300774439;5653.9151912721345;5683.2895888014;5693.3168019837885;3758.6241375862196;3818.1409182933617;3865.96134038656;3870.303345397799;3874.5544262410185;3931.68546516278;3936.3505021671103;3945.230680017369;3947.2500224957166;3970.1662650843646;4533.206688829442;4558.384618076583;4564.360989461478;4570.811588986888;4571.771411429415;5211.869703257449;5391.514763671288;5458.836234912959;5459.945400546023;5470.8085217017215;1338.9288569144646;1368.2269517722455;1371.636516323175;1373.4368908747565;1374.7077746917864;848.4188330993289;855.3755758296478;884.7832281091174;889.235257678396;892.8973168085623;4264.680148988777;4311.568843115663;4313.525512193656;4319.460067491564;4336.241157797373;4968.8757781055765;4990;5009.897822479049;5033.446320904697;5044.074436826631;4260.211860805699;4287.742735435884;4310.7629080400875;4335.479742430865;4341.522432532419;2776.2232171410315;3020.9244768880953;3024.5311976643657;3037.893673721409;3044.8782048717803;5225.921611175835;5244.423113457517;5248.711320877312;5260.289860868734;5265.605079619044;5429.457054294539;5685.744141513642;5709.058005429058;5737.282839645044;5795.855103622359;5180.559652429586;5215.139501982207;5226.163813789775;5227.764750586157;5230.660007099526;5620.915686264628;5637.182608521824;5655.324039374275;5675.31896172462;5679.659220446786;5210.088234558862;5491.835244942658;5521.668699878021;5559.805406810742;5583.330000399978;5197.1164901966;5218.582513398843;5260.763265652979;5263.473652634706;5271.262023316662;3609.260101679202;3717.8326975285636;3822.3119838429348;3835.964289641837;3853.2660302864383;5567.777288908398;5568.693721845338;5595.237500187428;5603.915941260802;5610.971945140248;5256.553192978639;5407.459254074561;5418.295621569171;5426.728663566885;5445.373782015119;5289.6032797539565;5367.819079802437;5384.6499977501335;5387.757550910297;5432.29380180574;5298.81454149103;5322.441143679858;5346.893062138814;5367.490088441592;5369.597280203922;5287.418383977682;5427.24018637399;5451.264079349396;5451.700156491431;5469.453054694499;5298.966701493326;5322.760475778522;5334.226537152169;5359.946400536101;5366.570674345965 09:42:18 INFO - PROCESS | 19096 | |5;yui.html;656.2256537286003;664.5215444879688;673.8685956238536;742.3281929853483;748.2779118150986;12559.748805023906;13206.141600795941;13595.04834661574;13605.183688978668;14092.929535352334;13394.263315517643;13440.52958146465;13536.864631353683;13548.322583870817;13552.864471355284;625.2996643758996;767.5509826751357;777;793.0245797668871;794.7258195922426;779.7660701789468;791.5369508837337;792.7700966719644;794.6384395100215;796.9800754981114;839.8824164616958;840.6007146605344;841.0790184747691;841.7222316635496;844.4806444036903;836.0928392693935;836.188896770135;839.1943734015352;839.2488722593306;841.305922613843;611.9724612392453;612.8712970276202;612.9356417576134;613.7637009751234;614.5176036811082;12176.878231217663;12193.39033048344;12249.142560020802;12263.570775022921;12326.445309961073;13094.738105237842;13401.46394144233;13475.326233688276;13476.595702128952;13620.863791362059;10899;10921.235513513977;10942.56229750809;11078.723031924266;11103.83344249837;3283.1299705577803;3327.633960264369;3331.983340083308;3333.2000319923045;3402.5916889973114;61291.6687366488;61947.38052619461;64040.35959640437;64710;65032;10056.446895420675;10165.847512287322;10198.133158681596;10225.079742823033;10230.437325946996;19221.03894805254;19253.32613358526;19256.807431925783;19439.416817495214;19953.60092798165;6407.807765767035;6563.3764792344655;6581.440577550866;6710.127683401127;6802.217744959294;3473.8610455581997;3741.6258374162912;3813.1992281620614;3821.6751576115785;3913.0413048803225;2839.772818174541;3233.611966564027;3467.9653203468147;3487.05849420655;3490.6683865032783;582.432128674539;585.4145854145854;595.0835713001928;598.1924402057275;598.2312728144401;472.60301346868107;568.1335962656981;584.3893131677407;586.3784388548067;612.5773216480615;8400.78998025042;8568;8710.69512567057;8913.732588022369;8982.281417486585;484.8545436369075;495.76946719775475;553.9529140023062;575.0741306496537;616.5529990756755;4010.458588090629;4078.5921407858978;4201.096764195712;4290.099079193342;4312.310030395121;112065;114730.42634786773;115736.42131789288;117496;118466.4076679611;100916.49541752244;101168;102269;102653;103331.45002824963;48000;63506.364936350044;63573;65031;70427;8693.913060869563;8712.825743485222;8855.690050848447;8946.821063578822;9111.681091161778;44687.55312446834;45138.77430612826;45884.31173532466;46753.53246467628;48022.279665804344;62548;67175.32824671887;67369;67815.66092169507;68268;11324.94337528307;11521.88478115208;11553.191276610556;11728.589499367481;11759.353235571783;12936.159149655243;13358.465661373824;13435.731285374433;14178;14302.141871487744;10739.624113156002;10904.7273818152;10921.890781092088;11244.325340479598;11479.655610331703;11874.346910919638;11978.820317695066;12239.449224785085;12496.87503124957;12572.811407829073;11553;11979.580714674945;11985.34080625574;12425;12624.684382890502;9730.513474326113;9964.50177491137;10025.649102281384;10066.44634545107;10147.949260253652;10474.895251047392;10499.790004200026;10561.683149505527;10616.1507079435;10721.624743133953 09:42:18 INFO - PROCESS | 19096 | __end_tp_report 09:42:18 INFO - PROCESS | 19096 | __start_cc_report 09:42:18 INFO - PROCESS | 19096 | _x_x_mozilla_cycle_collect,389 09:42:18 INFO - PROCESS | 19096 | __end_cc_report 09:42:18 INFO - PROCESS | 19096 | __startTimestamp1467650538510__endTimestamp 09:42:18 INFO - PROCESS | 19096 | 09:42:18 INFO - PROCESS | 19096 | ------- Summary: start ------- 09:42:18 INFO - PROCESS | 19096 | Number of tests: 6 09:42:18 INFO - PROCESS | 19096 | 09:42:18 INFO - PROCESS | 19096 | [#0] dojo.html Cycles:165 Average:4757.11 Median:4894.27 stddev:603.31 (12.3%) stddev-sans-first:581.47 09:42:18 INFO - PROCESS | 19096 | Values: 2623.2 2650.2 2662.0 2663.2 2675.8 4727.8 4771.1 4797.3 4817.7 4825.7 4768.1 4808.4 4811.8 4817.8 4828.0 4388.8 4423.7 4543.2 4546.5 4553.1 555.7 4352.5 4400.5 4448.6 4494.2 4445.0 4471.4 4493.2 4500.9 4503.7 4459.0 4480.2 4486.6 4493.8 4531.6 4356.8 4374.4 4411.1 4411.4 4411.6 4772.1 4811.9 4836.0 4853.4 4924.8 5182.8 5186.7 5195.9 5197.4 5260.3 5154.4 5177.1 5178.6 5187.2 5207.3 4802.4 4826.5 4830.8 4851.5 4885.8 5257.9 5297.9 5304.5 5309.7 5313.2 5086.8 5106.5 5107.5 5107.9 5151.8 5199.7 5200.9 5209.9 5221.2 5247.7 5000.3 5007.4 5027.8 5046.0 5153.2 5006.3 5034.4 5037.6 5047.0 5094.1 4377.2 4385.9 4391.3 4393.4 4433.0 3785.8 3818.9 3820.2 3827.1 3878.8 4411.9 4426.6 4426.9 4428.1 4460.1 5147.0 5154.7 5156.4 5168.7 5196.7 4385.3 4433.6 4450.7 4463.0 4505.7 4711.3 4719.9 4728.3 4768.4 4779.4 4830.0 4851.3 4856.6 4868.4 4914.6 5069.8 5175.0 5219.8 5220.2 5283.6 4856.0 4874.4 4888.6 4894.3 4935.5 5120.1 5161.3 5166.3 5178.9 5208.5 5089.4 5168.2 5174.9 5234.2 5246.6 5077.5 5078.8 5079.2 5083.5 5128.4 5044.7 5071.6 5078.4 5083.1 5087.3 4871.6 4887.7 4943.3 4954.9 4997.8 5019.7 5035.0 5047.5 5061.8 5118.6 4965.9 4985.7 4990.5 4993.5 5031.0 09:42:18 INFO - PROCESS | 19096 | 09:42:18 INFO - PROCESS | 19096 | [#1] ext.html Cycles:180 Average:44963.13 Median:36436.50 stddev:83228.93 (228.4%) stddev-sans-first:83395.59 09:42:18 INFO - PROCESS | 19096 | Values: 546.2 559.1 561.2 566.2 586.8 34939.3 38635.2 38713.2 38761.6 38908.2 39253.4 39405.8 39739.8 39789.2 39879.6 7791.6 7875.8 7925.8 7937.2 7952.0 7890.6 7913.5 7977.8 7984.8 7992.5 7896.1 7918.0 7937.7 7939.2 7981.8 7963.9 7968.8 7980.1 7980.6 7987.9 7819.7 7866.3 7894.5 7901.6 7940.3 37798.4 38012.0 38211.2 38325.6 38345.6 2487.7 2919.4 2944.7 3007.4 3097.0 25606.4 26979.0 28107.4 28272.4 28651.7 3314.5 3377.5 3399.9 3487.8 3497.9 282441.6 282963.0 282970.0 284015.0 284854.0 31936.0 32946.0 56326.4 57043.7 57098.7 34005.5 34021.3 34111.1 34138.1 34205.7 13159.4 13235.1 13283.9 13287.6 13328.7 10823.6 10890.6 10948.7 10982.7 11020.2 7942.5 7985.8 7986.2 8035.4 8068.6 3095.6 3110.4 3111.8 3124.8 3157.5 887.7 891.8 908.3 930.6 970.6 27715.3 28235.9 28577.6 28654.0 28928.0 934.6 951.9 970.2 971.8 1002.9 14843.2 15068.8 15245.2 15310.9 15371.5 123411.0 124785.4 409556.0 410207.0 412184.0 48504.8 49518.8 49684.5 49803.0 49817.3 1130.4 1135.1 1154.1 1154.1 1160.0 26825.2 27866.4 27973.3 28344.7 28514.0 41819.8 41919.2 42017.2 42152.0 42195.4 323914.0 331035.0 332337.0 333134.0 333205.0 24793.5 25200.6 25393.4 25428.5 25521.5 40828.2 42136.8 42425.6 42467.2 42485.4 36920.0 37192.3 37341.0 37596.2 37887.6 36894.0 36952.8 37133.4 37275.8 37647.6 35578.8 35637.6 35752.6 35906.8 35979.0 31699.2 32592.8 33189.5 33207.5 33466.8 25334.2 25335.9 25359.7 26181.7 26228.9 09:42:18 INFO - PROCESS | 19096 | 09:42:18 INFO - PROCESS | 19096 | [#2] jquery.html Cycles:180 Average:24812.48 Median:4542.55 stddev:68659.93 (1511.5%) stddev-sans-first:68828.02 09:42:18 INFO - PROCESS | 19096 | Values: 373.3 376.2 380.2 383.8 394.6 16606.6 17087.2 17619.9 17966.6 18129.0 10887.5 11179.7 11183.8 11200.9 11233.6 4442.6 4687.5 5297.2 5317.4 5342.1 5150.6 5232.1 5236.5 5259.6 5272.0 5057.8 5180.4 5185.4 5214.7 5232.9 5176.1 5181.4 5227.1 5230.0 5247.1 4695.4 4902.2 5198.7 5233.8 5264.8 12896.7 12921.2 12959.1 12969.6 13042.6 1825.4 1828.9 1859.0 1899.6 2370.4 9318.0 9467.8 9540.9 9756.0 9783.4 1673.8 1712.5 1712.9 1717.9 1762.3 56838.0 62611.4 69096.7 69737.3 69822.3 9966.5 10085.1 10103.5 10178.8 10562.6 13353.3 13424.9 13430.8 13442.3 13481.6 7233.2 7588.9 7722.3 7773.2 7775.5 7434.4 7444.9 7558.2 7562.2 7609.2 4387.3 4399.9 4408.9 4500.5 4584.6 1886.9 1889.7 1905.2 1925.3 1930.8 755.4 778.9 829.7 869.1 918.1 16773.4 17055.1 17216.7 17555.7 17780.4 845.2 850.6 857.0 877.2 905.9 9484.7 9529.3 9679.3 9718.4 9985.9 406830.0 417320.5 419318.0 419882.0 419915.0 70757.6 76430.2 77235.0 77272.2 77372.6 969.9 977.0 981.1 1019.6 1020.8 16685.0 16837.4 16914.0 17025.0 17293.7 32756.5 37618.8 38851.8 39786.4 40744.8 54470.2 56036.7 56476.0 56657.7 56771.4 7679.4 7790.2 7830.1 7982.9 8036.4 12095.9 12290.4 12425.1 12466.4 12529.7 10777.1 10796.2 10821.5 11095.7 11207.5 10401.0 10508.8 10638.4 10839.6 11038.4 10384.2 10538.7 10652.9 10846.7 10904.2 6625.3 6927.7 7038.9 7153.1 8010.9 7465.6 8702.4 9223.8 9400.4 9486.0 09:42:18 INFO - PROCESS | 19096 | 09:42:18 INFO - PROCESS | 19096 | [#3] mootools.html Cycles:180 Average:5168.30 Median:4701.46 stddev:2884.71 (61.4%) stddev-sans-first:2878.78 09:42:18 INFO - PROCESS | 19096 | Values: 1383.6 1410.6 1497.7 1685.7 1727.4 6884.1 7455.1 7672.3 8159.3 8167.3 7721.3 8017.8 8049.6 8056.1 8069.1 2209.9 2240.9 2260.0 2261.1 2267.9 2198.9 2207.2 2222.0 2229.8 2231.6 2254.4 2256.8 2258.1 2265.3 2272.4 2123.4 2136.7 2144.0 2146.2 2149.7 2163.3 2165.4 2172.4 2179.0 2194.0 7964.9 8006.9 8007.6 8037.9 8096.6 4406.3 4459.5 4512.1 4513.9 4513.9 2885.5 3017.2 3049.1 3065.5 3070.3 996.2 1025.6 1032.1 1037.2 1052.2 10241.8 10247.6 10334.3 10350.7 10370.8 3978.1 4067.6 4198.1 4210.4 4238.8 8921.1 8958.0 9007.4 9015.1 9033.8 4560.1 4572.1 4608.6 4619.9 4620.2 3599.9 4076.3 4215.8 4230.6 4275.3 3669.3 3718.6 3781.6 3796.1 3932.8 1197.3 1210.1 1216.3 1218.9 1221.4 706.4 860.7 863.8 865.5 875.7 5212.4 5264.5 5295.5 5365.7 5480.4 406.6 411.6 412.2 420.9 422.5 3702.1 3726.2 3753.8 3756.6 3784.9 9205.2 9642.2 9646.8 9653.8 9738.4 9519.6 9521.4 9598.3 9600.7 9617.4 7268.4 7353.6 7375.0 7384.3 7422.7 5099.1 5166.8 5225.8 5236.6 5300.7 9007.1 9044.5 9061.6 9075.2 9090.3 8540.5 8947.2 8962.6 9185.4 9259.1 6066.9 6611.6 6713.6 6813.4 6875.4 7784.0 7791.8 7798.3 7813.2 7814.3 6679.1 6877.8 6896.1 6907.2 7052.4 7062.9 7086.4 7100.5 7163.9 7227.3 6373.2 6401.5 6408.3 6431.3 6457.6 4513.9 4518.5 4542.2 4602.5 4612.0 4639.2 4701.2 4701.7 4711.3 4772.4 09:42:18 INFO - PROCESS | 19096 | 09:42:18 INFO - PROCESS | 19096 | [#4] prototype.html Cycles:180 Average:4444.90 Median:5070.38 stddev:1306.07 (25.8%) stddev-sans-first:1272.23 09:42:18 INFO - PROCESS | 19096 | Values: 304.6 307.4 314.6 317.6 318.1 4981.9 5073.1 5172.2 5225.4 5238.8 5121.5 5164.1 5176.7 5177.8 5182.4 4058.2 4068.4 4077.1 4080.8 4088.8 3940.3 4077.3 4085.9 4093.9 4099.0 4022.0 4024.5 4039.7 4046.9 4059.9 4044.1 4045.2 4048.3 4052.2 4059.4 3333.1 3435.8 3475.4 3476.7 3600.6 5017.9 5034.3 5036.3 5038.6 5068.3 4550.7 4569.0 4571.7 4574.0 4584.4 5072.5 5341.6 5410.2 5414.8 5433.2 3778.2 3798.0 3801.7 3808.3 3809.5 5639.9 5643.5 5653.9 5683.3 5693.3 3758.6 3818.1 3866.0 3870.3 3874.6 3931.7 3936.4 3945.2 3947.3 3970.2 4533.2 4558.4 4564.4 4570.8 4571.8 5211.9 5391.5 5458.8 5459.9 5470.8 1338.9 1368.2 1371.6 1373.4 1374.7 848.4 855.4 884.8 889.2 892.9 4264.7 4311.6 4313.5 4319.5 4336.2 4968.9 4990.0 5009.9 5033.4 5044.1 4260.2 4287.7 4310.8 4335.5 4341.5 2776.2 3020.9 3024.5 3037.9 3044.9 5225.9 5244.4 5248.7 5260.3 5265.6 5429.5 5685.7 5709.1 5737.3 5795.9 5180.6 5215.1 5226.2 5227.8 5230.7 5620.9 5637.2 5655.3 5675.3 5679.7 5210.1 5491.8 5521.7 5559.8 5583.3 5197.1 5218.6 5260.8 5263.5 5271.3 3609.3 3717.8 3822.3 3836.0 3853.3 5567.8 5568.7 5595.2 5603.9 5611.0 5256.6 5407.5 5418.3 5426.7 5445.4 5289.6 5367.8 5384.6 5387.8 5432.3 5298.8 5322.4 5346.9 5367.5 5369.6 5287.4 5427.2 5451.3 5451.7 5469.5 5299.0 5322.8 5334.2 5359.9 5366.6 09:42:18 INFO - PROCESS | 19096 | 09:42:18 INFO - PROCESS | 19096 | [#5] yui.html Cycles:180 Average:18759.59 Median:3817.44 stddev:28040.63 (734.5%) stddev-sans-first:28086.34 09:42:18 INFO - PROCESS | 19096 | Values: 656.2 664.5 673.9 742.3 748.3 12559.7 13206.1 13595.0 13605.2 14092.9 13394.3 13440.5 13536.9 13548.3 13552.9 625.3 767.6 777.0 793.0 794.7 779.8 791.5 792.8 794.6 797.0 839.9 840.6 841.1 841.7 844.5 836.1 836.2 839.2 839.2 841.3 612.0 612.9 612.9 613.8 614.5 12176.9 12193.4 12249.1 12263.6 12326.4 13094.7 13401.5 13475.3 13476.6 13620.9 10899.0 10921.2 10942.6 11078.7 11103.8 3283.1 3327.6 3332.0 3333.2 3402.6 61291.7 61947.4 64040.4 64710.0 65032.0 10056.4 10165.8 10198.1 10225.1 10230.4 19221.0 19253.3 19256.8 19439.4 19953.6 6407.8 6563.4 6581.4 6710.1 6802.2 3473.9 3741.6 3813.2 3821.7 3913.0 2839.8 3233.6 3468.0 3487.1 3490.7 582.4 585.4 595.1 598.2 598.2 472.6 568.1 584.4 586.4 612.6 8400.8 8568.0 8710.7 8913.7 8982.3 484.9 495.8 554.0 575.1 616.6 4010.5 4078.6 4201.1 4290.1 4312.3 112065.0 114730.4 115736.4 117496.0 118466.4 100916.5 101168.0 102269.0 102653.0 103331.5 48000.0 63506.4 63573.0 65031.0 70427.0 8693.9 8712.8 8855.7 8946.8 9111.7 44687.6 45138.8 45884.3 46753.5 48022.3 62548.0 67175.3 67369.0 67815.7 68268.0 11324.9 11521.9 11553.2 11728.6 11759.4 12936.2 13358.5 13435.7 14178.0 14302.1 10739.6 10904.7 10921.9 11244.3 11479.7 11874.3 11978.8 12239.4 12496.9 12572.8 11553.0 11979.6 11985.3 12425.0 12624.7 9730.5 9964.5 10025.6 10066.4 10147.9 10474.9 10499.8 10561.7 10616.2 10721.6 09:42:18 INFO - PROCESS | 19096 | -------- Summary: end -------- 09:42:18 INFO - PROCESS | 19096 | 09:42:19 INFO - TEST-INFO | 19096: exit 0 09:42:19 INFO - TEST-OK | dromaeo_css | took 1116279ms 09:42:19 INFO - TEST-START | kraken 09:42:19 INFO - operating with platform_type : linux_ 09:42:19 INFO - Initialising browser for kraken test... 09:42:19 INFO - TEST-INFO | started process 19337 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcOGmqh/profile http://localhost:53857/getInfo.html) 09:42:24 INFO - PROCESS | 19337 | __metrics Screen width/height:1600/1200 09:42:24 INFO - PROCESS | 19337 | colorDepth:24 09:42:24 INFO - PROCESS | 19337 | Browser inner width/height: 1024/697 09:42:24 INFO - PROCESS | 19337 | __metrics 09:42:24 ERROR - PROCESS | 19337 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2968: TypeError: this.tabs is undefined 09:42:25 INFO - TEST-INFO | 19337: exit 0 09:42:25 INFO - Browser initialized. 09:42:25 INFO - Running cycle 1/1 for kraken test... 09:42:25 INFO - TEST-INFO | started process 19455 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpcOGmqh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:42:37 INFO - PROCESS | 19455 | RSS: Main: 169975808 09:42:37 INFO - PROCESS | 19455 | 09:42:40 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53857/tests/kraken/driver.html?testName=audio-beat-detection) 09:42:41 INFO - PROCESS | 19455 | RSS: Main: 174915584 09:42:41 INFO - PROCESS | 19455 | 09:42:44 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53857/tests/kraken/driver.html?testName=audio-dft) 09:42:44 INFO - PROCESS | 19455 | RSS: Main: 174874624 09:42:44 INFO - PROCESS | 19455 | 09:42:47 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53857/tests/kraken/driver.html?testName=audio-fft) 09:42:48 INFO - PROCESS | 19455 | RSS: Main: 169369600 09:42:48 INFO - PROCESS | 19455 | 09:42:50 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53857/tests/kraken/driver.html?testName=audio-oscillator) 09:42:51 INFO - PROCESS | 19455 | RSS: Main: 170000384 09:42:51 INFO - PROCESS | 19455 | 09:42:53 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53857/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:42:53 INFO - PROCESS | 19455 | RSS: Main: 170639360 09:42:53 INFO - PROCESS | 19455 | 09:42:57 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53857/tests/kraken/driver.html?testName=imaging-darkroom) 09:42:57 INFO - PROCESS | 19455 | RSS: Main: 171057152 09:42:57 INFO - PROCESS | 19455 | 09:43:01 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53857/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:01 INFO - PROCESS | 19455 | RSS: Main: 168112128 09:43:01 INFO - PROCESS | 19455 | 09:43:04 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53857/tests/kraken/driver.html?testName=json-parse-financial) 09:43:05 INFO - PROCESS | 19455 | RSS: Main: 169570304 09:43:05 INFO - PROCESS | 19455 | 09:43:07 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53857/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:43:07 INFO - PROCESS | 19455 | RSS: Main: 169836544 09:43:07 INFO - PROCESS | 19455 | 09:43:09 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53857/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:43:10 INFO - PROCESS | 19455 | RSS: Main: 169824256 09:43:10 INFO - PROCESS | 19455 | 09:43:12 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53857/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:43:13 INFO - PROCESS | 19455 | RSS: Main: 170061824 09:43:13 INFO - PROCESS | 19455 | 09:43:16 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:43:16 INFO - PROCESS | 19455 | RSS: Main: 170487808 09:43:16 INFO - PROCESS | 19455 | 09:43:19 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:43:20 INFO - PROCESS | 19455 | RSS: Main: 170598400 09:43:20 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | Cycle 1(1): loaded http://localhost:53857/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53857/tests/kraken/driver.html?testName=ai-astar) 09:43:22 INFO - PROCESS | 19455 | RSS: Main: 171323392 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | __start_tp_report 09:43:22 INFO - PROCESS | 19455 | _x_x_mozilla_page_load 09:43:22 INFO - PROCESS | 19455 | _x_x_mozilla_page_load_details 09:43:22 INFO - PROCESS | 19455 | |i|pagename|runs| 09:43:22 INFO - PROCESS | 19455 | |0;ai-astar;103;113;106;112;113;113;114;112;113;113 09:43:22 INFO - PROCESS | 19455 | |1;audio-beat-detection;158;123;144;178;124;157;146;122;186;124 09:43:22 INFO - PROCESS | 19455 | |2;audio-dft;165;164;163;164;170;164;164;162;163;162 09:43:22 INFO - PROCESS | 19455 | |3;audio-fft;77;76;77;152;78;76;74;78;157;77 09:43:22 INFO - PROCESS | 19455 | |4;audio-oscillator;85;86;138;86;85;87;134;86;86;136 09:43:22 INFO - PROCESS | 19455 | |5;imaging-gaussian-blur;117;118;117;118;118;118;118;117;119;118 09:43:22 INFO - PROCESS | 19455 | |6;imaging-darkroom;150;149;148;148;148;148;148;149;149;149 09:43:22 INFO - PROCESS | 19455 | |7;imaging-desaturate;96;96;95;95;96;96;95;95;96;96 09:43:22 INFO - PROCESS | 19455 | |8;json-parse-financial;63;63;69;64;65;67;64;64;63;67 09:43:22 INFO - PROCESS | 19455 | |9;json-stringify-tinderbox;65;65;64;64;65;64;63;64;66;63 09:43:22 INFO - PROCESS | 19455 | |10;stanford-crypto-aes;79;87;79;78;79;78;77;80;84;79 09:43:22 INFO - PROCESS | 19455 | |11;stanford-crypto-ccm;142;152;130;136;132;139;140;136;177;134 09:43:22 INFO - PROCESS | 19455 | |12;stanford-crypto-pbkdf2;176;171;179;176;172;173;180;180;177;170 09:43:22 INFO - PROCESS | 19455 | |13;stanford-crypto-sha256-iterative;69;69;68;72;69;74;66;67;68;67 09:43:22 INFO - PROCESS | 19455 | __end_tp_report 09:43:22 INFO - PROCESS | 19455 | __start_cc_report 09:43:22 INFO - PROCESS | 19455 | _x_x_mozilla_cycle_collect,1028 09:43:22 INFO - PROCESS | 19455 | __end_cc_report 09:43:22 INFO - PROCESS | 19455 | __startTimestamp1467650602367__endTimestamp 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | ------- Summary: start ------- 09:43:22 INFO - PROCESS | 19455 | Number of tests: 14 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#0] ai-astar Cycles:10 Average:111.20 Median:113.00 stddev:3.65 (3.2%) stddev-sans-first:2.37 09:43:22 INFO - PROCESS | 19455 | Values: 103.0 113.0 106.0 112.0 113.0 113.0 114.0 112.0 113.0 113.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#1] audio-beat-detection Cycles:10 Average:146.20 Median:151.50 stddev:23.49 (15.5%) stddev-sans-first:24.52 09:43:22 INFO - PROCESS | 19455 | Values: 158.0 123.0 144.0 178.0 124.0 157.0 146.0 122.0 186.0 124.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#2] audio-dft Cycles:10 Average:164.10 Median:164.00 stddev:2.28 (1.4%) stddev-sans-first:2.40 09:43:22 INFO - PROCESS | 19455 | Values: 165.0 164.0 163.0 164.0 170.0 164.0 164.0 162.0 163.0 162.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#3] audio-fft Cycles:10 Average:92.20 Median:77.00 stddev:32.88 (42.7%) stddev-sans-first:34.41 09:43:22 INFO - PROCESS | 19455 | Values: 77.0 76.0 77.0 152.0 78.0 76.0 74.0 78.0 157.0 77.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#4] audio-oscillator Cycles:10 Average:100.90 Median:86.00 stddev:24.25 (28.2%) stddev-sans-first:25.02 09:43:22 INFO - PROCESS | 19455 | Values: 85.0 86.0 138.0 86.0 85.0 87.0 134.0 86.0 86.0 136.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.60 09:43:22 INFO - PROCESS | 19455 | Values: 117.0 118.0 117.0 118.0 118.0 118.0 118.0 117.0 119.0 118.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#6] imaging-darkroom Cycles:10 Average:148.60 Median:149.00 stddev:0.70 (0.5%) stddev-sans-first:0.53 09:43:22 INFO - PROCESS | 19455 | Values: 150.0 149.0 148.0 148.0 148.0 148.0 148.0 149.0 149.0 149.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 09:43:22 INFO - PROCESS | 19455 | Values: 96.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 96.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#8] json-parse-financial Cycles:10 Average:64.90 Median:64.50 stddev:2.08 (3.2%) stddev-sans-first:2.09 09:43:22 INFO - PROCESS | 19455 | Values: 63.0 63.0 69.0 64.0 65.0 67.0 64.0 64.0 63.0 67.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#9] json-stringify-tinderbox Cycles:10 Average:64.30 Median:64.50 stddev:0.95 (1.5%) stddev-sans-first:0.97 09:43:22 INFO - PROCESS | 19455 | Values: 65.0 65.0 64.0 64.0 65.0 64.0 63.0 64.0 66.0 63.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#10] stanford-crypto-aes Cycles:10 Average:80.00 Median:79.00 stddev:3.09 (3.9%) stddev-sans-first:3.26 09:43:22 INFO - PROCESS | 19455 | Values: 79.0 87.0 79.0 78.0 79.0 78.0 77.0 80.0 84.0 79.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:139.50 stddev:13.81 (9.9%) stddev-sans-first:14.65 09:43:22 INFO - PROCESS | 19455 | Values: 142.0 152.0 130.0 136.0 132.0 139.0 140.0 136.0 177.0 134.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:175.40 Median:176.50 stddev:3.72 (2.1%) stddev-sans-first:3.94 09:43:22 INFO - PROCESS | 19455 | Values: 176.0 171.0 179.0 176.0 172.0 173.0 180.0 180.0 177.0 170.0 09:43:22 INFO - PROCESS | 19455 | 09:43:22 INFO - PROCESS | 19455 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:2.42 (3.5%) stddev-sans-first:2.57 09:43:22 INFO - PROCESS | 19455 | Values: 69.0 69.0 68.0 72.0 69.0 74.0 66.0 67.0 68.0 67.0 09:43:22 INFO - PROCESS | 19455 | -------- Summary: end -------- 09:43:22 INFO - PROCESS | 19455 | 09:43:23 INFO - TEST-INFO | 19455: exit 0 09:43:23 INFO - TEST-OK | kraken | took 64136ms 09:43:23 INFO - SUITE-END | took 1180s 09:43:23 INFO - Completed test suite (00:19:40) 09:43:23 INFO - javascript benchmark 09:43:23 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6419.440995122348, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.1737002844106, 2650.2446802661234, 2661.9866900665493, 2663.2010396880937, 2675.78593712503, 4727.763611819412, 4771.069641419925, 4797.280407938811, 4817.735024573647, 4825.662203645742, 4768.141734487791, 4808.350872632193, 4811.783469743861, 4817.807287708488, 4827.951720482794, 4388.824447022115, 4423.6601365968645, 4543.204939135655, 4546.477155127153, 4553.066621342617, 555.736233821767, 4352.455943007124, 4400.471943366801, 4448.599626033656, 4494.1910456117885, 4445.044315472157, 4471.35165401015, 4493.168763778679, 4500.887477813081, 4503.707259028152, 4458.977705111453, 4480.171168333869, 4486.618637415823, 4493.820247190109, 4531.637469002472, 4356.760378179199, 4374.431323927869, 4411.051623900845, 4411.42651455312, 4411.6250118739945, 4772.069446457942, 4811.855644330676, 4835.975820120877, 4853.417589889201, 4924.8276310328965, 5182.818601348935, 5186.688798672092, 5195.922061169085, 5197.428282888879, 5260.289860868772, 5154.407243167008, 5177.119889618773, 5178.6116041297055, 5187.19598462239, 5207.270982062477, 4802.399700037496, 4826.493218212107, 4830.830920917786, 4851.466338702739, 4885.755712214446, 5257.894842103213, 5297.894042119136, 5304.549113325411, 5309.681419114865, 5313.1764576490705, 5086.847394578169, 5106.46382129871, 5107.54032137102, 5107.87230319245, 5151.768170432265, 5199.7140157291715, 5200.895982080413, 5209.921851172236, 5221.216817477332, 5247.711375874287, 5000.2749601307605, 5007.37407824022, 5027.798888044437, 5045.990801839646, 5153.17549192135, 5006.3491746073505, 5034.421041580192, 5037.647364684437, 5047.0, 5094.108531007133, 4377.16833801583, 4385.912281754411, 4391.3412988051405, 4393.406890069799, 4433.0, 3785.848566057382, 3818.9427158592644, 3820.2168555446065, 3827.0623697194364, 3878.7866667333005, 4411.933820992687, 4426.557344265548, 4426.889327766768, 4428.070105277863, 4460.107978404332, 5147.0, 5154.690718556823, 5156.432792392834, 5168.715720635401, 5196.68819870809, 4385.342198670225, 4433.556644335541, 4450.688451808407, 4463.04044630406, 4505.662075344362, 4711.316859055418, 4719.905601888012, 4728.290756386501, 4768.356271903318, 4779.402574678165, 4829.975850120727, 4851.296561998561, 4856.5871900887405, 4868.440129385166, 4914.582260507826, 5069.797208111634, 5174.97412512935, 5219.817306394258, 5220.243064755665, 5283.550898173698, 4856.028794241237, 4874.439439464507, 4888.60891128716, 4894.2658601210105, 4935.481774413634, 5120.103981803244, 5161.277421160966, 5166.2767212589515, 5178.922316165336, 5208.479152084761, 5089.414717307557, 5168.198929165986, 5174.922376164285, 5234.241035049972, 5246.554042906396, 5077.492250774893, 5078.771455284447, 5079.16193828029, 5083.46623604531, 5128.358955130609, 5044.672096313728, 5071.568916642127, 5078.390593128848, 5083.059633967728, 5087.3132127163835, 4871.610271178368, 4887.731174785421, 4943.307936888767, 4954.8761280968265, 4997.800087996439, 5019.67372120811, 5035.0, 5047.4952504749235, 5061.797528098982, 5118.590512759045, 4965.900681986268, 4985.7257850817105, 4990.47600002009, 4993.500649934977, 5030.974845125751], "value": 4719.8217799135655, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [546.2352706211304, 559.1305519916531, 561.1806762127294, 566.2412367427647, 586.809286981731, 34939.301213975705, 38635.227295454075, 38713.22573548527, 38761.612383876185, 38908.22183556331, 39253.411198832044, 39405.802970985176, 39739.801300993524, 39789.204215915735, 39879.60120398802, 7791.571463569516, 7875.763727088168, 7925.841483170333, 7937.166597507266, 7951.960240198791, 7890.64492097857, 7913.485623434487, 7977.760667179994, 7984.800379990517, 7992.48048876824, 7896.091949425803, 7918.0, 7937.682492700314, 7939.245771651684, 7981.840363192733, 7963.8805417918775, 7968.7609371718945, 7980.082290536605, 7980.640871160812, 7987.880181797249, 7819.726309579138, 7866.252705992922, 7894.526328420313, 7901.644426000844, 7940.285374316281, 37798.43302350467, 38012.0, 38211.235775284615, 38325.616743832485, 38345.61654383448, 2487.7263501014872, 2919.4453053919688, 2944.661363943131, 3007.3534190149003, 3097.0399176255432, 25606.359841003938, 26979.0, 28107.437851243067, 28272.43455130886, 28651.71348286532, 3314.5193946877807, 3377.5102610121394, 3399.8980030599123, 3487.808170550619, 3497.877574284888, 282441.5877920618, 282963.0, 282970.0, 284015.0, 284854.0, 31936.0, 32946.0, 56326.43673563294, 57043.71478142666, 57098.714506427204, 34005.489917651255, 34021.31957360839, 34111.14722131917, 34138.14654633654, 34205.657943420745, 13159.407826647825, 13235.073544851768, 13283.867161328457, 13287.601371958857, 13328.733425331438, 10823.56705731762, 10890.61882834097, 10948.671539853816, 10982.670519884416, 11020.228583999044, 7942.483738556975, 7985.760427187193, 7986.241307075818, 8035.357171426272, 8068.556229407322, 3095.5666206731075, 3110.3623757129735, 3111.844407779602, 3124.8281344525813, 3157.494800831856, 887.6759982606302, 891.8127193289482, 908.3232991421434, 930.5579849571535, 970.5632465390603, 27715.307117322227, 28235.858820705766, 28577.570476576166, 28654.0, 28928.0, 934.6448349627234, 951.9190868776093, 970.2480577552312, 971.7619183299995, 1002.8946960569181, 14843.165895080874, 15068.773968390484, 15245.16151611672, 15310.923445382925, 15371.538853834403, 123411.0, 124785.37607312087, 409556.0, 410207.0, 412184.0, 48504.7574762131, 49518.75240623846, 49684.50315496871, 49803.01181929096, 49817.25274120891, 1130.4121856634504, 1135.0805847263744, 1154.0594415551132, 1154.1228666213738, 1159.9594014209463, 26825.195244142706, 27866.44267114606, 27973.30066748266, 28344.71655283421, 28514.0, 41819.7909010453, 41919.161616768106, 42017.15965680731, 42152.0, 42195.3670694946, 323914.0, 331035.0, 332337.0, 333134.0, 333205.0, 24793.504129917663, 25200.621990669788, 25393.365165870262, 25428.49143017092, 25521.48957020886, 40828.1834363317, 42136.789316053226, 42425.57574424216, 42467.1506569873, 42485.362719558616, 36920.0, 37192.256154877294, 37341.0, 37596.2480750378, 37887.62112378951, 36894.0, 36952.81523592365, 37133.442998354505, 37275.81362093172, 37647.623523765506, 35578.8221058893, 35637.64362356447, 35752.64247357493, 35906.8204658975, 35979.0, 31699.20751981219, 32592.837035814668, 33189.50215746718, 33207.501887471226, 33466.83266583652, 25334.239972800846, 25335.87332063328, 25359.746402535737, 26181.73818261793, 26228.8688556556], "value": 16368.597494317752, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [373.34291646701803, 376.17242067451616, 380.16363999201764, 383.8407061069656, 394.63101999630345, 16606.584835379123, 17087.23107460164, 17619.91190044051, 17966.550836229086, 18128.999999999967, 10887.455627218647, 11179.66461006171, 11183.776324473505, 11200.887991120086, 11233.60682376117, 4442.644588432918, 4687.460941991663, 5297.205419187114, 5317.3619165700175, 5342.0651386007485, 5150.639455238135, 5232.136697444917, 5236.4763523647525, 5259.6055295852775, 5272.024675435056, 5057.848264552069, 5180.378354597435, 5185.351831021122, 5214.713190774506, 5232.869178270555, 5176.0683077046115, 5181.4300426953005, 5227.085260079471, 5229.999999999981, 5247.10799164143, 4695.413073365829, 4902.166631672624, 5198.714070726109, 5233.764480598382, 5264.842054738364, 12896.677583060406, 12921.160124591872, 12959.092863499558, 12969.610911672666, 13042.608721738363, 1825.4158669225853, 1828.8902665840092, 1858.9907050464797, 1899.6105798311312, 2370.431096536836, 9318.0, 9467.763305917339, 9540.904590954071, 9756.0, 9783.36408133469, 1673.8242484539069, 1712.469134568288, 1712.9379784533544, 1717.9484615461556, 1762.34740285646, 56838.0, 62611.37388626146, 69096.6545167271, 69737.3026269741, 69822.30177698209, 9966.501674916226, 10085.092341689136, 10103.54534045955, 10178.847317290247, 10562.577496900038, 13353.265570393722, 13424.93287533556, 13430.798538021938, 13442.260675662932, 13481.59555213345, 7233.168185658611, 7588.886166707503, 7722.266384693445, 7773.183815699384, 7775.455718099679, 7434.405247580181, 7444.8883266751045, 7558.168601453835, 7562.168161502341, 7609.201033891472, 4387.298032314814, 4399.868003959887, 4408.933865992013, 4500.537325369268, 4584.564466375689, 1886.8867867927968, 1889.6976483762533, 1905.1902941249914, 1925.2876435718874, 1930.8165724256173, 755.4258763339901, 778.8909552662632, 829.6639860856363, 869.0527325215545, 918.1186061381148, 16773.412930547373, 17055.147242638068, 17216.655666886592, 17555.73666395005, 17780.3776867809, 845.2097289034772, 850.6129710981488, 856.9785755356166, 877.1623099939543, 905.8822353094056, 9484.715458536255, 9529.332946693803, 9679.274054445945, 9718.368306060083, 9985.850212246822, 406830.0, 417320.4803855889, 419318.0, 419882.0, 419915.0, 70757.64621176862, 76430.23569764342, 77235.0, 77272.22727772762, 77372.61313693396, 969.9078587534173, 976.9999999999858, 981.0826876870007, 1019.5768755966191, 1020.7805321855836, 16685.0, 16837.41069062577, 16914.0, 17025.0, 17293.65412691764, 32756.508652369757, 37618.81190594139, 38851.805740972246, 39786.403203951384, 40744.79627601843, 54470.18294725503, 56036.719816402285, 56476.0, 56657.71671141618, 56771.432285676616, 7679.424043196671, 7790.220977902164, 7830.099538552911, 7982.880256796268, 8036.357091432788, 12095.879041209475, 12290.385480725748, 12425.13024088305, 12466.376681166086, 12529.749405012031, 10777.137828973506, 10796.190285728444, 10821.51303191374, 11095.667129986114, 11207.495662695035, 10401.0, 10508.78982420332, 10638.361698298128, 10839.566417343218, 11038.448077595927, 10384.221183411124, 10538.736531586772, 10652.946735266274, 10846.728831779268, 10904.236703430684, 6625.304343043911, 6927.7228910845015, 7038.929610704033, 7153.105861767279, 8010.879836802569, 7465.58939258346, 8702.433561958907, 9223.815523689354, 9400.388974716896, 9485.952570237381], "value": 8100.933522062178, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1383.5849245226436, 1410.612081677539, 1497.6779992301654, 1685.6851655708535, 1727.4213138598577, 6884.139482564679, 7455.0681164854395, 7672.347850432713, 8159.265666090051, 8167.264946154853, 7721.266479684435, 8017.7594672159785, 8049.557274349909, 8056.0735515415745, 8069.072056713465, 2209.9005544750526, 2240.8879556022216, 2259.954800903981, 2261.072960086365, 2267.875266860322, 2198.857074290166, 2207.1612787140866, 2221.9888900555475, 2229.7658745831695, 2231.631780756173, 2254.413852398372, 2256.8194544436487, 2258.0741895822716, 2265.3090807303765, 2272.4318920269934, 2123.4160605833363, 2136.7222261106112, 2143.9999999999923, 2146.1844499090403, 2149.720536330275, 2163.3077415227135, 2165.4261620670536, 2172.424307558498, 2178.9782102178933, 2193.9561208775895, 7964.920350796534, 8006.9199308006755, 8007.559584222866, 8037.879431808527, 8096.635651395702, 4406.317020861739, 4459.487158976727, 4512.142692888341, 4513.909721805546, 4513.932291015604, 2885.4851203118533, 3017.215523963785, 3049.1005153479555, 3065.524843649238, 3070.3245286037036, 996.1781530237511, 1025.574386629548, 1032.0659802878406, 1037.2272656870605, 1052.2476429352973, 10241.795164096677, 10247.6413325534, 10334.276600637959, 10350.689479315633, 10370.844437333446, 3978.1049263915966, 4067.613576710208, 4198.097409057067, 4210.368444733314, 4238.830446782094, 8921.063288354759, 8957.955210223907, 9007.414518056436, 9015.098490150933, 9033.77415564603, 4560.110778398247, 4572.0627271409285, 4608.5621865922685, 4619.930701039487, 4620.214563524209, 3599.9100022499647, 4076.286649836267, 4215.768132752728, 4230.5769423057445, 4275.337322714984, 3669.339518886626, 3718.5537735471917, 3781.640744129303, 3796.0699628591174, 3932.842686292516, 1197.3414621957888, 1210.1105687319814, 1216.3370962825281, 1218.9085818563642, 1221.3709939381226, 706.427793487277, 860.6858496648678, 863.8099618084011, 865.4504389712578, 875.6584931876573, 5212.374515058142, 5264.473552644705, 5295.4969277918535, 5365.678059316453, 5480.3971563128025, 406.61371696888074, 411.57402088838506, 412.23736088236524, 420.926337890874, 422.54154242646456, 3702.0559757261726, 3726.1988672435555, 3753.7935413551972, 3756.567994680592, 3784.8864534064023, 9205.217556507638, 9642.180414664692, 9646.842378914575, 9653.806923861483, 9738.415695058178, 9519.571619277149, 9521.381110227812, 9598.32811703174, 9600.66397676078, 9617.374870633386, 7268.38218751412, 7353.6323183840595, 7375.0, 7384.261573842573, 7422.703091876372, 5099.1331473648825, 5166.767495462638, 5225.843224703265, 5236.633435659467, 5300.70846103468, 9007.054259302678, 9044.547772611475, 9061.637534498546, 9075.2286055686, 9090.318226132935, 8540.530270835165, 8947.150020748019, 8962.641494340414, 9185.357025008452, 9259.074092590687, 6066.878662426815, 6611.603303801788, 6713.597184168965, 6813.3527314905, 6875.449964002768, 7784.026996625422, 7791.766247012599, 7798.298153166243, 7813.1796161402235, 7814.296713295831, 6679.098321726505, 6877.793666190022, 6896.103506544117, 6907.240203577502, 7052.365287124184, 7062.858742825218, 7086.433085353263, 7100.467464940253, 7163.8567228656175, 7227.27727227273, 6373.235211774617, 6401.519886008475, 6408.327125651926, 6431.260405053479, 6457.61254324742, 4513.909721805479, 4518.457785065813, 4542.1824071667415, 4602.539746025371, 4612.0, 4639.164950308842, 4701.247800351927, 4701.670883038155, 4711.269753188261, 4772.355731976278], "value": 4110.0342985623365, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [304.5842425089753, 307.41744394372665, 314.64759469394284, 317.6347200719171, 318.0585467017628, 4981.850544483671, 5073.061483625532, 5172.215585622958, 5225.372955245366, 5238.7642556084975, 5121.487851214877, 5164.122099243138, 5176.689398636075, 5177.792888284464, 5182.352205974254, 4058.2289365020697, 4068.41008053832, 4077.103037331782, 4080.795960201993, 4088.8364465421346, 3940.290747665419, 4077.2864748669012, 4085.8978525536804, 4093.89765255868, 4098.97950510247, 4022.0, 4024.5170579530495, 4039.7172197946156, 4046.858359957402, 4059.9188016239805, 4044.090079732066, 4045.170739998308, 4048.251073551388, 4052.1895620875944, 4059.411385349108, 3333.1333853198344, 3435.793852368841, 3475.4091804393315, 3476.739244556643, 3600.6219346968455, 5017.9247311290355, 5034.270030845507, 5036.345275114211, 5038.622103342264, 5068.290439338495, 4550.749708766017, 4568.977155114237, 4571.702839315467, 4573.954260457386, 4584.381108550337, 5072.467390923936, 5341.599380046512, 5410.215518749798, 5414.7834086636485, 5433.212184233304, 3778.1688028633657, 3797.9810100949317, 3801.657850793414, 3808.315137827825, 3809.5428548574073, 5639.943600563983, 5643.520300774439, 5653.9151912721345, 5683.2895888014, 5693.3168019837885, 3758.6241375862196, 3818.1409182933617, 3865.96134038656, 3870.303345397799, 3874.5544262410185, 3931.68546516278, 3936.3505021671103, 3945.230680017369, 3947.2500224957166, 3970.1662650843646, 4533.206688829442, 4558.384618076583, 4564.360989461478, 4570.811588986888, 4571.771411429415, 5211.869703257449, 5391.514763671288, 5458.836234912959, 5459.945400546023, 5470.8085217017215, 1338.9288569144646, 1368.2269517722455, 1371.636516323175, 1373.4368908747565, 1374.7077746917864, 848.4188330993289, 855.3755758296478, 884.7832281091174, 889.235257678396, 892.8973168085623, 4264.680148988777, 4311.568843115663, 4313.525512193656, 4319.460067491564, 4336.241157797373, 4968.8757781055765, 4990.0, 5009.897822479049, 5033.446320904697, 5044.074436826631, 4260.211860805699, 4287.742735435884, 4310.7629080400875, 4335.479742430865, 4341.522432532419, 2776.2232171410315, 3020.9244768880953, 3024.5311976643657, 3037.893673721409, 3044.8782048717803, 5225.921611175835, 5244.423113457517, 5248.711320877312, 5260.289860868734, 5265.605079619044, 5429.457054294539, 5685.744141513642, 5709.058005429058, 5737.282839645044, 5795.855103622359, 5180.559652429586, 5215.139501982207, 5226.163813789775, 5227.764750586157, 5230.660007099526, 5620.915686264628, 5637.182608521824, 5655.324039374275, 5675.31896172462, 5679.659220446786, 5210.088234558862, 5491.835244942658, 5521.668699878021, 5559.805406810742, 5583.330000399978, 5197.1164901966, 5218.582513398843, 5260.763265652979, 5263.473652634706, 5271.262023316662, 3609.260101679202, 3717.8326975285636, 3822.3119838429348, 3835.964289641837, 3853.2660302864383, 5567.777288908398, 5568.693721845338, 5595.237500187428, 5603.915941260802, 5610.971945140248, 5256.553192978639, 5407.459254074561, 5418.295621569171, 5426.728663566885, 5445.373782015119, 5289.6032797539565, 5367.819079802437, 5384.6499977501335, 5387.757550910297, 5432.29380180574, 5298.81454149103, 5322.441143679858, 5346.893062138814, 5367.490088441592, 5369.597280203922, 5287.418383977682, 5427.24018637399, 5451.264079349396, 5451.700156491431, 5469.453054694499, 5298.966701493326, 5322.760475778522, 5334.226537152169, 5359.946400536101, 5366.570674345965], "value": 4027.1925671278996, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [656.2256537286003, 664.5215444879688, 673.8685956238536, 742.3281929853483, 748.2779118150986, 12559.748805023906, 13206.141600795941, 13595.04834661574, 13605.183688978668, 14092.929535352334, 13394.263315517643, 13440.52958146465, 13536.864631353683, 13548.322583870817, 13552.864471355284, 625.2996643758996, 767.5509826751357, 777.0, 793.0245797668871, 794.7258195922426, 779.7660701789468, 791.5369508837337, 792.7700966719644, 794.6384395100215, 796.9800754981114, 839.8824164616958, 840.6007146605344, 841.0790184747691, 841.7222316635496, 844.4806444036903, 836.0928392693935, 836.188896770135, 839.1943734015352, 839.2488722593306, 841.305922613843, 611.9724612392453, 612.8712970276202, 612.9356417576134, 613.7637009751234, 614.5176036811082, 12176.878231217663, 12193.39033048344, 12249.142560020802, 12263.570775022921, 12326.445309961073, 13094.738105237842, 13401.46394144233, 13475.326233688276, 13476.595702128952, 13620.863791362059, 10899.0, 10921.235513513977, 10942.56229750809, 11078.723031924266, 11103.83344249837, 3283.1299705577803, 3327.633960264369, 3331.983340083308, 3333.2000319923045, 3402.5916889973114, 61291.6687366488, 61947.38052619461, 64040.35959640437, 64710.0, 65032.0, 10056.446895420675, 10165.847512287322, 10198.133158681596, 10225.079742823033, 10230.437325946996, 19221.03894805254, 19253.32613358526, 19256.807431925783, 19439.416817495214, 19953.60092798165, 6407.807765767035, 6563.3764792344655, 6581.440577550866, 6710.127683401127, 6802.217744959294, 3473.8610455581997, 3741.6258374162912, 3813.1992281620614, 3821.6751576115785, 3913.0413048803225, 2839.772818174541, 3233.611966564027, 3467.9653203468147, 3487.05849420655, 3490.6683865032783, 582.432128674539, 585.4145854145854, 595.0835713001928, 598.1924402057275, 598.2312728144401, 472.60301346868107, 568.1335962656981, 584.3893131677407, 586.3784388548067, 612.5773216480615, 8400.78998025042, 8568.0, 8710.69512567057, 8913.732588022369, 8982.281417486585, 484.8545436369075, 495.76946719775475, 553.9529140023062, 575.0741306496537, 616.5529990756755, 4010.458588090629, 4078.5921407858978, 4201.096764195712, 4290.099079193342, 4312.310030395121, 112065.0, 114730.42634786773, 115736.42131789288, 117496.0, 118466.4076679611, 100916.49541752244, 101168.0, 102269.0, 102653.0, 103331.45002824963, 48000.0, 63506.364936350044, 63573.0, 65031.0, 70427.0, 8693.913060869563, 8712.825743485222, 8855.690050848447, 8946.821063578822, 9111.681091161778, 44687.55312446834, 45138.77430612826, 45884.31173532466, 46753.53246467628, 48022.279665804344, 62548.0, 67175.32824671887, 67369.0, 67815.66092169507, 68268.0, 11324.94337528307, 11521.88478115208, 11553.191276610556, 11728.589499367481, 11759.353235571783, 12936.159149655243, 13358.465661373824, 13435.731285374433, 14178.0, 14302.141871487744, 10739.624113156002, 10904.7273818152, 10921.890781092088, 11244.325340479598, 11479.655610331703, 11874.346910919638, 11978.820317695066, 12239.449224785085, 12496.87503124957, 12572.811407829073, 11553.0, 11979.580714674945, 11985.34080625574, 12425.0, 12624.684382890502, 9730.513474326113, 9964.50177491137, 10025.649102281384, 10066.44634545107, 10147.949260253652, 10474.895251047392, 10499.790004200026, 10561.683149505527, 10616.1507079435, 10721.624743133953], "value": 6754.9052355337435, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1571.9, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 113.0, 106.0, 112.0, 113.0, 113.0, 114.0, 112.0, 113.0, 113.0], "value": 111.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 123.0, 144.0, 178.0, 124.0, 157.0, 146.0, 122.0, 186.0, 124.0], "value": 146.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 164.0, 163.0, 164.0, 170.0, 164.0, 164.0, 162.0, 163.0, 162.0], "value": 164.1, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 77.0, 152.0, 78.0, 76.0, 74.0, 78.0, 157.0, 77.0], "value": 92.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 86.0, 138.0, 86.0, 85.0, 87.0, 134.0, 86.0, 86.0, 136.0], "value": 100.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 117.0, 118.0, 118.0, 118.0, 118.0, 117.0, 119.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [150.0, 149.0, 148.0, 148.0, 148.0, 148.0, 148.0, 149.0, 149.0, 149.0], "value": 148.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0, 96.0], "value": 95.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 63.0, 69.0, 64.0, 65.0, 67.0, 64.0, 64.0, 63.0, 67.0], "value": 64.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 65.0, 64.0, 64.0, 65.0, 64.0, 63.0, 64.0, 66.0, 63.0], "value": 64.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 87.0, 79.0, 78.0, 79.0, 78.0, 77.0, 80.0, 84.0, 79.0], "value": 80.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 152.0, 130.0, 136.0, 132.0, 139.0, 140.0, 136.0, 177.0, 134.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [176.0, 171.0, 179.0, 176.0, 172.0, 173.0, 180.0, 180.0, 177.0, 170.0], "value": 175.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 69.0, 68.0, 72.0, 69.0, 74.0, 66.0, 67.0, 68.0, 67.0], "value": 68.9, "unit": "score"}]}]} 09:43:23 INFO - Return code: 0 09:43:23 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:43:23 ERROR - # TBPL SUCCESS # 09:43:23 INFO - Running post-action listener: _resource_record_post_action 09:43:23 INFO - ##### 09:43:23 INFO - ##### Finished run-tests step (success) 09:43:23 INFO - ##### 09:43:23 INFO - Running post-run listener: _resource_record_post_run 09:43:23 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 535207936; Read time: 0; Write time: 407336 09:43:23 INFO - TinderboxPrint: CPU usage
13.3% 09:43:23 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:43:23 INFO - TinderboxPrint: I/O write bytes / time
535,207,936 / 407,336 09:43:23 INFO - TinderboxPrint: CPU idle
8,279.2 (86.7%) 09:43:23 INFO - TinderboxPrint: CPU user
1,219.8 (12.8%) 09:43:23 INFO - TinderboxPrint: Swap in / out
0 / 0 09:43:23 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246427648; Read time: 0; Write time: 225544 09:43:23 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 288780288; Read time: 0; Write time: 181792 09:43:24 INFO - Running post-run listener: _upload_blobber_files 09:43:24 INFO - Blob upload gear active. 09:43:24 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:43:24 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 09:43:24 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'] 09:43:24 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 09:43:24 INFO - (blobuploader) - INFO - Open directory for files ... 09:43:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:43:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:28 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:43:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:28 INFO - (blobuploader) - INFO - Done attempting. 09:43:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:43:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:43:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:29 INFO - (blobuploader) - INFO - Done attempting. 09:43:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:43:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:43:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:43:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:43:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:43:29 INFO - (blobuploader) - INFO - Done attempting. 09:43:29 INFO - (blobuploader) - INFO - Iteration through files over. 09:43:30 INFO - Return code: 0 09:43:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:43:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:43:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e28f171f1b8e6d09cfbfe4100ee337f82e69fd62a3239a211327f7a9f138e54fdce87572eaf4c185d4cb642234608b546504f980ebe7dcf8c89bb28973a61b1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a8584d8405e81a634b94b7d6980b999c7f5035a97214dd678fd91aa4b09880d1a245a696f59b2d446092ad9020b938556f57f89734a929dbdb6e130ae98b70a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f72148fb5287930263e8cbaaa5cb720fd5a18af86485e52fd5c98f67aaf84937750bb53c44d658f98301575f0fadc09266f91a569dd40cbc23b72741460634e2"} 09:43:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:43:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:43:30 INFO - Contents: 09:43:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e28f171f1b8e6d09cfbfe4100ee337f82e69fd62a3239a211327f7a9f138e54fdce87572eaf4c185d4cb642234608b546504f980ebe7dcf8c89bb28973a61b1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a8584d8405e81a634b94b7d6980b999c7f5035a97214dd678fd91aa4b09880d1a245a696f59b2d446092ad9020b938556f57f89734a929dbdb6e130ae98b70a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f72148fb5287930263e8cbaaa5cb720fd5a18af86485e52fd5c98f67aaf84937750bb53c44d658f98301575f0fadc09266f91a569dd40cbc23b72741460634e2"} 09:43:30 INFO - Running post-run listener: copy_logs_to_upload_dir 09:43:30 INFO - Copying logs to upload dir... 09:43:30 INFO - mkdir: /builds/slave/test/build/upload/logs 09:43:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1235.894185 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 35 secs) (at 2016-07-04 09:43:28.792800) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 09:43:28.796070) ========= 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=cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e28f171f1b8e6d09cfbfe4100ee337f82e69fd62a3239a211327f7a9f138e54fdce87572eaf4c185d4cb642234608b546504f980ebe7dcf8c89bb28973a61b1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a8584d8405e81a634b94b7d6980b999c7f5035a97214dd678fd91aa4b09880d1a245a696f59b2d446092ad9020b938556f57f89734a929dbdb6e130ae98b70a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f72148fb5287930263e8cbaaa5cb720fd5a18af86485e52fd5c98f67aaf84937750bb53c44d658f98301575f0fadc09266f91a569dd40cbc23b72741460634e2"} build_url:https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011305 build_url: 'https://queue.taskcluster.net/v1/task/O3bJ_9qvRTGnXbf0aw6MNg/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/e28f171f1b8e6d09cfbfe4100ee337f82e69fd62a3239a211327f7a9f138e54fdce87572eaf4c185d4cb642234608b546504f980ebe7dcf8c89bb28973a61b1f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/7a8584d8405e81a634b94b7d6980b999c7f5035a97214dd678fd91aa4b09880d1a245a696f59b2d446092ad9020b938556f57f89734a929dbdb6e130ae98b70a", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f72148fb5287930263e8cbaaa5cb720fd5a18af86485e52fd5c98f67aaf84937750bb53c44d658f98301575f0fadc09266f91a569dd40cbc23b72741460634e2"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-04 09:43:28.821497) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:43:28.821832) ========= 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=cbe409c6de289db6ac707de3000001d4-1467649372.259392-1727947163 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004446 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-04 09:43:28.905357) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 09:43:28.905684) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-04 09:43:28.905989) ========= ========= Total master_lag: 0.18 =========