builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-003 starttime: 1467822274.28 results: success (0) buildid: 20160706083823 builduid: 69de8c4ee53f42f2a8f36c4fdb883228 revision: df4803bab0bc40c206c6977a8cc7fcaeac677357 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:34.283659) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:34.284106) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:34.284388) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:34.305263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:34.305593) ========= 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=7de08804244eb36560b44971000001c3-1467822273.587255-789491697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 09:24:34-- 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% 70.6M=0s 2016-07-06 09:24:34 (70.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.115365 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:34.434910) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:34.435319) ========= 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=7de08804244eb36560b44971000001c3-1467822273.587255-789491697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018492 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:34.484779) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:34.485444) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev df4803bab0bc40c206c6977a8cc7fcaeac677357 --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 df4803bab0bc40c206c6977a8cc7fcaeac677357 --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=7de08804244eb36560b44971000001c3-1467822273.587255-789491697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 09:24:34,887 truncating revision to first 12 chars 2016-07-06 09:24:34,887 Setting DEBUG logging. 2016-07-06 09:24:34,887 attempt 1/10 2016-07-06 09:24:34,887 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/df4803bab0bc?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-06 09:24:35,321 unpacking tar archive at: fx-team-df4803bab0bc/testing/mozharness/ program finished with exit code 0 elapsedTime=0.790965 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:35.289771) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:35.290107) ========= script_repo_revision: df4803bab0bc40c206c6977a8cc7fcaeac677357 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:35.290489) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:35.290751) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 09:24:35.302119) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-06 09:24:35.302511) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=7de08804244eb36560b44971000001c3-1467822273.587255-789491697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:24:35 INFO - MultiFileLogger online at 20160706 09:24:35 in /builds/slave/test 09:24:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:24:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:24:35 INFO - {'append_to_log': False, 09:24:35 INFO - 'base_work_dir': '/builds/slave/test', 09:24:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:24:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:24:35 INFO - 'branch': 'Fx-Team-Non-PGO', 09:24:35 INFO - 'buildbot_json_path': 'buildprops.json', 09:24:35 INFO - 'config_files': ('talos/linux_config.py',), 09:24:35 INFO - 'default_actions': ('clobber', 09:24:35 INFO - 'read-buildbot-config', 09:24:35 INFO - 'download-and-extract', 09:24:35 INFO - 'populate-webroot', 09:24:35 INFO - 'create-virtualenv', 09:24:35 INFO - 'install', 09:24:35 INFO - 'run-tests'), 09:24:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:24:35 INFO - 'download_minidump_stackwalk': True, 09:24:35 INFO - 'download_symbols': 'ondemand', 09:24:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:24:35 INFO - 'tooltool.py': '/tools/tooltool.py', 09:24:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:24:35 INFO - '/tools/misc-python/virtualenv.py')}, 09:24:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:24:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:24:35 INFO - 'installer_path': 'installer.exe', 09:24:35 INFO - 'log_level': 'info', 09:24:35 INFO - 'log_name': 'talos', 09:24:35 INFO - 'log_to_console': True, 09:24:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:24:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:24:35 INFO - 'opt_config_files': (), 09:24:35 INFO - 'pip_index': False, 09:24:35 INFO - 'sps_profile': False, 09:24:35 INFO - 'sps_profile_interval': 0, 09:24:35 INFO - 'suite': 'dromaeojs', 09:24:35 INFO - 'system_bits': '32', 09:24:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:24:35 INFO - 'title': 'talos-linux64-ix-003', 09:24:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:24:35 INFO - 'use_talos_json': True, 09:24:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:24:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:24:35 INFO - 'work_dir': 'build'} 09:24:35 INFO - ##### 09:24:35 INFO - ##### Running clobber step. 09:24:35 INFO - ##### 09:24:35 INFO - Running pre-action listener: _resource_record_pre_action 09:24:35 INFO - Running main action method: clobber 09:24:35 INFO - rmtree: /builds/slave/test/build 09:24:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:24:36 INFO - Running post-action listener: _resource_record_post_action 09:24:36 INFO - ##### 09:24:36 INFO - ##### Finished clobber step (success) 09:24:36 INFO - ##### 09:24:36 INFO - ##### 09:24:36 INFO - ##### Running read-buildbot-config step. 09:24:36 INFO - ##### 09:24:36 INFO - Running pre-action listener: _resource_record_pre_action 09:24:36 INFO - Running main action method: read_buildbot_config 09:24:36 INFO - Using buildbot properties: 09:24:36 INFO - { 09:24:36 INFO - "project": "", 09:24:36 INFO - "product": "firefox", 09:24:36 INFO - "script_repo_revision": "production", 09:24:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 09:24:36 INFO - "repository": "", 09:24:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 09:24:36 INFO - "buildid": "20160706083823", 09:24:36 INFO - "pgo_build": "False", 09:24:36 INFO - "basedir": "/builds/slave/test", 09:24:36 INFO - "buildnumber": 3136, 09:24:36 INFO - "slavename": "talos-linux64-ix-003", 09:24:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 09:24:36 INFO - "platform": "ubuntu64_hw", 09:24:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:24:36 INFO - "branch": "fx-team", 09:24:36 INFO - "repo_path": "integration/fx-team", 09:24:36 INFO - "revision": "df4803bab0bc40c206c6977a8cc7fcaeac677357", 09:24:36 INFO - "stage_platform": "linux64", 09:24:36 INFO - "builduid": "69de8c4ee53f42f2a8f36c4fdb883228", 09:24:36 INFO - "slavebuilddir": "test" 09:24:36 INFO - } 09:24:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 09:24:36 INFO - Running post-action listener: _resource_record_post_action 09:24:36 INFO - ##### 09:24:36 INFO - ##### Finished read-buildbot-config step (success) 09:24:36 INFO - ##### 09:24:36 INFO - ##### 09:24:36 INFO - ##### Running download-and-extract step. 09:24:36 INFO - ##### 09:24:36 INFO - Running pre-action listener: _resource_record_pre_action 09:24:36 INFO - Running main action method: download_and_extract 09:24:36 INFO - mkdir: /builds/slave/test/build/tests 09:24:36 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:24:36 INFO - https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 09:24:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:24:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:24:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/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:24:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/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:24:37 INFO - Downloaded 1361 bytes. 09:24:37 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:24:37 INFO - Using the following test package requirements: 09:24:37 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:24:37 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:24:37 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:24:37 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:37 INFO - u'jsshell-linux-x86_64.zip'], 09:24:37 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:24:37 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:24:37 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:24:37 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:24:37 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:24:37 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:24:37 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:24:37 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:24:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:37 INFO - https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:24:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:24:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:24:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/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:24:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/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:24:39 INFO - Downloaded 22730934 bytes. 09:24:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:24:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:24:40 INFO - Return code: 0 09:24:40 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:24:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:40 INFO - https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:24:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:24:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 09:24:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/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:24:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/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:24:41 INFO - Downloaded 22730934 bytes. 09:24:41 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:24:41 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:24:43 INFO - Return code: 0 09:24:43 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:24:43 INFO - https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:24:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:24:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 09:24:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/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:24:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/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:24:44 INFO - Downloaded 14403333 bytes. 09:24:44 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:24:44 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:24:44 INFO - Return code: 0 09:24:44 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:24:44 INFO - https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:24:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:24:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:24:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/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:24:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JpOpiI26SYKZvxxQd2wibQ/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:24:45 INFO - Downloaded 56468549 bytes. 09:24:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:24:45 INFO - mkdir: /builds/slave/test/properties 09:24:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:45 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:45 INFO - Contents: 09:24:45 INFO - build_url:https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 09:24:46 INFO - Running post-action listener: _resource_record_post_action 09:24:46 INFO - Running post-action listener: set_extra_try_arguments 09:24:46 INFO - ##### 09:24:46 INFO - ##### Finished download-and-extract step (success) 09:24:46 INFO - ##### 09:24:46 INFO - ##### 09:24:46 INFO - ##### Running populate-webroot step. 09:24:46 INFO - ##### 09:24:46 INFO - Running pre-action listener: _resource_record_pre_action 09:24:46 INFO - Running main action method: populate_webroot 09:24:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:46 INFO - '--tppagecycles', 09:24:46 INFO - '7'], 09:24:46 INFO - 'tests': ['tsvgm']}}, 09:24:46 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:24:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:46 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:24:46 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:24:46 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:46 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:24:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:46 INFO - 'talos_options': ['--disable-e10s'], 09:24:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:46 INFO - 'talos_options': ['--disable-e10s'], 09:24:46 INFO - 'tests': ['damp', 'tps']}, 09:24:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:46 INFO - 'tests': ['damp', 'tps']}, 09:24:46 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:24:46 INFO - 'tests': ['dromaeo_dom']}, 09:24:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:46 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:24:46 INFO - 'tests': ['basic_compositor_video']}, 09:24:46 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:24:46 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:24:46 INFO - 'tests': ['a11yr', 09:24:46 INFO - 'ts_paint', 09:24:46 INFO - 'tpaint', 09:24:46 INFO - 'sessionrestore', 09:24:46 INFO - 'sessionrestore_no_auto_restore', 09:24:46 INFO - 'tabpaint']}, 09:24:46 INFO - 'other-e10s': {'tests': ['a11yr', 09:24:46 INFO - 'ts_paint', 09:24:46 INFO - 'tpaint', 09:24:46 INFO - 'sessionrestore', 09:24:46 INFO - 'sessionrestore_no_auto_restore', 09:24:46 INFO - 'tabpaint']}, 09:24:46 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:24:46 INFO - 'ts_paint', 09:24:46 INFO - 'tpaint', 09:24:46 INFO - 'sessionrestore', 09:24:46 INFO - 'sessionrestore_no_auto_restore', 09:24:46 INFO - 'tabpaint']}, 09:24:46 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:24:46 INFO - 'ts_paint', 09:24:46 INFO - 'tpaint', 09:24:46 INFO - 'sessionrestore', 09:24:46 INFO - 'sessionrestore_no_auto_restore', 09:24:46 INFO - 'tabpaint']}, 09:24:46 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:24:46 INFO - 'tests': ['a11yr', 09:24:46 INFO - 'ts_paint', 09:24:46 INFO - 'tpaint', 09:24:46 INFO - 'sessionrestore', 09:24:46 INFO - 'sessionrestore_no_auto_restore', 09:24:46 INFO - 'tabpaint']}, 09:24:46 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:24:46 INFO - 'tests': ['a11yr', 09:24:46 INFO - 'ts_paint', 09:24:46 INFO - 'tpaint', 09:24:46 INFO - 'sessionrestore', 09:24:46 INFO - 'sessionrestore_no_auto_restore', 09:24:46 INFO - 'tabpaint']}, 09:24:46 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:24:46 INFO - 'tests': ['tsvgx', 09:24:46 INFO - 'tsvgr_opacity', 09:24:46 INFO - 'tart', 09:24:46 INFO - 'tscrollx', 09:24:46 INFO - 'cart']}, 09:24:46 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:24:46 INFO - 'tsvgr_opacity', 09:24:46 INFO - 'tart', 09:24:46 INFO - 'tscrollx', 09:24:46 INFO - 'cart']}, 09:24:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:46 INFO - 'talos_options': ['--disable-e10s'], 09:24:46 INFO - 'tests': ['tp5o']}, 09:24:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:46 INFO - 'tests': ['tp5o']}, 09:24:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:46 INFO - 'talos_options': ['--disable-e10s', 09:24:46 INFO - '--xperf_path', 09:24:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:46 INFO - 'tests': ['tp5n']}, 09:24:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:46 INFO - 'talos_options': ['--xperf_path', 09:24:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:46 INFO - 'tests': ['tp5n']}}, 09:24:46 INFO - 'talos.zip': {'path': '', 09:24:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:46 INFO - Running post-action listener: _resource_record_post_action 09:24:46 INFO - ##### 09:24:46 INFO - ##### Finished populate-webroot step (success) 09:24:46 INFO - ##### 09:24:46 INFO - ##### 09:24:46 INFO - ##### Running create-virtualenv step. 09:24:46 INFO - ##### 09:24:46 INFO - Running pre-action listener: _resource_record_pre_action 09:24:46 INFO - Running main action method: create_virtualenv 09:24:46 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:46 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:24:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:46 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:46 INFO - Using real prefix '/usr' 09:24:46 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:47 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:49 INFO - Installing pip.................done. 09:24:49 INFO - Return code: 0 09:24:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24:49 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:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:49 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:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:49 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 0xbd1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe903b0>, '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 0xe912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91740>, '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': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', '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:24:49 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:24:49 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:24:49 INFO - Using env: {'DISPLAY': ':0', 09:24:49 INFO - 'HOME': '/home/cltbld', 09:24:49 INFO - 'LANG': 'en_US.UTF-8', 09:24:49 INFO - 'LANGUAGE': 'en_US:en', 09:24:49 INFO - 'LOGNAME': 'cltbld', 09:24:49 INFO - 'MAIL': '/var/mail/cltbld', 09:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:49 INFO - 'MOZ_NO_REMOTE': '1', 09:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:49 INFO - 'NO_EM_RESTART': '1', 09:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:49 INFO - 'PWD': '/builds/slave/test', 09:24:49 INFO - 'SHELL': '/bin/bash', 09:24:49 INFO - 'SHLVL': '1', 09:24:49 INFO - 'TERM': 'linux', 09:24:49 INFO - 'TMOUT': '86400', 09:24:49 INFO - 'USER': 'cltbld', 09:24:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', 09:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:49 INFO - '_': '/tools/buildbot/bin/python'} 09:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:49 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:24:49 INFO - Cleaning up... 09:24:49 INFO - Return code: 0 09:24:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:24:49 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:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:49 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:24:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:49 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 0xbd1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe903b0>, '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 0xe912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91740>, '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': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', '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:24:49 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:24:49 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:24:49 INFO - Using env: {'DISPLAY': ':0', 09:24:49 INFO - 'HOME': '/home/cltbld', 09:24:49 INFO - 'LANG': 'en_US.UTF-8', 09:24:49 INFO - 'LANGUAGE': 'en_US:en', 09:24:49 INFO - 'LOGNAME': 'cltbld', 09:24:49 INFO - 'MAIL': '/var/mail/cltbld', 09:24:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:49 INFO - 'MOZ_NO_REMOTE': '1', 09:24:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:49 INFO - 'NO_EM_RESTART': '1', 09:24:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:49 INFO - 'PWD': '/builds/slave/test', 09:24:49 INFO - 'SHELL': '/bin/bash', 09:24:49 INFO - 'SHLVL': '1', 09:24:49 INFO - 'TERM': 'linux', 09:24:49 INFO - 'TMOUT': '86400', 09:24:49 INFO - 'USER': 'cltbld', 09:24:49 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', 09:24:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:49 INFO - '_': '/tools/buildbot/bin/python'} 09:24:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:49 INFO - Downloading/unpacking psutil>=3.1.1 09:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:51 INFO - Installing collected packages: psutil 09:24:51 INFO - Running setup.py install for psutil 09:24:51 INFO - building 'psutil._psutil_linux' extension 09:24:51 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:24:51 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:24:51 INFO - building 'psutil._psutil_posix' extension 09:24:51 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:24:51 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:24:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:52 INFO - Successfully installed psutil 09:24:52 INFO - Cleaning up... 09:24:52 INFO - Return code: 0 09:24:52 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbd1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe903b0>, '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 0xe912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91740>, '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': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', '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:24:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:24:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 09:24:52 INFO - Using env: {'DISPLAY': ':0', 09:24:52 INFO - 'HOME': '/home/cltbld', 09:24:52 INFO - 'LANG': 'en_US.UTF-8', 09:24:52 INFO - 'LANGUAGE': 'en_US:en', 09:24:52 INFO - 'LOGNAME': 'cltbld', 09:24:52 INFO - 'MAIL': '/var/mail/cltbld', 09:24:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:52 INFO - 'MOZ_NO_REMOTE': '1', 09:24:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:52 INFO - 'NO_EM_RESTART': '1', 09:24:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:52 INFO - 'PWD': '/builds/slave/test', 09:24:52 INFO - 'SHELL': '/bin/bash', 09:24:52 INFO - 'SHLVL': '1', 09:24:52 INFO - 'TERM': 'linux', 09:24:52 INFO - 'TMOUT': '86400', 09:24:52 INFO - 'USER': 'cltbld', 09:24:52 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', 09:24:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:52 INFO - '_': '/tools/buildbot/bin/python'} 09:24:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:52 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:54 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:24:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:24:54 INFO - Installing collected packages: mozsystemmonitor 09:24:54 INFO - Running setup.py install for mozsystemmonitor 09:24:54 INFO - Successfully installed mozsystemmonitor 09:24:54 INFO - Cleaning up... 09:24:54 INFO - Return code: 0 09:24:54 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:24: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:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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:24:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:54 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 0xbd1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe903b0>, '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 0xe912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91740>, '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': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', '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:24:54 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:24:54 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:24:54 INFO - Using env: {'DISPLAY': ':0', 09:24:54 INFO - 'HOME': '/home/cltbld', 09:24:54 INFO - 'LANG': 'en_US.UTF-8', 09:24:54 INFO - 'LANGUAGE': 'en_US:en', 09:24:54 INFO - 'LOGNAME': 'cltbld', 09:24:54 INFO - 'MAIL': '/var/mail/cltbld', 09:24:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:54 INFO - 'MOZ_NO_REMOTE': '1', 09:24:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:54 INFO - 'NO_EM_RESTART': '1', 09:24:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:54 INFO - 'PWD': '/builds/slave/test', 09:24:54 INFO - 'SHELL': '/bin/bash', 09:24:54 INFO - 'SHLVL': '1', 09:24:54 INFO - 'TERM': 'linux', 09:24:54 INFO - 'TMOUT': '86400', 09:24:54 INFO - 'USER': 'cltbld', 09:24:54 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', 09:24:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:54 INFO - '_': '/tools/buildbot/bin/python'} 09:24:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:54 INFO - Downloading/unpacking jsonschema==2.5.1 09:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:24:56 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:24:56 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:24:56 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:24:56 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:24:56 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:24:56 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:24:56 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:56 INFO - warning: no files found matching '*.txt' 09:24:56 INFO - no previously-included directories found matching 'build' 09:24:56 INFO - no previously-included directories found matching 'dist' 09:24:56 INFO - no previously-included directories found matching '.git*' 09:24:56 INFO - Installing collected packages: jsonschema, functools32 09:24:56 INFO - Running setup.py install for functools32 09:24:56 INFO - warning: no files found matching '*.txt' 09:24:56 INFO - no previously-included directories found matching 'build' 09:24:56 INFO - no previously-included directories found matching 'dist' 09:24:56 INFO - no previously-included directories found matching '.git*' 09:24:56 INFO - Successfully installed jsonschema functools32 09:24:56 INFO - Cleaning up... 09:24:56 INFO - Return code: 0 09:24:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:56 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 0xbd1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe903b0>, '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 0xe912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91740>, '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': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', '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:24:56 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:24:56 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:24:56 INFO - Using env: {'DISPLAY': ':0', 09:24:56 INFO - 'HOME': '/home/cltbld', 09:24:56 INFO - 'LANG': 'en_US.UTF-8', 09:24:56 INFO - 'LANGUAGE': 'en_US:en', 09:24:56 INFO - 'LOGNAME': 'cltbld', 09:24:56 INFO - 'MAIL': '/var/mail/cltbld', 09:24:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:56 INFO - 'MOZ_NO_REMOTE': '1', 09:24:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:56 INFO - 'NO_EM_RESTART': '1', 09:24:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:56 INFO - 'PWD': '/builds/slave/test', 09:24:56 INFO - 'SHELL': '/bin/bash', 09:24:56 INFO - 'SHLVL': '1', 09:24:56 INFO - 'TERM': 'linux', 09:24:56 INFO - 'TMOUT': '86400', 09:24:56 INFO - 'USER': 'cltbld', 09:24:56 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', 09:24:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:56 INFO - '_': '/tools/buildbot/bin/python'} 09:24:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:57 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:59 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:59 INFO - Downloading docopt-0.6.1.tar.gz 09:24:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:59 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:59 INFO - Running setup.py install for blobuploader 09:24:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:59 INFO - Running setup.py install for requests 09:25:00 INFO - Running setup.py install for docopt 09:25:00 INFO - Successfully installed blobuploader requests docopt 09:25:00 INFO - Cleaning up... 09:25:00 INFO - Return code: 0 09:25:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25: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:25:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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:25:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:00 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 0xbd1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe903b0>, '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 0xe912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91740>, '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': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', '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:25:00 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:25:00 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:25:00 INFO - Using env: {'DISPLAY': ':0', 09:25:00 INFO - 'HOME': '/home/cltbld', 09:25:00 INFO - 'LANG': 'en_US.UTF-8', 09:25:00 INFO - 'LANGUAGE': 'en_US:en', 09:25:00 INFO - 'LOGNAME': 'cltbld', 09:25:00 INFO - 'MAIL': '/var/mail/cltbld', 09:25:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:00 INFO - 'MOZ_NO_REMOTE': '1', 09:25:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:00 INFO - 'NO_EM_RESTART': '1', 09:25:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:00 INFO - 'PWD': '/builds/slave/test', 09:25:00 INFO - 'SHELL': '/bin/bash', 09:25:00 INFO - 'SHLVL': '1', 09:25:00 INFO - 'TERM': 'linux', 09:25:00 INFO - 'TMOUT': '86400', 09:25:00 INFO - 'USER': 'cltbld', 09:25:00 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', 09:25:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:00 INFO - '_': '/tools/buildbot/bin/python'} 09:25:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:00 INFO - Running setup.py (path:/tmp/pip-WhC_oX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:00 INFO - Running setup.py (path:/tmp/pip-0glHhV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:00 INFO - Running setup.py (path:/tmp/pip-vdStr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:00 INFO - Running setup.py (path:/tmp/pip-WM4jNK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:00 INFO - Running setup.py (path:/tmp/pip-SDZrXy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:01 INFO - Running setup.py (path:/tmp/pip-5o6NpW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:01 INFO - Running setup.py (path:/tmp/pip-ZThDys-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:01 INFO - Running setup.py (path:/tmp/pip-UPDy2z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:01 INFO - Running setup.py (path:/tmp/pip-w43zd9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:01 INFO - Running setup.py (path:/tmp/pip-rtiUgi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:01 INFO - Running setup.py (path:/tmp/pip-FTIz07-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:01 INFO - Running setup.py (path:/tmp/pip-lmbgtp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:01 INFO - Running setup.py (path:/tmp/pip-QZCi7c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:01 INFO - Running setup.py (path:/tmp/pip-p3w8Co-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:01 INFO - Running setup.py (path:/tmp/pip-NMGyQA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:01 INFO - Running setup.py (path:/tmp/pip-_jAax5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:01 INFO - Running setup.py (path:/tmp/pip-0RYNAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:25:01 INFO - Running setup.py install for manifestparser 09:25:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Running setup.py install for mozcrash 09:25:02 INFO - Running setup.py install for mozdebug 09:25:02 INFO - Running setup.py install for mozdevice 09:25:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Running setup.py install for mozfile 09:25:02 INFO - Running setup.py install for mozhttpd 09:25:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Running setup.py install for mozinfo 09:25:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Running setup.py install for mozInstall 09:25:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Running setup.py install for mozleak 09:25:02 INFO - Running setup.py install for mozlog 09:25:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:25:02 INFO - Running setup.py install for moznetwork 09:25:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:25:03 INFO - Running setup.py install for mozprocess 09:25:03 INFO - Running setup.py install for mozprofile 09:25:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:25:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:25:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:25:03 INFO - Running setup.py install for mozrunner 09:25:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:25:03 INFO - Running setup.py install for mozscreenshot 09:25:03 INFO - Running setup.py install for moztest 09:25:03 INFO - Running setup.py install for mozversion 09:25:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:25:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:25:03 INFO - Cleaning up... 09:25:03 INFO - Return code: 0 09:25:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25:03 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:25:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:03 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:25:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:03 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 0xbd1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe903b0>, '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 0xe912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91740>, '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': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', '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:25:03 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:25:03 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:25:03 INFO - Using env: {'DISPLAY': ':0', 09:25:03 INFO - 'HOME': '/home/cltbld', 09:25:03 INFO - 'LANG': 'en_US.UTF-8', 09:25:03 INFO - 'LANGUAGE': 'en_US:en', 09:25:03 INFO - 'LOGNAME': 'cltbld', 09:25:03 INFO - 'MAIL': '/var/mail/cltbld', 09:25:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:03 INFO - 'MOZ_NO_REMOTE': '1', 09:25:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:03 INFO - 'NO_EM_RESTART': '1', 09:25:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:03 INFO - 'PWD': '/builds/slave/test', 09:25:03 INFO - 'SHELL': '/bin/bash', 09:25:03 INFO - 'SHLVL': '1', 09:25:03 INFO - 'TERM': 'linux', 09:25:03 INFO - 'TMOUT': '86400', 09:25:03 INFO - 'USER': 'cltbld', 09:25:03 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', 09:25:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:03 INFO - '_': '/tools/buildbot/bin/python'} 09:25:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:25:03 INFO - Running setup.py (path:/tmp/pip-bxLp0f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:25:03 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:25:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:25:04 INFO - Running setup.py (path:/tmp/pip-4Z1JdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:25:04 INFO - Running setup.py (path:/tmp/pip-z2cloI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:25:04 INFO - Running setup.py (path:/tmp/pip-xhzsEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:25:04 INFO - Running setup.py (path:/tmp/pip-KKnxls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:25:04 INFO - Running setup.py (path:/tmp/pip-BUZ6SY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:25:04 INFO - Running setup.py (path:/tmp/pip-Walg_w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:25:04 INFO - Running setup.py (path:/tmp/pip-PlQTc4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:25:04 INFO - Running setup.py (path:/tmp/pip-ApitM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:25:04 INFO - Running setup.py (path:/tmp/pip-h2TO8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:25:04 INFO - Running setup.py (path:/tmp/pip-8kzJ2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:25:04 INFO - Running setup.py (path:/tmp/pip-OsdJ5U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:25:04 INFO - Running setup.py (path:/tmp/pip-OFOq3l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:25:04 INFO - Running setup.py (path:/tmp/pip-FiuqEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:25:04 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:25:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:04 INFO - Running setup.py (path:/tmp/pip-XufH_x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:25:05 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:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:25:05 INFO - Running setup.py (path:/tmp/pip-ezajBA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:25:05 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:25:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:25:05 INFO - Running setup.py (path:/tmp/pip-9NLt8s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 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:25:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:25:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:25:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:25:07 INFO - Downloading blessings-1.6.tar.gz 09:25:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:25:07 INFO - Installing collected packages: blessings 09:25:07 INFO - Running setup.py install for blessings 09:25:07 INFO - Successfully installed blessings 09:25:07 INFO - Cleaning up... 09:25:07 INFO - Return code: 0 09:25:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:25:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:07 INFO - Reading from file tmpfile_stdout 09:25:07 INFO - Current package versions: 09:25:07 INFO - argparse == 1.2.1 09:25:07 INFO - blessings == 1.6 09:25:07 INFO - blobuploader == 1.2.4 09:25:07 INFO - docopt == 0.6.1 09:25:07 INFO - functools32 == 3.2.3-2 09:25:07 INFO - jsonschema == 2.5.1 09:25:07 INFO - manifestparser == 1.1 09:25:07 INFO - mozInstall == 1.12 09:25:07 INFO - mozcrash == 0.17 09:25:07 INFO - mozdebug == 0.1 09:25:07 INFO - mozdevice == 0.48 09:25:07 INFO - mozfile == 1.2 09:25:07 INFO - mozhttpd == 0.7 09:25:07 INFO - mozinfo == 0.9 09:25:07 INFO - mozleak == 0.1 09:25:07 INFO - mozlog == 3.2 09:25:07 INFO - moznetwork == 0.27 09:25:07 INFO - mozprocess == 0.22 09:25:07 INFO - mozprofile == 0.28 09:25:07 INFO - mozrunner == 6.11 09:25:07 INFO - mozscreenshot == 0.1 09:25:07 INFO - mozsystemmonitor == 0.3 09:25:07 INFO - moztest == 0.7 09:25:07 INFO - mozversion == 1.4 09:25:07 INFO - psutil == 3.1.1 09:25:07 INFO - requests == 1.2.3 09:25:07 INFO - wsgiref == 0.1.2 09:25:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:25: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:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:07 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 0xbd1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe903b0>, '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 0xe912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91740>, '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': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', '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:25:07 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:25:07 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:25:07 INFO - Using env: {'DISPLAY': ':0', 09:25:07 INFO - 'HOME': '/home/cltbld', 09:25:07 INFO - 'LANG': 'en_US.UTF-8', 09:25:07 INFO - 'LANGUAGE': 'en_US:en', 09:25:07 INFO - 'LOGNAME': 'cltbld', 09:25:07 INFO - 'MAIL': '/var/mail/cltbld', 09:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:07 INFO - 'MOZ_NO_REMOTE': '1', 09:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:07 INFO - 'NO_EM_RESTART': '1', 09:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:07 INFO - 'PWD': '/builds/slave/test', 09:25:07 INFO - 'SHELL': '/bin/bash', 09:25:07 INFO - 'SHLVL': '1', 09:25:07 INFO - 'TERM': 'linux', 09:25:07 INFO - 'TMOUT': '86400', 09:25:07 INFO - 'USER': 'cltbld', 09:25:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', 09:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:07 INFO - '_': '/tools/buildbot/bin/python'} 09:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 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:25:07 INFO - Cleaning up... 09:25:07 INFO - Return code: 0 09:25:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:25: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:25:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:25:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25: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:25:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:25:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:25:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xbd1030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xd348a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xe92180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xe903b0>, '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 0xe912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91740>, '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': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', '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:25:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:25:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:25:07 INFO - Using env: {'DISPLAY': ':0', 09:25:07 INFO - 'HOME': '/home/cltbld', 09:25:07 INFO - 'LANG': 'en_US.UTF-8', 09:25:07 INFO - 'LANGUAGE': 'en_US:en', 09:25:07 INFO - 'LOGNAME': 'cltbld', 09:25:07 INFO - 'MAIL': '/var/mail/cltbld', 09:25:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:07 INFO - 'MOZ_NO_REMOTE': '1', 09:25:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:07 INFO - 'NO_EM_RESTART': '1', 09:25:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:07 INFO - 'PWD': '/builds/slave/test', 09:25:07 INFO - 'SHELL': '/bin/bash', 09:25:07 INFO - 'SHLVL': '1', 09:25:07 INFO - 'TERM': 'linux', 09:25:07 INFO - 'TMOUT': '86400', 09:25:07 INFO - 'USER': 'cltbld', 09:25:07 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', 09:25:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:07 INFO - '_': '/tools/buildbot/bin/python'} 09:25:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:25:08 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:25:08 INFO - Cleaning up... 09:25:08 INFO - Return code: 0 09:25:08 INFO - Running post-action listener: _resource_record_post_action 09:25:08 INFO - Running post-action listener: _start_resource_monitoring 09:25:08 INFO - Starting resource monitoring. 09:25:08 INFO - ##### 09:25:08 INFO - ##### Finished create-virtualenv step (success) 09:25:08 INFO - ##### 09:25:08 INFO - ##### 09:25:08 INFO - ##### Running install step. 09:25:08 INFO - ##### 09:25:08 INFO - Running pre-action listener: _resource_record_pre_action 09:25:08 INFO - Running main action method: install 09:25:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:25:08 INFO - Reading from file tmpfile_stdout 09:25:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:25:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:25:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:25:08 INFO - Reading from file tmpfile_stdout 09:25:08 INFO - Output received: 09:25:08 INFO - Usage: mozinstall [options] installer 09:25:08 INFO - Options: 09:25:08 INFO - -h, --help show this help message and exit 09:25:08 INFO - -d DEST, --destination=DEST 09:25:08 INFO - Directory to install application into. [default: 09:25:08 INFO - "/builds/slave/test"] 09:25:08 INFO - --app=APP Application being installed. [default: firefox] 09:25:08 INFO - mkdir: /builds/slave/test/build/application 09:25:08 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:25:08 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:25:24 INFO - Reading from file tmpfile_stdout 09:25:24 INFO - Output received: 09:25:24 INFO - /builds/slave/test/build/application/firefox/firefox 09:25:24 INFO - Running post-action listener: _resource_record_post_action 09:25:24 INFO - ##### 09:25:24 INFO - ##### Finished install step (success) 09:25:24 INFO - ##### 09:25:24 INFO - ##### 09:25:24 INFO - ##### Running run-tests step. 09:25:24 INFO - ##### 09:25:24 INFO - Running pre-action listener: _resource_record_pre_action 09:25:24 INFO - Running main action method: run_tests 09:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:25:24 INFO - Python 2.7.3 09:25:24 INFO - Return code: 0 09:25:24 INFO - grabbing minidump binary from tooltool 09:25:24 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:25:24 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 0xe903b0>, '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 0xe912b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0xe91740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:25:24 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:25:24 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:25:24 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:25:24 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:25:24 INFO - Return code: 0 09:25:24 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:25:24 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:25:24 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:25:24 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:25:24 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:25:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 09:25:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-003 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 09:25:24 INFO - Using env: {'DISPLAY': ':0', 09:25:24 INFO - 'HOME': '/home/cltbld', 09:25:24 INFO - 'LANG': 'en_US.UTF-8', 09:25:24 INFO - 'LANGUAGE': 'en_US:en', 09:25:24 INFO - 'LOGNAME': 'cltbld', 09:25:24 INFO - 'MAIL': '/var/mail/cltbld', 09:25:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:25:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:25:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:25:24 INFO - 'MOZ_NO_REMOTE': '1', 09:25:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:25:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:25:24 INFO - 'NO_EM_RESTART': '1', 09:25:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:25:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:25:24 INFO - 'PWD': '/builds/slave/test', 09:25:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:25:24 INFO - 'SHELL': '/bin/bash', 09:25:24 INFO - 'SHLVL': '1', 09:25:24 INFO - 'TERM': 'linux', 09:25:24 INFO - 'TMOUT': '86400', 09:25:24 INFO - 'USER': 'cltbld', 09:25:24 INFO - 'XDG_SESSION_COOKIE': '7de08804244eb36560b44971000001c3-1467822273.587255-789491697', 09:25:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:25:24 INFO - '_': '/tools/buildbot/bin/python'} 09:25:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-003', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 09:25:24 INFO - mozversion application_buildid: 20160706083823 09:25:24 INFO - mozversion application_changeset: df4803bab0bc40c206c6977a8cc7fcaeac677357 09:25:24 INFO - mozversion application_display_name: Nightly 09:25:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:25:24 INFO - mozversion application_name: Firefox 09:25:24 INFO - mozversion application_remotingname: firefox 09:25:24 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:25:24 INFO - mozversion application_vendor: Mozilla 09:25:24 INFO - mozversion application_version: 50.0a1 09:25:24 INFO - mozversion platform_buildid: 20160706083823 09:25:24 INFO - mozversion platform_changeset: df4803bab0bc40c206c6977a8cc7fcaeac677357 09:25:24 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:25:24 INFO - mozversion platform_version: 50.0a1 09:25:24 INFO - using testdate: 1467822324 09:25:24 INFO - actual date: 1467822324 09:25:24 INFO - starting webserver on 'localhost:43349' 09:25:24 INFO - SUITE-START | Running 2 tests 09:25:24 INFO - TEST-START | dromaeo_css 09:25:24 INFO - operating with platform_type : linux_ 09:25:24 INFO - Initialising browser for dromaeo_css test... 09:25:24 INFO - TEST-INFO | started process 17568 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWL4IEH/profile http://localhost:43349/getInfo.html) 09:25:29 INFO - PROCESS | 17568 | __metrics Screen width/height:1600/1200 09:25:29 INFO - PROCESS | 17568 | colorDepth:24 09:25:29 INFO - PROCESS | 17568 | Browser inner width/height: 1024/697 09:25:29 INFO - PROCESS | 17568 | __metrics 09:25:30 INFO - PROCESS | 17568 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:25:31 INFO - TEST-INFO | 17568: exit 0 09:25:31 INFO - Browser initialized. 09:25:31 INFO - Running cycle 1/1 for dromaeo_css test... 09:25:31 INFO - TEST-INFO | started process 17651 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWL4IEH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:25:43 INFO - PROCESS | 17651 | RSS: Main: 158826496 09:25:43 INFO - PROCESS | 17651 | 09:26:34 INFO - PROCESS | 17651 | 1467822394305 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:28:47 INFO - PROCESS | 17651 | Cycle 1(1): loaded http://localhost:43349/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43349/tests/dromaeo/cssquery-ext.html) 09:28:48 INFO - PROCESS | 17651 | RSS: Main: 266485760 09:28:48 INFO - PROCESS | 17651 | 09:31:51 INFO - PROCESS | 17651 | Cycle 1(1): loaded http://localhost:43349/tests/dromaeo/cssquery-ext.html (next: http://localhost:43349/tests/dromaeo/cssquery-jquery.html) 09:31:51 INFO - PROCESS | 17651 | RSS: Main: 245661696 09:31:51 INFO - PROCESS | 17651 | 09:34:54 INFO - PROCESS | 17651 | Cycle 1(1): loaded http://localhost:43349/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43349/tests/dromaeo/cssquery-mootools.html) 09:34:54 INFO - PROCESS | 17651 | RSS: Main: 253657088 09:34:54 INFO - PROCESS | 17651 | 09:37:56 INFO - PROCESS | 17651 | Cycle 1(1): loaded http://localhost:43349/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43349/tests/dromaeo/cssquery-prototype.html) 09:37:57 INFO - PROCESS | 17651 | RSS: Main: 242552832 09:37:57 INFO - PROCESS | 17651 | 09:41:00 INFO - PROCESS | 17651 | Cycle 1(1): loaded http://localhost:43349/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43349/tests/dromaeo/cssquery-yui.html) 09:41:01 INFO - PROCESS | 17651 | RSS: Main: 221446144 09:41:01 INFO - PROCESS | 17651 | 09:44:03 INFO - PROCESS | 17651 | Cycle 1(1): loaded http://localhost:43349/tests/dromaeo/cssquery-yui.html (next: http://localhost:43349/tests/dromaeo/cssquery-dojo.html) 09:44:03 INFO - PROCESS | 17651 | RSS: Main: 297906176 09:44:03 INFO - PROCESS | 17651 | 09:44:03 INFO - PROCESS | 17651 | __start_tp_report 09:44:03 INFO - PROCESS | 17651 | _x_x_mozilla_page_load 09:44:03 INFO - PROCESS | 17651 | _x_x_mozilla_page_load_details 09:44:03 INFO - PROCESS | 17651 | |i|pagename|runs| 09:44:04 INFO - PROCESS | 17651 | |0;dojo.html;2594.54595445797;2602.687677478703;2647.52344577976;2659.8803053862575;2660.6275121482995;4597.1265459562655;4600.516945720701;4635.745034023127;4720.645951553634;4739.454962679293;4728.692634978733;4745.620350371971;4752.2396416573265;4784.928226076603;4789.856304310868;4318.222719910407;4364.629006534448;4392.934105988413;4430.113977204556;4439.045605194882;4374.2126417245045;4404.559544045602;4431.069475410168;4431.113777244548;4463.575960283768;4273.465816772903;4322.805473753689;4326.762028088454;4368.584984426506;4421.226285400075;4311.956880431187;4315.093830295642;4319.460067491564;4431.578999994996;4479.529649386833;4342.413774140482;4349.913001739979;4356.390105385249;4391.736495810262;4407.559244075599;4595;4601.700889442175;4619.076184763061;4764.95235047652;4802.039592081597;4970.676906001098;5023.8492845214705;5031.295618613397;5032.169692000815;5035.571976382012;4991.326170966946;5036.697798132123;5039.143345631252;5050.166722490784;5052.8484145475695;4654.371659825948;4673.228917228687;4712.5994290485005;4736.100140973204;4788.329633851229;5227.163653815447;5240.9213861792105;5242.213667949838;5253.789848406097;5254.527092561688;5012.674176178537;5020.071286811952;5022.648414610942;5023.447420783711;5025.648204625714;5010.148274793294;5016.498350165028;5046.873828154326;5052.621053421009;5073.34046573943;5018.648694591417;5043.067032598981;5045.621578381636;5047.823326183639;5100.515451032146;4918.92621610669;5032.396112466454;5036.697798132051;5047.570956468668;5051.873703157377;4182.979085104555;4216.430781844473;4230.555791641895;4230.936535951963;4273.487181538236;3730.440433934877;3739.7943113128495;3758.285925674113;3782.791946442972;3796.620337966181;4429.291313389842;4436.245838207513;4436.844710435119;4472.932906006413;4482.686211965196;4928.408590969035;4973.35346404965;5001.0998020355955;5071.797128114834;5153.974230128825;4340.392345071693;4362.236608593484;4373.234683930299;4403.207422663952;4412.7793610319995;4501.459824821042;4515.412996310524;4515.9548404515535;4519.367288579601;4561.7262964222255;4697.412823397075;4791;4792.424909011011;4828.082664293773;4834.323194752667;5086.694798312114;5108.59131269505;5111.05445492585;5137.280780690631;5169.172932330809;4831.492693267297;4843.75781210931;4844.709317440965;4847.297141914332;4891.853244402673;4905.926411103907;5008.474110218521;5038.974805125951;5078.9238161426865;5097.898042039213;5123.974380128076;5157.690538567698;5159.251908473326;5160.716160611202;5214.634975551675;4791.377120974391;4973.229149481836;4981.178105612678;4992.2761199626575;4999.150144475375;4788.688735232199;4802.73584952831;4812.759362031955;4814.735189564468;4843.200871856105;4761;4763.237881938873;4812.302216178705;4812.855614331575;4814.903701925872;4837.080954618611;4863.878403039952;4873.269009648439;4875.853724388274;4886.633502487257;4819.421669399694;4840.709557426566;4850.369451971221;4860.416749990024;4914.287428322945 09:44:04 INFO - PROCESS | 17651 | |1;ext.html;577.8035467940902;579.9971000144996;582.9594174398698;585.9765609375626;597.3906615252444;28197;41311.58688413115;42389.36415953763;42413.36379954303;46094.53905460944;41472.79263603678;41782;41872.37191442131;42017.7899110504;42060.15879682404;7566.092068951733;7847.725329613479;7964.2433968772875;7995.6801727930815;7998.520088794691;7478.102627684685;7719.922800772005;7725.497842640239;10178.23663225261;10385.376877387382;10394.688159355193;10421.645186125794;10430.63492777753;10436.686899393031;10442.58229670816;10216.13162881156;10272.383656980604;10275.126614237799;10278.588856445771;10286.794264114751;7528.47300688952;7708.884366734504;7709.6916123354995;9957.80084398308;10349.844752328721;39418;39693;39802.40296395557;39842;39908.20183596312;2751.2984189031667;2777.7777777777933;2803.088996076263;3278.378714410046;3313.4698448248405;29745.405091898258;30021.849890750407;30198.396032079236;30243.546346804815;30583.541246881316;3348.5479460272795;3354.4465163248033;3386.4920261960656;3434.3989801784837;3445.3798316303055;251750;251818;252839;252982;253365;48864.51135488671;55781.44218557844;57256;57442.42557574454;62214;60145.69927150336;60219.39780602138;60297;60482.39517604856;60677.39322606806;15209.923950380398;15396.384144634088;15404.075755454709;15425.074495530303;15434.228288585751;9107.635694572275;10719;10736.463176841127;10740.946295268473;10816.513256903301;18129.909350453163;18774.1551630177;18782.718259226123;19244;19410.22359105648;6712.865742685119;6865.9313406866295;6921.619310937846;7002.444107900579;7159.212486626467;827.3257295304428;976.858355538443;984.2765567308023;993.9006099390003;1028.1928685981468;28200.29499262535;29393.85303073471;29417.705822941498;29500.409991800043;29698.554521682192;951.3911096897991;967.9854802177973;985.9457729824785;1019.1948360795037;1028.4292217819032;15077.773833392288;15358.155301458528;15588.376464941275;15772.369105235892;15858.762118568231;384512;386397;387547;387733;387890;31444;31561.526577101362;31578.684213158034;31603.20991975219;31664.050078497683;1072.619220176826;1140.6578026592156;1190.1918637051135;1206.7526157137765;1221.3099598726692;29121.41757164887;29672;30036.24909377283;30322.116696010467;30464.238394040327;42742;43105.784471077444;43221;43263.78368108139;43364;290742;291449;291821;293061;293073;22574.774252257925;25441.872790635927;25742.87128564345;26075.348116297246;26174.476510470064;41356;42427.7878610605;42514.14971700487;43108.13783724245;43555.564444356416;36990.075248119014;37158.8142059288;37280.813595931846;37542.812285938395;37940.05149871275;36087.45868812023;37122.25755484929;37547.2490550182;37607;37643;35817;36559.81720091382;37197.25605487929;37342.2531549362;37878;32580;34032.65967340295;34586;34591.13522161966;34855.47716784301;25586.872065639553;25939.87030064913;26068.73931260739;26157;26171 09:44:04 INFO - PROCESS | 17651 | |2;jquery.html;374.7470457441227;376.50677612327854;383.29091181314556;386.1215734204684;395.6913607386238;16588.585285367855;16788.412405565792;17400.21699023544;17597.472075837744;17617.471475855727;10412.531436085375;10940.45297735112;10959.780804383907;10966.835497467524;10968.506417211225;4600.424946881648;4631.513691062423;4746.169420351442;5600.52395546379;5605.971970140144;5591.524720398751;5608.158776183564;5619.6066275360745;5636.0982242841155;5659.5755318351285;5144.742762861861;5423.538999185074;5424.918626220609;5510.531604813596;5569.610127291091;5523.337199536061;5534.695591742473;5541.501264886159;5546.362168350651;5553.722313884289;4667.8599642010795;4956.950430495685;4960;5010.173321401964;5017.147084995559;20456.69314960277;20662.690059649118;20882.89558552213;21070.683939740917;21650.24224152147;1767.098779622389;1887.5469887227105;1898.8006259342847;1908.427471758467;1923.1538123225737;14437.278136093259;14858.851411485855;15161.241937903062;15407.460738874197;16161.757573636405;1958.99020504898;1992.5715971066145;2024.058812652109;2043.3665563675308;2049.723287356203;63962.68018659923;67956;70573.29426705718;79824.60087699525;82925;15991.041657293204;17433.738493922603;17495.912520437316;17889.821101789075;18121.456356309332;30423.543646845315;30595.541066884016;30861.228469288;30897;30950.380992380477;8917.464952102895;9484.288678349152;9745.366551174293;9763;10013.048760367754;8030.839383212303;8140.145284745016;8202.671893124209;8233.17668233172;8359.791005224917;8691.304695624334;8772.692955746517;8783.385163038654;8815.426997245158;8968.282537396992;3178.8092714436743;3409.7613167078066;3418.6239513653477;3455.6889879910927;3650.1239702471216;788.5584072919183;843.7682330236613;898.2437990838525;929.9488528131018;955.1212884146602;17819.376321828673;18293.08534573266;18342.082895855154;18425.355112570996;18460.907695461436;911.9635214591475;914.2503147419053;917.124146440148;933.7338858425317;944.7354740672623;9976.152027077635;10055.547500362502;10241.795164096677;10241.795164096677;10280.845787313196;370309;372055;373379;380008;383875;51426;73008.63495682487;74593.6270318645;74787;81811.18188818036;910.981780364389;927.8283517549276;940.9294302927308;958.6884262614678;959.4147569982305;16353.936994095346;16527.669446611242;16867.240974156437;16962.321507139575;17171.484855453855;28192.15423537297;38595.80702096471;39672;40899;42404.1519169621;56488.71755641195;57059.144112839174;58386.54033649023;58986.705066474395;59242;7499.962500187464;7855.410844186823;7867.213278672087;7882.763517094496;8020.197980202167;8794.384393092421;11859.16985810985;11976.46105925218;12209.267443953391;12268.386580670753;10396;10517.631882884063;10557.63048293306;10735.46322683847;11011.064059555027;10430.26988110825;10582.682519524427;10622.468876556295;10773.084287835622;10868.076213521623;10536.84194737095;10749.140068794633;11099.112071034137;11123.83314250303;11139.10887129044;7703.345215656732;7748.535087894745;7840.764777056697;7863.252990965849;8086.838263234585;8481.703140390056;10719.678409647722;10875.912408759377;10962.671119866416;10977.725556861142 09:44:04 INFO - PROCESS | 17651 | |3;mootools.html;1256.3341429042612;1357.6605848537863;1413.371049882802;1465.6848777512832;1714.6484970581039;6845.931540684592;7661.502002369849;7882.842343153141;7926.405519586026;8166.428350015486;7892.131865494791;8027.759167224993;8030.839383212332;8036.477628954114;8040.236177563137;2201.5927053495075;2231.230225572183;2234.1733558583264;2236.1614394602025;2236.720409948748;2175.3147758456116;2201.9779802202015;2239.8320125990535;2242.820574354048;2244.517428752818;2215.2468160825315;2217.5343177932655;2224.6774217738416;2228.2535350657467;2256.8307376946714;2083.7395325584303;2087.269455690504;2090.9581808363823;2091.2262462888675;2095.4132842803965;1954.7556555430572;1980.9009549522611;1982.9504262393555;1992.980070199294;1995.8503112266637;7893.526388416713;7998.760037198836;8010.239027292398;8074.152214017502;8085.474444161169;4559.17934771741;4727.66906316558;4735.763211839429;4736.692115012514;4738.3603213566075;2811.381496070861;2895.2761809547615;2948.78840869348;2955;2974.8363839988792;869.9869501957476;879.4415546128255;879.5997820991433;881.532787622561;892.4912799704172;10801.135909127252;10811;10913.781724365468;10929.672109836718;10930.289531180448;3945.3095708251517;3983.083890705154;4131.173765246963;4158.750474971512;4242.787860607019;8297.04583972851;8321.750347489586;8336.541490218096;8346.916530834615;8349.123342049119;4725.149473094807;4725.64557658177;4726.598239149642;4732.2428411454;4734.313524538991;3626.9818650907105;4049.655779258796;4206.621404073648;4378.321360189176;4378.5183629800695;3420.8289585520624;3461.1693193633346;3479.251960828434;3490.110021944388;3648.179159689049;1031.504877658728;1053.8155822730992;1060.734816295926;1066.8239740442896;1077.6389909380446;679.6839469646638;754.1704125461948;754.2985023927799;799.3605115907251;818.2594751749676;4963.875903102451;5053.2420136979745;5080.5681517070725;5157;5172.327597412313;392.95481019683103;394.41823310617184;395.28848073467645;395.96455269470704;413.14272883765705;3376.206591451007;3513.982430087833;3523.3834079036064;3546.91132721684;3585.049961760136;9411.952940235255;9880.863700674514;9899.851502227473;9935.503224838729;9935.850962235572;9877.901220987842;9905.20758339331;9908.752281192883;9916.057974492413;9919.256055795844;7374.815629609303;7524.247575242542;7563.924360756322;7582.962085189649;7606.20134885829;5093.083245015932;5101.668391554537;5126.871828204325;5149.382074151126;5182.585393168462;8904.688335908211;9016.954915225382;9141.77145571366;9154.084591540792;9166.129217724305;9246.815063698554;9377.718668439958;9378.859317110113;9397.577109030246;9411.247100232102;5489.34127904654;6020.668863212565;6185.041318595625;6376.553641245068;6428.132202152837;7677.500962437423;7699.8845017323665;7761.107472640493;7768.689252430066;7774.961125194338;6742.595444273359;6785.491088168308;6834.897476537756;6866.759663411756;6982.720691172296;6845.486588505982;6946.305369463215;6999.580025198505;7015.052967849275;7083.964580177066;5906.852328691645;5951.494122999594;5990.1314309424015;6002.129691194839;6079.756809727562;4351.891202719958;4382.912341753084;4413.360062790942;4466.419365482597;4475.776211189493;4425.601695847389;4446.0885518467985;4468.754218518013;4533.818647254205;4577.153226653079 09:44:04 INFO - PROCESS | 17651 | |4;prototype.html;294.70676676706665;297.05684451865324;300.7218323051177;304.44135012252514;308.99730374933335;4829.082474329879;4883.413990321166;4890.193118135508;4891.877703057426;4906.975465122669;4783.545563171502;4802.303665968432;4850.9029819403595;4855.902881942359;4862.416510018803;3630.4917311576464;3692.9446058309145;3743.28877513273;3802.4676545283683;3821.29306078375;3770.377887648535;3786.9053273668105;3811.504504414422;3816.847326106966;3833.5974722654137;3602.2795440911923;3773.415120656303;3791.4312853071983;3801.3727734923705;3811.7141214408894;3663.139162296858;3766.1902690921584;3771.8868433947027;3776.867809626677;3793.596369343333;3341.7159541439005;3351.983240083808;3357.6306606273292;3374.2407958209205;3383.8646454141804;4704.823794051487;4733.337332773414;4735.124002059595;4751.548602882721;4757.286407038937;4235.745855248664;4273.807678654468;4279;4307.849225277131;4367.301231802928;4961.8663974490955;4965.230389289666;4991.550760431543;5011.198208286693;5013.172826483626;3614.36748569002;3618.3486972344967;3631.782093074424;3646;3653.1962968146963;5125.897482050375;5211.270422140903;5226.608004399685;5261.3167284684705;5321.361436627591;3716.925661486755;3745.138618117848;3751.6811071059265;3759.6616304532176;3780.4140358244517;3815.6565909068318;3818.694504439638;3819.7899115548357;3842.634949679832;3843.98190949748;4321.481422229353;4321.644703636525;4327.0480494291205;4327.978360108179;4346.847860324873;4926.655134140576;4983.526564976321;5020.870304181603;5028.723420211923;5040.8487745366965;1310.2007775257086;1311.3377744239099;1322.3322222277689;1322.4577923051502;1327.681356474439;853.4580541356283;871.4335681806876;893.8301722672801;902.7923577577194;903.1600611431301;4360.49854266757;4371.584699453547;4456.398386217884;4473.239549276631;4481.775911204427;5123.3339665843205;5124.5131712487255;5144.61415393847;5163.044836705147;5171.379434467813;4272.957270427318;4414.09511050234;4428.158649856581;4436;4514.781009127517;2723.319170207448;2741.136541989267;2745.958810617842;2750.5049091163382;2768.8615569221456;4868.391451068616;4876.244182151772;4894.412670479494;4930.161872481687;4938.185199442052;5033.823816166417;5256.6057545684225;5265.736713164327;5281.445448227881;5312.1766126250495;4854.490278520704;4867.367242258484;4870.172070747982;4887.315775791392;4901.362822833009;5136.691798492103;5161.793528258828;5187.507186817246;5190.688558686491;5198.636095473281;4898.779554919965;5035.924461133012;5045.5459008689395;5069.239614057921;5071.771770270273;4870.634702397405;4884.267359896044;4885.75413269614;4894.238074293323;4907.386576677915;3700.982964284525;3702.2595480904465;3727.813609319469;3734.8879533614036;3741.270452261783;4973.403191617029;5172.482751724798;5183.300254465599;5187.896242075213;5205.6356055075785;4934.18585933317;4935.358403407534;4951.851444456672;4954.984228233276;5003.424606170337;4936.2102063669645;4938.901221975469;4962.181240095344;4968.254761785761;4987.202047672355;4650.279206722963;4671.696339737906;4882.462929077869;4900.460949295503;4909.95090049095;4909.656324057424;5037.496250374933;5046.722430266371;5050.823221187241;5061.898762024665;4923.236898280772;4928.852134435972;4947.752612369439;4968.503149685002;4983.25251212321 09:44:04 INFO - PROCESS | 17651 | |5;yui.html;617.9165812615297;626.2766504687087;644.9484041276695;660.2077506991611;699.9335063168998;10501.527431265593;11296.604618838343;11383.886161138396;12204.389780510972;12213.267203967756;12717.23696578206;14172.50396236132;14199.645008874782;14199.71600567988;14276.500322488715;624.1760875644152;746.3506749128239;775.1241097559749;778.4667502760627;781.8788087846365;780.2665494435241;780.9219078092202;782.9138794732575;787.0122995640463;788.4756636836497;820.3478234803316;823.1480417767611;825.7275099217273;826.1862065865118;826.8263664630434;813.1299509524811;814.2549567146054;814.5194335342147;815.3517953227199;815.3762371785589;599.0534954771495;600.0369407101583;600.7957294519884;601.0923505506672;601.1073555769678;12438.19151755133;12505.187162834387;12543.121981461301;12622.431990560446;12644.051696122828;11726.706832329175;11822.890959581582;11878.346690931996;12045.879541204564;12140.392980350947;7912.169222231698;8016.719414820512;8071.919280807176;8135.430519863612;8157.14349993254;3221.32352206037;3252.567882388754;3252.9186770330693;3255.5930508686415;3308.2225676965895;42041;43395.349069763666;43644;49245.261321080216;65552.67223663851;7245.347918687344;8840.690575829814;9273.020679762612;9359.970403255773;9373.437593744397;16883;16938.153092345332;16981.235844387033;16988.235529401205;17009.659806803793;6254.843628909222;6256.710931764444;6383.744650213939;6449.871002579922;6569.967150164314;3560.4481305397703;3591.4792355108884;3602.351576716164;3663.6885864701267;3669.412893936957;2799.3981294021883;2898;2900.202444327827;2901.10065879578;2909.7090290971155;494.868859752166;507.3075252280684;508.4737296897693;509.40399732313284;554.1549137565245;583.2942140010634;597.6623207887529;604.7308947518312;608.5162295974711;619.102301662591;7818.4136189785995;8028.277455029075;8182.18178182189;8589.484630922165;8738.69414570487;511.5575027601098;516.7571241516481;526.4491008150053;531.2801154435762;536.629725489411;3853.672437842759;3939.074317535377;3968.940465893014;4068.2591137469103;4144.191882582928;58554.70722646359;59180.40819591835;59398;59453;60318.39681603128;92875.53562232146;95825.5208723952;97571;97677.5116124429;97910;40538;46242;74517.50964980779;75752.24247757673;77502;8935.508547029976;9140.497272649802;9169.220616247694;9208.585613647268;9438.433693978383;42835.357469637354;43858.12283754243;45254.54745452503;45264.094718104796;46536.83657908444;36208.45687314745;50386;60668.69665651643;60798.39201607927;61319.69340153449;11375.601853935073;11834.408279586158;11878.584249551224;12180.817287740869;12500.499980000699;13034.4134513949;13278.867211327763;13533.93233033868;13618.93190534041;14057.718845623234;11759.882401175879;12192;12257.570985015482;12270.325132117463;12865.614031579067;12311.815322770344;12997.610071697864;13059.934700326437;13352.532661356807;13468.595942121752;11320.37737924422;11558.653240402802;11560.364179969845;11634.592789252336;12063.336516491327;10413.843792343272;10509.31689440184;10634.361938283728;10816.296940698829;10903.509342079467;9523.761905952406;9613.375130616487;9723.56243969009;10413.895861041292;10416.531256093342 09:44:04 INFO - PROCESS | 17651 | __end_tp_report 09:44:04 INFO - PROCESS | 17651 | __start_cc_report 09:44:04 INFO - PROCESS | 17651 | _x_x_mozilla_cycle_collect,1047 09:44:04 INFO - PROCESS | 17651 | __end_cc_report 09:44:04 INFO - PROCESS | 17651 | __startTimestamp1467823443994__endTimestamp 09:44:04 INFO - PROCESS | 17651 | 09:44:04 INFO - PROCESS | 17651 | ------- Summary: start ------- 09:44:04 INFO - PROCESS | 17651 | Number of tests: 6 09:44:04 INFO - PROCESS | 17651 | 09:44:04 INFO - PROCESS | 17651 | [#0] dojo.html Cycles:165 Average:4677.50 Median:4802.74 stddev:489.61 (10.2%) stddev-sans-first:463.04 09:44:04 INFO - PROCESS | 17651 | Values: 2594.5 2602.7 2647.5 2659.9 2660.6 4597.1 4600.5 4635.7 4720.6 4739.5 4728.7 4745.6 4752.2 4784.9 4789.9 4318.2 4364.6 4392.9 4430.1 4439.0 4374.2 4404.6 4431.1 4431.1 4463.6 4273.5 4322.8 4326.8 4368.6 4421.2 4312.0 4315.1 4319.5 4431.6 4479.5 4342.4 4349.9 4356.4 4391.7 4407.6 4595.0 4601.7 4619.1 4765.0 4802.0 4970.7 5023.8 5031.3 5032.2 5035.6 4991.3 5036.7 5039.1 5050.2 5052.8 4654.4 4673.2 4712.6 4736.1 4788.3 5227.2 5240.9 5242.2 5253.8 5254.5 5012.7 5020.1 5022.6 5023.4 5025.6 5010.1 5016.5 5046.9 5052.6 5073.3 5018.6 5043.1 5045.6 5047.8 5100.5 4918.9 5032.4 5036.7 5047.6 5051.9 4183.0 4216.4 4230.6 4230.9 4273.5 3730.4 3739.8 3758.3 3782.8 3796.6 4429.3 4436.2 4436.8 4472.9 4482.7 4928.4 4973.4 5001.1 5071.8 5154.0 4340.4 4362.2 4373.2 4403.2 4412.8 4501.5 4515.4 4516.0 4519.4 4561.7 4697.4 4791.0 4792.4 4828.1 4834.3 5086.7 5108.6 5111.1 5137.3 5169.2 4831.5 4843.8 4844.7 4847.3 4891.9 4905.9 5008.5 5039.0 5078.9 5097.9 5124.0 5157.7 5159.3 5160.7 5214.6 4791.4 4973.2 4981.2 4992.3 4999.2 4788.7 4802.7 4812.8 4814.7 4843.2 4761.0 4763.2 4812.3 4812.9 4814.9 4837.1 4863.9 4873.3 4875.9 4886.6 4819.4 4840.7 4850.4 4860.4 4914.3 09:44:04 INFO - PROCESS | 17651 | 09:44:04 INFO - PROCESS | 17651 | [#1] ext.html Cycles:180 Average:47120.48 Median:18733.53 stddev:82889.73 (442.5%) stddev-sans-first:83048.60 09:44:04 INFO - PROCESS | 17651 | Values: 577.8 580.0 583.0 586.0 597.4 28197.0 41311.6 42389.4 42413.4 46094.5 41472.8 41782.0 41872.4 42017.8 42060.2 7566.1 7847.7 7964.2 7995.7 7998.5 7478.1 7719.9 7725.5 10178.2 10385.4 10394.7 10421.6 10430.6 10436.7 10442.6 10216.1 10272.4 10275.1 10278.6 10286.8 7528.5 7708.9 7709.7 9957.8 10349.8 39418.0 39693.0 39802.4 39842.0 39908.2 2751.3 2777.8 2803.1 3278.4 3313.5 29745.4 30021.8 30198.4 30243.5 30583.5 3348.5 3354.4 3386.5 3434.4 3445.4 251750.0 251818.0 252839.0 252982.0 253365.0 48864.5 55781.4 57256.0 57442.4 62214.0 60145.7 60219.4 60297.0 60482.4 60677.4 15209.9 15396.4 15404.1 15425.1 15434.2 9107.6 10719.0 10736.5 10740.9 10816.5 18129.9 18774.2 18782.7 19244.0 19410.2 6712.9 6865.9 6921.6 7002.4 7159.2 827.3 976.9 984.3 993.9 1028.2 28200.3 29393.9 29417.7 29500.4 29698.6 951.4 968.0 985.9 1019.2 1028.4 15077.8 15358.2 15588.4 15772.4 15858.8 384512.0 386397.0 387547.0 387733.0 387890.0 31444.0 31561.5 31578.7 31603.2 31664.1 1072.6 1140.7 1190.2 1206.8 1221.3 29121.4 29672.0 30036.2 30322.1 30464.2 42742.0 43105.8 43221.0 43263.8 43364.0 290742.0 291449.0 291821.0 293061.0 293073.0 22574.8 25441.9 25742.9 26075.3 26174.5 41356.0 42427.8 42514.1 43108.1 43555.6 36990.1 37158.8 37280.8 37542.8 37940.1 36087.5 37122.3 37547.2 37607.0 37643.0 35817.0 36559.8 37197.3 37342.3 37878.0 32580.0 34032.7 34586.0 34591.1 34855.5 25586.9 25939.9 26068.7 26157.0 26171.0 09:44:04 INFO - PROCESS | 17651 | 09:44:04 INFO - PROCESS | 17651 | [#2] jquery.html Cycles:180 Average:25191.94 Median:192129.15 stddev:62097.57 (32.3%) stddev-sans-first:62243.81 09:44:04 INFO - PROCESS | 17651 | Values: 374.7 376.5 383.3 386.1 395.7 16588.6 16788.4 17400.2 17597.5 17617.5 10412.5 10940.5 10959.8 10966.8 10968.5 4600.4 4631.5 4746.2 5600.5 5606.0 5591.5 5608.2 5619.6 5636.1 5659.6 5144.7 5423.5 5424.9 5510.5 5569.6 5523.3 5534.7 5541.5 5546.4 5553.7 4667.9 4957.0 4960.0 5010.2 5017.1 20456.7 20662.7 20882.9 21070.7 21650.2 1767.1 1887.5 1898.8 1908.4 1923.2 14437.3 14858.9 15161.2 15407.5 16161.8 1959.0 1992.6 2024.1 2043.4 2049.7 63962.7 67956.0 70573.3 79824.6 82925.0 15991.0 17433.7 17495.9 17889.8 18121.5 30423.5 30595.5 30861.2 30897.0 30950.4 8917.5 9484.3 9745.4 9763.0 10013.0 8030.8 8140.1 8202.7 8233.2 8359.8 8691.3 8772.7 8783.4 8815.4 8968.3 3178.8 3409.8 3418.6 3455.7 3650.1 788.6 843.8 898.2 929.9 955.1 17819.4 18293.1 18342.1 18425.4 18460.9 912.0 914.3 917.1 933.7 944.7 9976.2 10055.5 10241.8 10241.8 10280.8 370309.0 372055.0 373379.0 380008.0 383875.0 51426.0 73008.6 74593.6 74787.0 81811.2 911.0 927.8 940.9 958.7 959.4 16353.9 16527.7 16867.2 16962.3 17171.5 28192.2 38595.8 39672.0 40899.0 42404.2 56488.7 57059.1 58386.5 58986.7 59242.0 7500.0 7855.4 7867.2 7882.8 8020.2 8794.4 11859.2 11976.5 12209.3 12268.4 10396.0 10517.6 10557.6 10735.5 11011.1 10430.3 10582.7 10622.5 10773.1 10868.1 10536.8 10749.1 11099.1 11123.8 11139.1 7703.3 7748.5 7840.8 7863.3 8086.8 8481.7 10719.7 10875.9 10962.7 10977.7 09:44:04 INFO - PROCESS | 17651 | 09:44:04 INFO - PROCESS | 17651 | [#3] mootools.html Cycles:180 Average:5117.79 Median:5008.56 stddev:2959.21 (59.1%) stddev-sans-first:2953.28 09:44:04 INFO - PROCESS | 17651 | Values: 1256.3 1357.7 1413.4 1465.7 1714.6 6845.9 7661.5 7882.8 7926.4 8166.4 7892.1 8027.8 8030.8 8036.5 8040.2 2201.6 2231.2 2234.2 2236.2 2236.7 2175.3 2202.0 2239.8 2242.8 2244.5 2215.2 2217.5 2224.7 2228.3 2256.8 2083.7 2087.3 2091.0 2091.2 2095.4 1954.8 1980.9 1983.0 1993.0 1995.9 7893.5 7998.8 8010.2 8074.2 8085.5 4559.2 4727.7 4735.8 4736.7 4738.4 2811.4 2895.3 2948.8 2955.0 2974.8 870.0 879.4 879.6 881.5 892.5 10801.1 10811.0 10913.8 10929.7 10930.3 3945.3 3983.1 4131.2 4158.8 4242.8 8297.0 8321.8 8336.5 8346.9 8349.1 4725.1 4725.6 4726.6 4732.2 4734.3 3627.0 4049.7 4206.6 4378.3 4378.5 3420.8 3461.2 3479.3 3490.1 3648.2 1031.5 1053.8 1060.7 1066.8 1077.6 679.7 754.2 754.3 799.4 818.3 4963.9 5053.2 5080.6 5157.0 5172.3 393.0 394.4 395.3 396.0 413.1 3376.2 3514.0 3523.4 3546.9 3585.0 9412.0 9880.9 9899.9 9935.5 9935.9 9877.9 9905.2 9908.8 9916.1 9919.3 7374.8 7524.2 7563.9 7583.0 7606.2 5093.1 5101.7 5126.9 5149.4 5182.6 8904.7 9017.0 9141.8 9154.1 9166.1 9246.8 9377.7 9378.9 9397.6 9411.2 5489.3 6020.7 6185.0 6376.6 6428.1 7677.5 7699.9 7761.1 7768.7 7775.0 6742.6 6785.5 6834.9 6866.8 6982.7 6845.5 6946.3 6999.6 7015.1 7084.0 5906.9 5951.5 5990.1 6002.1 6079.8 4351.9 4382.9 4413.4 4466.4 4475.8 4425.6 4446.1 4468.8 4533.8 4577.2 09:44:04 INFO - PROCESS | 17651 | 09:44:04 INFO - PROCESS | 17651 | [#4] prototype.html Cycles:180 Average:4188.94 Median:4852.70 stddev:1196.82 (24.7%) stddev-sans-first:1163.94 09:44:04 INFO - PROCESS | 17651 | Values: 294.7 297.1 300.7 304.4 309.0 4829.1 4883.4 4890.2 4891.9 4907.0 4783.5 4802.3 4850.9 4855.9 4862.4 3630.5 3692.9 3743.3 3802.5 3821.3 3770.4 3786.9 3811.5 3816.8 3833.6 3602.3 3773.4 3791.4 3801.4 3811.7 3663.1 3766.2 3771.9 3776.9 3793.6 3341.7 3352.0 3357.6 3374.2 3383.9 4704.8 4733.3 4735.1 4751.5 4757.3 4235.7 4273.8 4279.0 4307.8 4367.3 4961.9 4965.2 4991.6 5011.2 5013.2 3614.4 3618.3 3631.8 3646.0 3653.2 5125.9 5211.3 5226.6 5261.3 5321.4 3716.9 3745.1 3751.7 3759.7 3780.4 3815.7 3818.7 3819.8 3842.6 3844.0 4321.5 4321.6 4327.0 4328.0 4346.8 4926.7 4983.5 5020.9 5028.7 5040.8 1310.2 1311.3 1322.3 1322.5 1327.7 853.5 871.4 893.8 902.8 903.2 4360.5 4371.6 4456.4 4473.2 4481.8 5123.3 5124.5 5144.6 5163.0 5171.4 4273.0 4414.1 4428.2 4436.0 4514.8 2723.3 2741.1 2746.0 2750.5 2768.9 4868.4 4876.2 4894.4 4930.2 4938.2 5033.8 5256.6 5265.7 5281.4 5312.2 4854.5 4867.4 4870.2 4887.3 4901.4 5136.7 5161.8 5187.5 5190.7 5198.6 4898.8 5035.9 5045.5 5069.2 5071.8 4870.6 4884.3 4885.8 4894.2 4907.4 3701.0 3702.3 3727.8 3734.9 3741.3 4973.4 5172.5 5183.3 5187.9 5205.6 4934.2 4935.4 4951.9 4955.0 5003.4 4936.2 4938.9 4962.2 4968.3 4987.2 4650.3 4671.7 4882.5 4900.5 4910.0 4909.7 5037.5 5046.7 5050.8 5061.9 4923.2 4928.9 4947.8 4968.5 4983.3 09:44:04 INFO - PROCESS | 17651 | 09:44:04 INFO - PROCESS | 17651 | [#5] yui.html Cycles:180 Average:16012.14 Median:25446.65 stddev:22146.16 (87.0%) stddev-sans-first:22178.12 09:44:04 INFO - PROCESS | 17651 | Values: 617.9 626.3 644.9 660.2 699.9 10501.5 11296.6 11383.9 12204.4 12213.3 12717.2 14172.5 14199.6 14199.7 14276.5 624.2 746.4 775.1 778.5 781.9 780.3 780.9 782.9 787.0 788.5 820.3 823.1 825.7 826.2 826.8 813.1 814.3 814.5 815.4 815.4 599.1 600.0 600.8 601.1 601.1 12438.2 12505.2 12543.1 12622.4 12644.1 11726.7 11822.9 11878.3 12045.9 12140.4 7912.2 8016.7 8071.9 8135.4 8157.1 3221.3 3252.6 3252.9 3255.6 3308.2 42041.0 43395.3 43644.0 49245.3 65552.7 7245.3 8840.7 9273.0 9360.0 9373.4 16883.0 16938.2 16981.2 16988.2 17009.7 6254.8 6256.7 6383.7 6449.9 6570.0 3560.4 3591.5 3602.4 3663.7 3669.4 2799.4 2898.0 2900.2 2901.1 2909.7 494.9 507.3 508.5 509.4 554.2 583.3 597.7 604.7 608.5 619.1 7818.4 8028.3 8182.2 8589.5 8738.7 511.6 516.8 526.4 531.3 536.6 3853.7 3939.1 3968.9 4068.3 4144.2 58554.7 59180.4 59398.0 59453.0 60318.4 92875.5 95825.5 97571.0 97677.5 97910.0 40538.0 46242.0 74517.5 75752.2 77502.0 8935.5 9140.5 9169.2 9208.6 9438.4 42835.4 43858.1 45254.5 45264.1 46536.8 36208.5 50386.0 60668.7 60798.4 61319.7 11375.6 11834.4 11878.6 12180.8 12500.5 13034.4 13278.9 13533.9 13618.9 14057.7 11759.9 12192.0 12257.6 12270.3 12865.6 12311.8 12997.6 13059.9 13352.5 13468.6 11320.4 11558.7 11560.4 11634.6 12063.3 10413.8 10509.3 10634.4 10816.3 10903.5 9523.8 9613.4 9723.6 10413.9 10416.5 09:44:04 INFO - PROCESS | 17651 | -------- Summary: end -------- 09:44:04 INFO - PROCESS | 17651 | 09:44:04 INFO - TEST-INFO | 17651: exit 0 09:44:04 INFO - TEST-OK | dromaeo_css | took 1119860ms 09:44:04 INFO - TEST-START | kraken 09:44:04 INFO - operating with platform_type : linux_ 09:44:04 INFO - Initialising browser for kraken test... 09:44:04 INFO - TEST-INFO | started process 17838 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq9Qk9Q/profile http://localhost:43349/getInfo.html) 09:44:09 INFO - PROCESS | 17838 | __metrics Screen width/height:1600/1200 09:44:09 INFO - PROCESS | 17838 | colorDepth:24 09:44:09 INFO - PROCESS | 17838 | Browser inner width/height: 1024/697 09:44:09 INFO - PROCESS | 17838 | __metrics 09:44:10 INFO - PROCESS | 17838 | JavaScript error: resource://app/modules/CaptivePortalWatcher.jsm, line 60: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:44:11 INFO - TEST-INFO | 17838: exit 0 09:44:11 INFO - Browser initialized. 09:44:11 INFO - Running cycle 1/1 for kraken test... 09:44:11 INFO - TEST-INFO | started process 17919 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpq9Qk9Q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:44:23 INFO - PROCESS | 17919 | RSS: Main: 158646272 09:44:23 INFO - PROCESS | 17919 | 09:44:25 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43349/tests/kraken/driver.html?testName=audio-beat-detection) 09:44:26 INFO - PROCESS | 17919 | RSS: Main: 216313856 09:44:26 INFO - PROCESS | 17919 | 09:44:29 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43349/tests/kraken/driver.html?testName=audio-dft) 09:44:30 INFO - PROCESS | 17919 | RSS: Main: 204890112 09:44:30 INFO - PROCESS | 17919 | 09:44:33 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43349/tests/kraken/driver.html?testName=audio-fft) 09:44:34 INFO - PROCESS | 17919 | RSS: Main: 271175680 09:44:34 INFO - PROCESS | 17919 | 09:44:36 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43349/tests/kraken/driver.html?testName=audio-oscillator) 09:44:36 INFO - PROCESS | 17919 | RSS: Main: 181542912 09:44:36 INFO - PROCESS | 17919 | 09:44:39 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43349/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:44:39 INFO - PROCESS | 17919 | RSS: Main: 185180160 09:44:39 INFO - PROCESS | 17919 | 09:44:42 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43349/tests/kraken/driver.html?testName=imaging-darkroom) 09:44:43 INFO - PROCESS | 17919 | RSS: Main: 221892608 09:44:43 INFO - PROCESS | 17919 | 09:44:46 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43349/tests/kraken/driver.html?testName=imaging-desaturate) 09:44:47 INFO - PROCESS | 17919 | RSS: Main: 217546752 09:44:47 INFO - PROCESS | 17919 | 09:44:50 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43349/tests/kraken/driver.html?testName=json-parse-financial) 09:44:51 INFO - PROCESS | 17919 | RSS: Main: 220274688 09:44:51 INFO - PROCESS | 17919 | 09:44:52 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43349/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:53 INFO - PROCESS | 17919 | RSS: Main: 207544320 09:44:53 INFO - PROCESS | 17919 | 09:44:55 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43349/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:55 INFO - PROCESS | 17919 | RSS: Main: 210538496 09:44:55 INFO - PROCESS | 17919 | 09:44:58 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43349/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:58 INFO - PROCESS | 17919 | RSS: Main: 207200256 09:44:58 INFO - PROCESS | 17919 | 09:45:01 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:45:02 INFO - PROCESS | 17919 | RSS: Main: 221962240 09:45:02 INFO - PROCESS | 17919 | 09:45:05 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:45:05 INFO - PROCESS | 17919 | RSS: Main: 221962240 09:45:05 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | Cycle 1(1): loaded http://localhost:43349/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43349/tests/kraken/driver.html?testName=ai-astar) 09:45:07 INFO - PROCESS | 17919 | RSS: Main: 265285632 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | __start_tp_report 09:45:07 INFO - PROCESS | 17919 | _x_x_mozilla_page_load 09:45:07 INFO - PROCESS | 17919 | _x_x_mozilla_page_load_details 09:45:07 INFO - PROCESS | 17919 | |i|pagename|runs| 09:45:07 INFO - PROCESS | 17919 | |0;ai-astar;103;114;114;113;113;112;112;111;111;111 09:45:07 INFO - PROCESS | 17919 | |1;audio-beat-detection;152;125;123;196;123;125;150;122;167;125 09:45:07 INFO - PROCESS | 17919 | |2;audio-dft;161;161;161;161;163;161;161;160;161;162 09:45:07 INFO - PROCESS | 17919 | |3;audio-fft;75;75;77;130;78;77;74;75;108;76 09:45:07 INFO - PROCESS | 17919 | |4;audio-oscillator;84;86;114;85;86;85;116;87;86;122 09:45:07 INFO - PROCESS | 17919 | |5;imaging-gaussian-blur;117;117;116;116;118;118;117;117;117;117 09:45:07 INFO - PROCESS | 17919 | |6;imaging-darkroom;147;147;146;146;146;147;147;147;146;145 09:45:07 INFO - PROCESS | 17919 | |7;imaging-desaturate;95;95;95;96;95;95;95;94;94;95 09:45:07 INFO - PROCESS | 17919 | |8;json-parse-financial;64;62;63;64;64;64;62;65;63;65 09:45:07 INFO - PROCESS | 17919 | |9;json-stringify-tinderbox;64;65;64;64;64;64;66;65;65;65 09:45:07 INFO - PROCESS | 17919 | |10;stanford-crypto-aes;84;78;78;78;78;78;76;81;77;79 09:45:07 INFO - PROCESS | 17919 | |11;stanford-crypto-ccm;137;135;139;139;129;141;132;136;166;140 09:45:07 INFO - PROCESS | 17919 | |12;stanford-crypto-pbkdf2;168;168;169;168;166;175;170;169;167;164 09:45:07 INFO - PROCESS | 17919 | |13;stanford-crypto-sha256-iterative;67;68;67;68;66;66;66;66;66;67 09:45:07 INFO - PROCESS | 17919 | __end_tp_report 09:45:07 INFO - PROCESS | 17919 | __start_cc_report 09:45:07 INFO - PROCESS | 17919 | _x_x_mozilla_cycle_collect,1928 09:45:07 INFO - PROCESS | 17919 | __end_cc_report 09:45:07 INFO - PROCESS | 17919 | __startTimestamp1467823507685__endTimestamp 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | ------- Summary: start ------- 09:45:07 INFO - PROCESS | 17919 | Number of tests: 14 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#0] ai-astar Cycles:10 Average:111.40 Median:112.50 stddev:3.17 (2.8%) stddev-sans-first:1.22 09:45:07 INFO - PROCESS | 17919 | Values: 103.0 114.0 114.0 113.0 113.0 112.0 112.0 111.0 111.0 111.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#1] audio-beat-detection Cycles:10 Average:140.80 Median:137.50 stddev:25.12 (18.3%) stddev-sans-first:26.32 09:45:07 INFO - PROCESS | 17919 | Values: 152.0 125.0 123.0 196.0 123.0 125.0 150.0 122.0 167.0 125.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:0.79 (0.5%) stddev-sans-first:0.83 09:45:07 INFO - PROCESS | 17919 | Values: 161.0 161.0 161.0 161.0 163.0 161.0 161.0 160.0 161.0 162.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#3] audio-fft Cycles:10 Average:84.50 Median:75.50 stddev:18.95 (25.1%) stddev-sans-first:19.78 09:45:07 INFO - PROCESS | 17919 | Values: 75.0 75.0 77.0 130.0 78.0 77.0 74.0 75.0 108.0 76.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:85.50 stddev:15.49 (18.1%) stddev-sans-first:15.90 09:45:07 INFO - PROCESS | 17919 | Values: 84.0 86.0 114.0 85.0 86.0 85.0 116.0 87.0 86.0 122.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#5] imaging-gaussian-blur Cycles:10 Average:117.00 Median:117.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 09:45:07 INFO - PROCESS | 17919 | Values: 117.0 117.0 116.0 116.0 118.0 118.0 117.0 117.0 117.0 117.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 09:45:07 INFO - PROCESS | 17919 | Values: 147.0 147.0 146.0 146.0 146.0 147.0 147.0 147.0 146.0 145.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.57 (0.6%) stddev-sans-first:0.60 09:45:07 INFO - PROCESS | 17919 | Values: 95.0 95.0 95.0 96.0 95.0 95.0 95.0 94.0 94.0 95.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#8] json-parse-financial Cycles:10 Average:63.60 Median:64.00 stddev:1.07 (1.7%) stddev-sans-first:1.13 09:45:07 INFO - PROCESS | 17919 | Values: 64.0 62.0 63.0 64.0 64.0 64.0 62.0 65.0 63.0 65.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#9] json-stringify-tinderbox Cycles:10 Average:64.60 Median:65.00 stddev:0.70 (1.1%) stddev-sans-first:0.71 09:45:07 INFO - PROCESS | 17919 | Values: 64.0 65.0 64.0 64.0 64.0 64.0 66.0 65.0 65.0 65.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#10] stanford-crypto-aes Cycles:10 Average:78.70 Median:78.00 stddev:2.26 (2.9%) stddev-sans-first:1.36 09:45:07 INFO - PROCESS | 17919 | Values: 84.0 78.0 78.0 78.0 78.0 78.0 76.0 81.0 77.0 79.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#11] stanford-crypto-ccm Cycles:10 Average:139.40 Median:139.00 stddev:10.06 (7.2%) stddev-sans-first:10.63 09:45:07 INFO - PROCESS | 17919 | Values: 137.0 135.0 139.0 139.0 129.0 141.0 132.0 136.0 166.0 140.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.40 Median:168.50 stddev:2.88 (1.7%) stddev-sans-first:3.05 09:45:07 INFO - PROCESS | 17919 | Values: 168.0 168.0 169.0 168.0 166.0 175.0 170.0 169.0 167.0 164.0 09:45:07 INFO - PROCESS | 17919 | 09:45:07 INFO - PROCESS | 17919 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 09:45:07 INFO - PROCESS | 17919 | Values: 67.0 68.0 67.0 68.0 66.0 66.0 66.0 66.0 66.0 67.0 09:45:07 INFO - PROCESS | 17919 | -------- Summary: end -------- 09:45:07 INFO - PROCESS | 17919 | 09:45:08 INFO - TEST-INFO | 17919: exit 0 09:45:08 INFO - TEST-OK | kraken | took 63981ms 09:45:08 INFO - SUITE-END | took 1183s 09:45:08 INFO - Completed test suite (00:19:43) 09:45:08 INFO - javascript benchmark 09:45:08 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2594.54595445797, 2602.687677478703, 2647.52344577976, 2659.8803053862575, 2660.6275121482995, 4597.1265459562655, 4600.516945720701, 4635.745034023127, 4720.645951553634, 4739.454962679293, 4728.692634978733, 4745.620350371971, 4752.2396416573265, 4784.928226076603, 4789.856304310868, 4318.222719910407, 4364.629006534448, 4392.934105988413, 4430.113977204556, 4439.045605194882, 4374.2126417245045, 4404.559544045602, 4431.069475410168, 4431.113777244548, 4463.575960283768, 4273.465816772903, 4322.805473753689, 4326.762028088454, 4368.584984426506, 4421.226285400075, 4311.956880431187, 4315.093830295642, 4319.460067491564, 4431.578999994996, 4479.529649386833, 4342.413774140482, 4349.913001739979, 4356.390105385249, 4391.736495810262, 4407.559244075599, 4595.0, 4601.700889442175, 4619.076184763061, 4764.95235047652, 4802.039592081597, 4970.676906001098, 5023.8492845214705, 5031.295618613397, 5032.169692000815, 5035.571976382012, 4991.326170966946, 5036.697798132123, 5039.143345631252, 5050.166722490784, 5052.8484145475695, 4654.371659825948, 4673.228917228687, 4712.5994290485005, 4736.100140973204, 4788.329633851229, 5227.163653815447, 5240.9213861792105, 5242.213667949838, 5253.789848406097, 5254.527092561688, 5012.674176178537, 5020.071286811952, 5022.648414610942, 5023.447420783711, 5025.648204625714, 5010.148274793294, 5016.498350165028, 5046.873828154326, 5052.621053421009, 5073.34046573943, 5018.648694591417, 5043.067032598981, 5045.621578381636, 5047.823326183639, 5100.515451032146, 4918.92621610669, 5032.396112466454, 5036.697798132051, 5047.570956468668, 5051.873703157377, 4182.979085104555, 4216.430781844473, 4230.555791641895, 4230.936535951963, 4273.487181538236, 3730.440433934877, 3739.7943113128495, 3758.285925674113, 3782.791946442972, 3796.620337966181, 4429.291313389842, 4436.245838207513, 4436.844710435119, 4472.932906006413, 4482.686211965196, 4928.408590969035, 4973.35346404965, 5001.0998020355955, 5071.797128114834, 5153.974230128825, 4340.392345071693, 4362.236608593484, 4373.234683930299, 4403.207422663952, 4412.7793610319995, 4501.459824821042, 4515.412996310524, 4515.9548404515535, 4519.367288579601, 4561.7262964222255, 4697.412823397075, 4791.0, 4792.424909011011, 4828.082664293773, 4834.323194752667, 5086.694798312114, 5108.59131269505, 5111.05445492585, 5137.280780690631, 5169.172932330809, 4831.492693267297, 4843.75781210931, 4844.709317440965, 4847.297141914332, 4891.853244402673, 4905.926411103907, 5008.474110218521, 5038.974805125951, 5078.9238161426865, 5097.898042039213, 5123.974380128076, 5157.690538567698, 5159.251908473326, 5160.716160611202, 5214.634975551675, 4791.377120974391, 4973.229149481836, 4981.178105612678, 4992.2761199626575, 4999.150144475375, 4788.688735232199, 4802.73584952831, 4812.759362031955, 4814.735189564468, 4843.200871856105, 4761.0, 4763.237881938873, 4812.302216178705, 4812.855614331575, 4814.903701925872, 4837.080954618611, 4863.878403039952, 4873.269009648439, 4875.853724388274, 4886.633502487257, 4819.421669399694, 4840.709557426566, 4850.369451971221, 4860.416749990024, 4914.287428322945], "value": 4646.159119440707, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [577.8035467940902, 579.9971000144996, 582.9594174398698, 585.9765609375626, 597.3906615252444, 28197.0, 41311.58688413115, 42389.36415953763, 42413.36379954303, 46094.53905460944, 41472.79263603678, 41782.0, 41872.37191442131, 42017.7899110504, 42060.15879682404, 7566.092068951733, 7847.725329613479, 7964.2433968772875, 7995.6801727930815, 7998.520088794691, 7478.102627684685, 7719.922800772005, 7725.497842640239, 10178.23663225261, 10385.376877387382, 10394.688159355193, 10421.645186125794, 10430.63492777753, 10436.686899393031, 10442.58229670816, 10216.13162881156, 10272.383656980604, 10275.126614237799, 10278.588856445771, 10286.794264114751, 7528.47300688952, 7708.884366734504, 7709.6916123354995, 9957.80084398308, 10349.844752328721, 39418.0, 39693.0, 39802.40296395557, 39842.0, 39908.20183596312, 2751.2984189031667, 2777.7777777777933, 2803.088996076263, 3278.378714410046, 3313.4698448248405, 29745.405091898258, 30021.849890750407, 30198.396032079236, 30243.546346804815, 30583.541246881316, 3348.5479460272795, 3354.4465163248033, 3386.4920261960656, 3434.3989801784837, 3445.3798316303055, 251750.0, 251818.0, 252839.0, 252982.0, 253365.0, 48864.51135488671, 55781.44218557844, 57256.0, 57442.42557574454, 62214.0, 60145.69927150336, 60219.39780602138, 60297.0, 60482.39517604856, 60677.39322606806, 15209.923950380398, 15396.384144634088, 15404.075755454709, 15425.074495530303, 15434.228288585751, 9107.635694572275, 10719.0, 10736.463176841127, 10740.946295268473, 10816.513256903301, 18129.909350453163, 18774.1551630177, 18782.718259226123, 19244.0, 19410.22359105648, 6712.865742685119, 6865.9313406866295, 6921.619310937846, 7002.444107900579, 7159.212486626467, 827.3257295304428, 976.858355538443, 984.2765567308023, 993.9006099390003, 1028.1928685981468, 28200.29499262535, 29393.85303073471, 29417.705822941498, 29500.409991800043, 29698.554521682192, 951.3911096897991, 967.9854802177973, 985.9457729824785, 1019.1948360795037, 1028.4292217819032, 15077.773833392288, 15358.155301458528, 15588.376464941275, 15772.369105235892, 15858.762118568231, 384512.0, 386397.0, 387547.0, 387733.0, 387890.0, 31444.0, 31561.526577101362, 31578.684213158034, 31603.20991975219, 31664.050078497683, 1072.619220176826, 1140.6578026592156, 1190.1918637051135, 1206.7526157137765, 1221.3099598726692, 29121.41757164887, 29672.0, 30036.24909377283, 30322.116696010467, 30464.238394040327, 42742.0, 43105.784471077444, 43221.0, 43263.78368108139, 43364.0, 290742.0, 291449.0, 291821.0, 293061.0, 293073.0, 22574.774252257925, 25441.872790635927, 25742.87128564345, 26075.348116297246, 26174.476510470064, 41356.0, 42427.7878610605, 42514.14971700487, 43108.13783724245, 43555.564444356416, 36990.075248119014, 37158.8142059288, 37280.813595931846, 37542.812285938395, 37940.05149871275, 36087.45868812023, 37122.25755484929, 37547.2490550182, 37607.0, 37643.0, 35817.0, 36559.81720091382, 37197.25605487929, 37342.2531549362, 37878.0, 32580.0, 34032.65967340295, 34586.0, 34591.13522161966, 34855.47716784301, 25586.872065639553, 25939.87030064913, 26068.73931260739, 26157.0, 26171.0], "value": 18001.237330078337, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [374.7470457441227, 376.50677612327854, 383.29091181314556, 386.1215734204684, 395.6913607386238, 16588.585285367855, 16788.412405565792, 17400.21699023544, 17597.472075837744, 17617.471475855727, 10412.531436085375, 10940.45297735112, 10959.780804383907, 10966.835497467524, 10968.506417211225, 4600.424946881648, 4631.513691062423, 4746.169420351442, 5600.52395546379, 5605.971970140144, 5591.524720398751, 5608.158776183564, 5619.6066275360745, 5636.0982242841155, 5659.5755318351285, 5144.742762861861, 5423.538999185074, 5424.918626220609, 5510.531604813596, 5569.610127291091, 5523.337199536061, 5534.695591742473, 5541.501264886159, 5546.362168350651, 5553.722313884289, 4667.8599642010795, 4956.950430495685, 4960.0, 5010.173321401964, 5017.147084995559, 20456.69314960277, 20662.690059649118, 20882.89558552213, 21070.683939740917, 21650.24224152147, 1767.098779622389, 1887.5469887227105, 1898.8006259342847, 1908.427471758467, 1923.1538123225737, 14437.278136093259, 14858.851411485855, 15161.241937903062, 15407.460738874197, 16161.757573636405, 1958.99020504898, 1992.5715971066145, 2024.058812652109, 2043.3665563675308, 2049.723287356203, 63962.68018659923, 67956.0, 70573.29426705718, 79824.60087699525, 82925.0, 15991.041657293204, 17433.738493922603, 17495.912520437316, 17889.821101789075, 18121.456356309332, 30423.543646845315, 30595.541066884016, 30861.228469288, 30897.0, 30950.380992380477, 8917.464952102895, 9484.288678349152, 9745.366551174293, 9763.0, 10013.048760367754, 8030.839383212303, 8140.145284745016, 8202.671893124209, 8233.17668233172, 8359.791005224917, 8691.304695624334, 8772.692955746517, 8783.385163038654, 8815.426997245158, 8968.282537396992, 3178.8092714436743, 3409.7613167078066, 3418.6239513653477, 3455.6889879910927, 3650.1239702471216, 788.5584072919183, 843.7682330236613, 898.2437990838525, 929.9488528131018, 955.1212884146602, 17819.376321828673, 18293.08534573266, 18342.082895855154, 18425.355112570996, 18460.907695461436, 911.9635214591475, 914.2503147419053, 917.124146440148, 933.7338858425317, 944.7354740672623, 9976.152027077635, 10055.547500362502, 10241.795164096677, 10241.795164096677, 10280.845787313196, 370309.0, 372055.0, 373379.0, 380008.0, 383875.0, 51426.0, 73008.63495682487, 74593.6270318645, 74787.0, 81811.18188818036, 910.981780364389, 927.8283517549276, 940.9294302927308, 958.6884262614678, 959.4147569982305, 16353.936994095346, 16527.669446611242, 16867.240974156437, 16962.321507139575, 17171.484855453855, 28192.15423537297, 38595.80702096471, 39672.0, 40899.0, 42404.1519169621, 56488.71755641195, 57059.144112839174, 58386.54033649023, 58986.705066474395, 59242.0, 7499.962500187464, 7855.410844186823, 7867.213278672087, 7882.763517094496, 8020.197980202167, 8794.384393092421, 11859.16985810985, 11976.46105925218, 12209.267443953391, 12268.386580670753, 10396.0, 10517.631882884063, 10557.63048293306, 10735.46322683847, 11011.064059555027, 10430.26988110825, 10582.682519524427, 10622.468876556295, 10773.084287835622, 10868.076213521623, 10536.84194737095, 10749.140068794633, 11099.112071034137, 11123.83314250303, 11139.10887129044, 7703.345215656732, 7748.535087894745, 7840.764777056697, 7863.252990965849, 8086.838263234585, 8481.703140390056, 10719.678409647722, 10875.912408759377, 10962.671119866416, 10977.725556861142], "value": 9160.57741381517, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1256.3341429042612, 1357.6605848537863, 1413.371049882802, 1465.6848777512832, 1714.6484970581039, 6845.931540684592, 7661.502002369849, 7882.842343153141, 7926.405519586026, 8166.428350015486, 7892.131865494791, 8027.759167224993, 8030.839383212332, 8036.477628954114, 8040.236177563137, 2201.5927053495075, 2231.230225572183, 2234.1733558583264, 2236.1614394602025, 2236.720409948748, 2175.3147758456116, 2201.9779802202015, 2239.8320125990535, 2242.820574354048, 2244.517428752818, 2215.2468160825315, 2217.5343177932655, 2224.6774217738416, 2228.2535350657467, 2256.8307376946714, 2083.7395325584303, 2087.269455690504, 2090.9581808363823, 2091.2262462888675, 2095.4132842803965, 1954.7556555430572, 1980.9009549522611, 1982.9504262393555, 1992.980070199294, 1995.8503112266637, 7893.526388416713, 7998.760037198836, 8010.239027292398, 8074.152214017502, 8085.474444161169, 4559.17934771741, 4727.66906316558, 4735.763211839429, 4736.692115012514, 4738.3603213566075, 2811.381496070861, 2895.2761809547615, 2948.78840869348, 2955.0, 2974.8363839988792, 869.9869501957476, 879.4415546128255, 879.5997820991433, 881.532787622561, 892.4912799704172, 10801.135909127252, 10811.0, 10913.781724365468, 10929.672109836718, 10930.289531180448, 3945.3095708251517, 3983.083890705154, 4131.173765246963, 4158.750474971512, 4242.787860607019, 8297.04583972851, 8321.750347489586, 8336.541490218096, 8346.916530834615, 8349.123342049119, 4725.149473094807, 4725.64557658177, 4726.598239149642, 4732.2428411454, 4734.313524538991, 3626.9818650907105, 4049.655779258796, 4206.621404073648, 4378.321360189176, 4378.5183629800695, 3420.8289585520624, 3461.1693193633346, 3479.251960828434, 3490.110021944388, 3648.179159689049, 1031.504877658728, 1053.8155822730992, 1060.734816295926, 1066.8239740442896, 1077.6389909380446, 679.6839469646638, 754.1704125461948, 754.2985023927799, 799.3605115907251, 818.2594751749676, 4963.875903102451, 5053.2420136979745, 5080.5681517070725, 5157.0, 5172.327597412313, 392.95481019683103, 394.41823310617184, 395.28848073467645, 395.96455269470704, 413.14272883765705, 3376.206591451007, 3513.982430087833, 3523.3834079036064, 3546.91132721684, 3585.049961760136, 9411.952940235255, 9880.863700674514, 9899.851502227473, 9935.503224838729, 9935.850962235572, 9877.901220987842, 9905.20758339331, 9908.752281192883, 9916.057974492413, 9919.256055795844, 7374.815629609303, 7524.247575242542, 7563.924360756322, 7582.962085189649, 7606.20134885829, 5093.083245015932, 5101.668391554537, 5126.871828204325, 5149.382074151126, 5182.585393168462, 8904.688335908211, 9016.954915225382, 9141.77145571366, 9154.084591540792, 9166.129217724305, 9246.815063698554, 9377.718668439958, 9378.859317110113, 9397.577109030246, 9411.247100232102, 5489.34127904654, 6020.668863212565, 6185.041318595625, 6376.553641245068, 6428.132202152837, 7677.500962437423, 7699.8845017323665, 7761.107472640493, 7768.689252430066, 7774.961125194338, 6742.595444273359, 6785.491088168308, 6834.897476537756, 6866.759663411756, 6982.720691172296, 6845.486588505982, 6946.305369463215, 6999.580025198505, 7015.052967849275, 7083.964580177066, 5906.852328691645, 5951.494122999594, 5990.1314309424015, 6002.129691194839, 6079.756809727562, 4351.891202719958, 4382.912341753084, 4413.360062790942, 4466.419365482597, 4475.776211189493, 4425.601695847389, 4446.0885518467985, 4468.754218518013, 4533.818647254205, 4577.153226653079], "value": 4003.662412629677, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [294.70676676706665, 297.05684451865324, 300.7218323051177, 304.44135012252514, 308.99730374933335, 4829.082474329879, 4883.413990321166, 4890.193118135508, 4891.877703057426, 4906.975465122669, 4783.545563171502, 4802.303665968432, 4850.9029819403595, 4855.902881942359, 4862.416510018803, 3630.4917311576464, 3692.9446058309145, 3743.28877513273, 3802.4676545283683, 3821.29306078375, 3770.377887648535, 3786.9053273668105, 3811.504504414422, 3816.847326106966, 3833.5974722654137, 3602.2795440911923, 3773.415120656303, 3791.4312853071983, 3801.3727734923705, 3811.7141214408894, 3663.139162296858, 3766.1902690921584, 3771.8868433947027, 3776.867809626677, 3793.596369343333, 3341.7159541439005, 3351.983240083808, 3357.6306606273292, 3374.2407958209205, 3383.8646454141804, 4704.823794051487, 4733.337332773414, 4735.124002059595, 4751.548602882721, 4757.286407038937, 4235.745855248664, 4273.807678654468, 4279.0, 4307.849225277131, 4367.301231802928, 4961.8663974490955, 4965.230389289666, 4991.550760431543, 5011.198208286693, 5013.172826483626, 3614.36748569002, 3618.3486972344967, 3631.782093074424, 3646.0, 3653.1962968146963, 5125.897482050375, 5211.270422140903, 5226.608004399685, 5261.3167284684705, 5321.361436627591, 3716.925661486755, 3745.138618117848, 3751.6811071059265, 3759.6616304532176, 3780.4140358244517, 3815.6565909068318, 3818.694504439638, 3819.7899115548357, 3842.634949679832, 3843.98190949748, 4321.481422229353, 4321.644703636525, 4327.0480494291205, 4327.978360108179, 4346.847860324873, 4926.655134140576, 4983.526564976321, 5020.870304181603, 5028.723420211923, 5040.8487745366965, 1310.2007775257086, 1311.3377744239099, 1322.3322222277689, 1322.4577923051502, 1327.681356474439, 853.4580541356283, 871.4335681806876, 893.8301722672801, 902.7923577577194, 903.1600611431301, 4360.49854266757, 4371.584699453547, 4456.398386217884, 4473.239549276631, 4481.775911204427, 5123.3339665843205, 5124.5131712487255, 5144.61415393847, 5163.044836705147, 5171.379434467813, 4272.957270427318, 4414.09511050234, 4428.158649856581, 4436.0, 4514.781009127517, 2723.319170207448, 2741.136541989267, 2745.958810617842, 2750.5049091163382, 2768.8615569221456, 4868.391451068616, 4876.244182151772, 4894.412670479494, 4930.161872481687, 4938.185199442052, 5033.823816166417, 5256.6057545684225, 5265.736713164327, 5281.445448227881, 5312.1766126250495, 4854.490278520704, 4867.367242258484, 4870.172070747982, 4887.315775791392, 4901.362822833009, 5136.691798492103, 5161.793528258828, 5187.507186817246, 5190.688558686491, 5198.636095473281, 4898.779554919965, 5035.924461133012, 5045.5459008689395, 5069.239614057921, 5071.771770270273, 4870.634702397405, 4884.267359896044, 4885.75413269614, 4894.238074293323, 4907.386576677915, 3700.982964284525, 3702.2595480904465, 3727.813609319469, 3734.8879533614036, 3741.270452261783, 4973.403191617029, 5172.482751724798, 5183.300254465599, 5187.896242075213, 5205.6356055075785, 4934.18585933317, 4935.358403407534, 4951.851444456672, 4954.984228233276, 5003.424606170337, 4936.2102063669645, 4938.901221975469, 4962.181240095344, 4968.254761785761, 4987.202047672355, 4650.279206722963, 4671.696339737906, 4882.462929077869, 4900.460949295503, 4909.95090049095, 4909.656324057424, 5037.496250374933, 5046.722430266371, 5050.823221187241, 5061.898762024665, 4923.236898280772, 4928.852134435972, 4947.752612369439, 4968.503149685002, 4983.25251212321], "value": 3811.0425405281453, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [617.9165812615297, 626.2766504687087, 644.9484041276695, 660.2077506991611, 699.9335063168998, 10501.527431265593, 11296.604618838343, 11383.886161138396, 12204.389780510972, 12213.267203967756, 12717.23696578206, 14172.50396236132, 14199.645008874782, 14199.71600567988, 14276.500322488715, 624.1760875644152, 746.3506749128239, 775.1241097559749, 778.4667502760627, 781.8788087846365, 780.2665494435241, 780.9219078092202, 782.9138794732575, 787.0122995640463, 788.4756636836497, 820.3478234803316, 823.1480417767611, 825.7275099217273, 826.1862065865118, 826.8263664630434, 813.1299509524811, 814.2549567146054, 814.5194335342147, 815.3517953227199, 815.3762371785589, 599.0534954771495, 600.0369407101583, 600.7957294519884, 601.0923505506672, 601.1073555769678, 12438.19151755133, 12505.187162834387, 12543.121981461301, 12622.431990560446, 12644.051696122828, 11726.706832329175, 11822.890959581582, 11878.346690931996, 12045.879541204564, 12140.392980350947, 7912.169222231698, 8016.719414820512, 8071.919280807176, 8135.430519863612, 8157.14349993254, 3221.32352206037, 3252.567882388754, 3252.9186770330693, 3255.5930508686415, 3308.2225676965895, 42041.0, 43395.349069763666, 43644.0, 49245.261321080216, 65552.67223663851, 7245.347918687344, 8840.690575829814, 9273.020679762612, 9359.970403255773, 9373.437593744397, 16883.0, 16938.153092345332, 16981.235844387033, 16988.235529401205, 17009.659806803793, 6254.843628909222, 6256.710931764444, 6383.744650213939, 6449.871002579922, 6569.967150164314, 3560.4481305397703, 3591.4792355108884, 3602.351576716164, 3663.6885864701267, 3669.412893936957, 2799.3981294021883, 2898.0, 2900.202444327827, 2901.10065879578, 2909.7090290971155, 494.868859752166, 507.3075252280684, 508.4737296897693, 509.40399732313284, 554.1549137565245, 583.2942140010634, 597.6623207887529, 604.7308947518312, 608.5162295974711, 619.102301662591, 7818.4136189785995, 8028.277455029075, 8182.18178182189, 8589.484630922165, 8738.69414570487, 511.5575027601098, 516.7571241516481, 526.4491008150053, 531.2801154435762, 536.629725489411, 3853.672437842759, 3939.074317535377, 3968.940465893014, 4068.2591137469103, 4144.191882582928, 58554.70722646359, 59180.40819591835, 59398.0, 59453.0, 60318.39681603128, 92875.53562232146, 95825.5208723952, 97571.0, 97677.5116124429, 97910.0, 40538.0, 46242.0, 74517.50964980779, 75752.24247757673, 77502.0, 8935.508547029976, 9140.497272649802, 9169.220616247694, 9208.585613647268, 9438.433693978383, 42835.357469637354, 43858.12283754243, 45254.54745452503, 45264.094718104796, 46536.83657908444, 36208.45687314745, 50386.0, 60668.69665651643, 60798.39201607927, 61319.69340153449, 11375.601853935073, 11834.408279586158, 11878.584249551224, 12180.817287740869, 12500.499980000699, 13034.4134513949, 13278.867211327763, 13533.93233033868, 13618.93190534041, 14057.718845623234, 11759.882401175879, 12192.0, 12257.570985015482, 12270.325132117463, 12865.614031579067, 12311.815322770344, 12997.610071697864, 13059.934700326437, 13352.532661356807, 13468.595942121752, 11320.37737924422, 11558.653240402802, 11560.364179969845, 11634.592789252336, 12063.336516491327, 10413.843792343272, 10509.31689440184, 10634.361938283728, 10816.296940698829, 10903.509342079467, 9523.761905952406, 9613.375130616487, 9723.56243969009, 10413.895861041292, 10416.531256093342], "value": 6312.327198727175, "unit": "score"}], "name": "dromaeo_css", "value": 6476.553941893446, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 114.0, 114.0, 113.0, 113.0, 112.0, 112.0, 111.0, 111.0, 111.0], "value": 111.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [152.0, 125.0, 123.0, 196.0, 123.0, 125.0, 150.0, 122.0, 167.0, 125.0], "value": 140.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [161.0, 161.0, 161.0, 161.0, 163.0, 161.0, 161.0, 160.0, 161.0, 162.0], "value": 161.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [75.0, 75.0, 77.0, 130.0, 78.0, 77.0, 74.0, 75.0, 108.0, 76.0], "value": 84.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 86.0, 114.0, 85.0, 86.0, 85.0, 116.0, 87.0, 86.0, 122.0], "value": 95.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 116.0, 116.0, 118.0, 118.0, 117.0, 117.0, 117.0, 117.0], "value": 117.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0, 147.0, 146.0, 145.0], "value": 146.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 94.0, 94.0, 95.0], "value": 94.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 62.0, 63.0, 64.0, 64.0, 64.0, 62.0, 65.0, 63.0, 65.0], "value": 63.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 65.0, 64.0, 64.0, 64.0, 64.0, 66.0, 65.0, 65.0, 65.0], "value": 64.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 78.0, 78.0, 78.0, 78.0, 78.0, 76.0, 81.0, 77.0, 79.0], "value": 78.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 135.0, 139.0, 139.0, 129.0, 141.0, 132.0, 136.0, 166.0, 140.0], "value": 139.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 168.0, 169.0, 168.0, 166.0, 175.0, 170.0, 169.0, 167.0, 164.0], "value": 168.4, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 67.0, 68.0, 66.0, 66.0, 66.0, 66.0, 66.0, 67.0], "value": 66.7, "unit": "score"}], "name": "kraken", "value": 1532.7000000000003, "alertThreshold": 2.0}]} 09:45:08 INFO - Return code: 0 09:45:08 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:45:08 INFO - # TBPL SUCCESS # 09:45:08 INFO - Running post-action listener: _resource_record_post_action 09:45:08 INFO - ##### 09:45:08 INFO - ##### Finished run-tests step (success) 09:45:08 INFO - ##### 09:45:08 INFO - Running post-run listener: _resource_record_post_run 09:45:09 INFO - Total resource usage - Wall time: 1200s; CPU: 13.0%; Read bytes: 4096; Write bytes: 534315008; Read time: 12; Write time: 398600 09:45:09 INFO - TinderboxPrint: CPU usage
13.0% 09:45:09 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 09:45:09 INFO - TinderboxPrint: I/O write bytes / time
534,315,008 / 398,600 09:45:09 INFO - TinderboxPrint: CPU idle
8,335.3 (87.0%) 09:45:09 INFO - TinderboxPrint: CPU user
1,200.7 (12.5%) 09:45:09 INFO - TinderboxPrint: Swap in / out
0 / 0 09:45:09 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246439936; Read time: 0; Write time: 233820 09:45:09 INFO - run-tests - Wall time: 1184s; CPU: 13.0%; Read bytes: 0; Write bytes: 287875072; Read time: 0; Write time: 164780 09:45:09 INFO - Running post-run listener: _upload_blobber_files 09:45:09 INFO - Blob upload gear active. 09:45:09 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:45:09 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:45:09 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:45:09 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:45:10 INFO - (blobuploader) - INFO - Open directory for files ... 09:45:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:45:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:10 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:45:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:10 INFO - (blobuploader) - INFO - Done attempting. 09:45:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:45:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:45:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:11 INFO - (blobuploader) - INFO - Done attempting. 09:45:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:45:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:45:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:45:15 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:45:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:45:15 INFO - (blobuploader) - INFO - Done attempting. 09:45:15 INFO - (blobuploader) - INFO - Iteration through files over. 09:45:15 INFO - Return code: 0 09:45:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:45:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:45:15 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9ec55e6bf1acc2a34a5520746cf5286672759fe46d5189778b5250b861d2954be187c2a6c16c1bea01a6ec9630902564cd7256e0ec45f5b65ae95b77ca518f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/869d7496e0cb08d4fcc5657c4a3d3cc6282cbc83d11af56dc6ec39552ba74a75a81c31adc67fa0c9aed382144c04bdfb9142f221c2af481faaafe98fb9fbf9f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab23c8db887b8c5559f6e95af1a96db379d10fa9bee6cab751cdda92f81dedd54c5dc40bea7a3e41aa845310714955db19a7ba86a4cce7cf0c0ba5eb63d9eeaf"} 09:45:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:45:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:45:15 INFO - Contents: 09:45:15 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9ec55e6bf1acc2a34a5520746cf5286672759fe46d5189778b5250b861d2954be187c2a6c16c1bea01a6ec9630902564cd7256e0ec45f5b65ae95b77ca518f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/869d7496e0cb08d4fcc5657c4a3d3cc6282cbc83d11af56dc6ec39552ba74a75a81c31adc67fa0c9aed382144c04bdfb9142f221c2af481faaafe98fb9fbf9f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab23c8db887b8c5559f6e95af1a96db379d10fa9bee6cab751cdda92f81dedd54c5dc40bea7a3e41aa845310714955db19a7ba86a4cce7cf0c0ba5eb63d9eeaf"} 09:45:15 INFO - Running post-run listener: copy_logs_to_upload_dir 09:45:15 INFO - Copying logs to upload dir... 09:45:15 INFO - mkdir: /builds/slave/test/build/upload/logs 09:45:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1239.577118 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 39 secs) (at 2016-07-06 09:45:14.894822) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 09:45:14.898458) ========= 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=7de08804244eb36560b44971000001c3-1467822273.587255-789491697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9ec55e6bf1acc2a34a5520746cf5286672759fe46d5189778b5250b861d2954be187c2a6c16c1bea01a6ec9630902564cd7256e0ec45f5b65ae95b77ca518f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/869d7496e0cb08d4fcc5657c4a3d3cc6282cbc83d11af56dc6ec39552ba74a75a81c31adc67fa0c9aed382144c04bdfb9142f221c2af481faaafe98fb9fbf9f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab23c8db887b8c5559f6e95af1a96db379d10fa9bee6cab751cdda92f81dedd54c5dc40bea7a3e41aa845310714955db19a7ba86a4cce7cf0c0ba5eb63d9eeaf"} build_url:https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011358 build_url: 'https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/f9ec55e6bf1acc2a34a5520746cf5286672759fe46d5189778b5250b861d2954be187c2a6c16c1bea01a6ec9630902564cd7256e0ec45f5b65ae95b77ca518f9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/869d7496e0cb08d4fcc5657c4a3d3cc6282cbc83d11af56dc6ec39552ba74a75a81c31adc67fa0c9aed382144c04bdfb9142f221c2af481faaafe98fb9fbf9f7", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/ab23c8db887b8c5559f6e95af1a96db379d10fa9bee6cab751cdda92f81dedd54c5dc40bea7a3e41aa845310714955db19a7ba86a4cce7cf0c0ba5eb63d9eeaf"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 09:45:14.923639) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:45:14.923958) ========= 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=7de08804244eb36560b44971000001c3-1467822273.587255-789491697 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004442 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:45:15.005954) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 09:45:15.006287) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 09:45:15.006581) ========= ========= Total master_lag: 0.16 =========