builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-024 starttime: 1467822228.88 results: success (0) buildid: 20160706083823 builduid: 69de8c4ee53f42f2a8f36c4fdb883228 revision: df4803bab0bc40c206c6977a8cc7fcaeac677357 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:48.883819) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:48.884902) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:48.885761) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:48.902878) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:48.903504) ========= 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=41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-06 09:23:49-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 222M=0s 2016-07-06 09:23:49 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.278220 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:49.201334) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:49.202125) ========= 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=41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019949 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:49.257538) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 09:23:49.258397) ========= 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=41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-06 09:23:49,414 truncating revision to first 12 chars 2016-07-06 09:23:49,414 Setting DEBUG logging. 2016-07-06 09:23:49,414 attempt 1/10 2016-07-06 09:23:49,414 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:23:50,712 unpacking tar archive at: fx-team-df4803bab0bc/testing/mozharness/ program finished with exit code 0 elapsedTime=1.632966 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-06 09:23:50.908807) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:50.909709) ========= script_repo_revision: df4803bab0bc40c206c6977a8cc7fcaeac677357 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:50.910764) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:50.911524) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-06 09:23:50.923734) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-06 09:23:50.924052) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:23:51 INFO - MultiFileLogger online at 20160706 09:23:51 in /builds/slave/test 09:23:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 09:23:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:23:51 INFO - {'append_to_log': False, 09:23:51 INFO - 'base_work_dir': '/builds/slave/test', 09:23:51 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 09:23:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:23:51 INFO - 'branch': 'Fx-Team-Non-PGO', 09:23:51 INFO - 'buildbot_json_path': 'buildprops.json', 09:23:51 INFO - 'config_files': ('talos/linux_config.py',), 09:23:51 INFO - 'default_actions': ('clobber', 09:23:51 INFO - 'read-buildbot-config', 09:23:51 INFO - 'download-and-extract', 09:23:51 INFO - 'populate-webroot', 09:23:51 INFO - 'create-virtualenv', 09:23:51 INFO - 'install', 09:23:51 INFO - 'run-tests'), 09:23:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:23:51 INFO - 'download_minidump_stackwalk': True, 09:23:51 INFO - 'download_symbols': 'ondemand', 09:23:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:23:51 INFO - 'tooltool.py': '/tools/tooltool.py', 09:23:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:23:51 INFO - '/tools/misc-python/virtualenv.py')}, 09:23:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:23:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:23:51 INFO - 'installer_path': 'installer.exe', 09:23:51 INFO - 'log_level': 'info', 09:23:51 INFO - 'log_name': 'talos', 09:23:51 INFO - 'log_to_console': True, 09:23:51 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:23:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:23:51 INFO - 'opt_config_files': (), 09:23:51 INFO - 'pip_index': False, 09:23:51 INFO - 'sps_profile': False, 09:23:51 INFO - 'sps_profile_interval': 0, 09:23:51 INFO - 'suite': 'dromaeojs-e10s', 09:23:51 INFO - 'system_bits': '32', 09:23:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:23:51 INFO - 'title': 'talos-linux64-ix-024', 09:23:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:23:51 INFO - 'use_talos_json': True, 09:23:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:23:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:23:51 INFO - 'work_dir': 'build'} 09:23:51 INFO - ##### 09:23:51 INFO - ##### Running clobber step. 09:23:51 INFO - ##### 09:23:51 INFO - Running pre-action listener: _resource_record_pre_action 09:23:51 INFO - Running main action method: clobber 09:23:51 INFO - rmtree: /builds/slave/test/build 09:23:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:23:51 INFO - Running post-action listener: _resource_record_post_action 09:23:51 INFO - ##### 09:23:51 INFO - ##### Finished clobber step (success) 09:23:51 INFO - ##### 09:23:51 INFO - ##### 09:23:51 INFO - ##### Running read-buildbot-config step. 09:23:51 INFO - ##### 09:23:51 INFO - Running pre-action listener: _resource_record_pre_action 09:23:51 INFO - Running main action method: read_buildbot_config 09:23:51 INFO - Using buildbot properties: 09:23:51 INFO - { 09:23:51 INFO - "project": "", 09:23:51 INFO - "product": "firefox", 09:23:51 INFO - "script_repo_revision": "production", 09:23:51 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 09:23:51 INFO - "repository": "", 09:23:51 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 09:23:51 INFO - "buildid": "20160706083823", 09:23:51 INFO - "pgo_build": "False", 09:23:51 INFO - "basedir": "/builds/slave/test", 09:23:51 INFO - "buildnumber": 1461, 09:23:51 INFO - "slavename": "talos-linux64-ix-024", 09:23:51 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 09:23:51 INFO - "platform": "ubuntu64_hw", 09:23:51 INFO - "scheduler": "tests-fx-team-linux64-talos", 09:23:51 INFO - "branch": "fx-team", 09:23:51 INFO - "repo_path": "integration/fx-team", 09:23:51 INFO - "revision": "df4803bab0bc40c206c6977a8cc7fcaeac677357", 09:23:51 INFO - "stage_platform": "linux64", 09:23:51 INFO - "builduid": "69de8c4ee53f42f2a8f36c4fdb883228", 09:23:51 INFO - "slavebuilddir": "test" 09:23:51 INFO - } 09:23:51 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:23:51 INFO - Running post-action listener: _resource_record_post_action 09:23:51 INFO - ##### 09:23:51 INFO - ##### Finished read-buildbot-config step (success) 09:23:51 INFO - ##### 09:23:51 INFO - ##### 09:23:51 INFO - ##### Running download-and-extract step. 09:23:51 INFO - ##### 09:23:51 INFO - Running pre-action listener: _resource_record_pre_action 09:23:51 INFO - Running main action method: download_and_extract 09:23:51 INFO - mkdir: /builds/slave/test/build/tests 09:23:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:51 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:23:51 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:23:51 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:23:51 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:23:51 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:23:52 INFO - Downloaded 1361 bytes. 09:23:52 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 09:23:52 INFO - Using the following test package requirements: 09:23:52 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:52 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:23:52 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 09:23:52 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'jsshell-linux-x86_64.zip'], 09:23:52 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:23:52 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 09:23:52 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:23:52 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:23:52 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:23:52 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 09:23:52 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:23:52 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:23: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:23:52 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:23:52 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:23:52 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:23:52 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:23:52 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:23:53 INFO - Downloaded 22730934 bytes. 09:23:53 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:23:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:23:54 INFO - Return code: 0 09:23:54 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:23: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:23:54 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:23:54 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:23:54 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:23:54 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:23:54 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:23:56 INFO - Downloaded 22730934 bytes. 09:23:56 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:23:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 09:23:57 INFO - Return code: 0 09:23:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:57 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:23:57 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:23:57 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:23:57 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:23:57 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:23:58 INFO - Downloaded 14403333 bytes. 09:23:58 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:23:58 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 09:23:58 INFO - Return code: 0 09:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:23:58 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:23:58 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:23:58 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:23:58 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:23:58 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:00 INFO - Downloaded 56468549 bytes. 09:24:00 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:00 INFO - mkdir: /builds/slave/test/properties 09:24:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:24:00 INFO - Writing to file /builds/slave/test/properties/build_url 09:24:00 INFO - Contents: 09:24:00 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:00 INFO - Running post-action listener: _resource_record_post_action 09:24:00 INFO - Running post-action listener: set_extra_try_arguments 09:24:00 INFO - ##### 09:24:00 INFO - ##### Finished download-and-extract step (success) 09:24:00 INFO - ##### 09:24:00 INFO - ##### 09:24:00 INFO - ##### Running populate-webroot step. 09:24:00 INFO - ##### 09:24:00 INFO - Running pre-action listener: _resource_record_pre_action 09:24:00 INFO - Running main action method: populate_webroot 09:24:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:24:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:24:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:24:00 INFO - '--tppagecycles', 09:24:00 INFO - '7'], 09:24:00 INFO - 'tests': ['tsvgm']}}, 09:24:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:24:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:24:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:24:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:24:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:24:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:24:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:00 INFO - 'talos_options': ['--disable-e10s'], 09:24:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:24:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:00 INFO - 'talos_options': ['--disable-e10s'], 09:24:00 INFO - 'tests': ['damp', 'tps']}, 09:24:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:00 INFO - 'tests': ['damp', 'tps']}, 09:24:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:24:00 INFO - 'tests': ['dromaeo_dom']}, 09:24:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:24:00 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:24:00 INFO - 'tests': ['basic_compositor_video']}, 09:24:00 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 09:24:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:24:00 INFO - 'tests': ['a11yr', 09:24:00 INFO - 'ts_paint', 09:24:00 INFO - 'tpaint', 09:24:00 INFO - 'sessionrestore', 09:24:00 INFO - 'sessionrestore_no_auto_restore', 09:24:00 INFO - 'tabpaint']}, 09:24:00 INFO - 'other-e10s': {'tests': ['a11yr', 09:24:00 INFO - 'ts_paint', 09:24:00 INFO - 'tpaint', 09:24:00 INFO - 'sessionrestore', 09:24:00 INFO - 'sessionrestore_no_auto_restore', 09:24:00 INFO - 'tabpaint']}, 09:24:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:24:00 INFO - 'ts_paint', 09:24:00 INFO - 'tpaint', 09:24:00 INFO - 'sessionrestore', 09:24:00 INFO - 'sessionrestore_no_auto_restore', 09:24:00 INFO - 'tabpaint']}, 09:24:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:24:00 INFO - 'ts_paint', 09:24:00 INFO - 'tpaint', 09:24:00 INFO - 'sessionrestore', 09:24:00 INFO - 'sessionrestore_no_auto_restore', 09:24:00 INFO - 'tabpaint']}, 09:24:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:24:00 INFO - 'tests': ['a11yr', 09:24:00 INFO - 'ts_paint', 09:24:00 INFO - 'tpaint', 09:24:00 INFO - 'sessionrestore', 09:24:00 INFO - 'sessionrestore_no_auto_restore', 09:24:00 INFO - 'tabpaint']}, 09:24:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:24:00 INFO - 'tests': ['a11yr', 09:24:00 INFO - 'ts_paint', 09:24:00 INFO - 'tpaint', 09:24:00 INFO - 'sessionrestore', 09:24:00 INFO - 'sessionrestore_no_auto_restore', 09:24:00 INFO - 'tabpaint']}, 09:24:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:24:00 INFO - 'tests': ['tsvgx', 09:24:00 INFO - 'tsvgr_opacity', 09:24:00 INFO - 'tart', 09:24:00 INFO - 'tscrollx', 09:24:00 INFO - 'cart']}, 09:24:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:24:00 INFO - 'tsvgr_opacity', 09:24:00 INFO - 'tart', 09:24:00 INFO - 'tscrollx', 09:24:00 INFO - 'cart']}, 09:24:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:00 INFO - 'talos_options': ['--disable-e10s'], 09:24:00 INFO - 'tests': ['tp5o']}, 09:24:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:00 INFO - 'tests': ['tp5o']}, 09:24:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:00 INFO - 'talos_options': ['--disable-e10s', 09:24:00 INFO - '--xperf_path', 09:24:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:00 INFO - 'tests': ['tp5n']}, 09:24:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:24:00 INFO - 'talos_options': ['--xperf_path', 09:24:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:24:00 INFO - 'tests': ['tp5n']}}, 09:24:00 INFO - 'talos.zip': {'path': '', 09:24:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:24:00 INFO - Running post-action listener: _resource_record_post_action 09:24:00 INFO - ##### 09:24:00 INFO - ##### Finished populate-webroot step (success) 09:24:00 INFO - ##### 09:24:00 INFO - ##### 09:24:00 INFO - ##### Running create-virtualenv step. 09:24:00 INFO - ##### 09:24:00 INFO - Running pre-action listener: _resource_record_pre_action 09:24:00 INFO - Running main action method: create_virtualenv 09:24:00 INFO - Creating virtualenv /builds/slave/test/build/venv 09:24:00 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:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:24:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:24:00 INFO - Using real prefix '/usr' 09:24:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:24:01 INFO - Installing distribute.............................................................................................................................................................................................done. 09:24:03 INFO - Installing pip.................done. 09:24:03 INFO - Return code: 0 09:24:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:24: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:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:03 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 0x11d7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1495570>, '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 0x1496470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1496900>, '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': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', '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:03 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:03 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:03 INFO - Using env: {'DISPLAY': ':0', 09:24:03 INFO - 'HOME': '/home/cltbld', 09:24:03 INFO - 'LANG': 'en_US.UTF-8', 09:24:03 INFO - 'LANGUAGE': 'en_US:en', 09:24:03 INFO - 'LOGNAME': 'cltbld', 09:24:03 INFO - 'MAIL': '/var/mail/cltbld', 09:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:03 INFO - 'MOZ_NO_REMOTE': '1', 09:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:03 INFO - 'NO_EM_RESTART': '1', 09:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:03 INFO - 'PWD': '/builds/slave/test', 09:24:03 INFO - 'SHELL': '/bin/bash', 09:24:03 INFO - 'SHLVL': '1', 09:24:03 INFO - 'TERM': 'linux', 09:24:03 INFO - 'TMOUT': '86400', 09:24:03 INFO - 'USER': 'cltbld', 09:24:03 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', 09:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:03 INFO - '_': '/tools/buildbot/bin/python'} 09:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:03 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:03 INFO - Cleaning up... 09:24:03 INFO - Return code: 0 09:24:03 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:24: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:24:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24: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:24:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:03 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 0x11d7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1495570>, '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 0x1496470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1496900>, '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': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', '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:03 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:03 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:03 INFO - Using env: {'DISPLAY': ':0', 09:24:03 INFO - 'HOME': '/home/cltbld', 09:24:03 INFO - 'LANG': 'en_US.UTF-8', 09:24:03 INFO - 'LANGUAGE': 'en_US:en', 09:24:03 INFO - 'LOGNAME': 'cltbld', 09:24:03 INFO - 'MAIL': '/var/mail/cltbld', 09:24:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:03 INFO - 'MOZ_NO_REMOTE': '1', 09:24:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:03 INFO - 'NO_EM_RESTART': '1', 09:24:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:03 INFO - 'PWD': '/builds/slave/test', 09:24:03 INFO - 'SHELL': '/bin/bash', 09:24:03 INFO - 'SHLVL': '1', 09:24:03 INFO - 'TERM': 'linux', 09:24:03 INFO - 'TMOUT': '86400', 09:24:03 INFO - 'USER': 'cltbld', 09:24:03 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', 09:24:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:03 INFO - '_': '/tools/buildbot/bin/python'} 09:24:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:03 INFO - Downloading/unpacking psutil>=3.1.1 09:24:03 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:03 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:03 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:03 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:03 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:03 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:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:24:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:05 INFO - Installing collected packages: psutil 09:24:05 INFO - Running setup.py install for psutil 09:24:05 INFO - building 'psutil._psutil_linux' extension 09:24:05 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:06 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:06 INFO - building 'psutil._psutil_posix' extension 09:24:06 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:06 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:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:24:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:24:06 INFO - Successfully installed psutil 09:24:06 INFO - Cleaning up... 09:24:06 INFO - Return code: 0 09:24:06 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:06 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 0x11d7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1495570>, '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 0x1496470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1496900>, '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': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', '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:06 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:06 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:06 INFO - Using env: {'DISPLAY': ':0', 09:24:06 INFO - 'HOME': '/home/cltbld', 09:24:06 INFO - 'LANG': 'en_US.UTF-8', 09:24:06 INFO - 'LANGUAGE': 'en_US:en', 09:24:06 INFO - 'LOGNAME': 'cltbld', 09:24:06 INFO - 'MAIL': '/var/mail/cltbld', 09:24:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:06 INFO - 'MOZ_NO_REMOTE': '1', 09:24:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:06 INFO - 'NO_EM_RESTART': '1', 09:24:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:06 INFO - 'PWD': '/builds/slave/test', 09:24:06 INFO - 'SHELL': '/bin/bash', 09:24:06 INFO - 'SHLVL': '1', 09:24:06 INFO - 'TERM': 'linux', 09:24:06 INFO - 'TMOUT': '86400', 09:24:06 INFO - 'USER': 'cltbld', 09:24:06 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', 09:24:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:06 INFO - '_': '/tools/buildbot/bin/python'} 09:24:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:06 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:24:06 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:06 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:06 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:06 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:06 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:06 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:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:24:08 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:08 INFO - Installing collected packages: mozsystemmonitor 09:24:08 INFO - Running setup.py install for mozsystemmonitor 09:24:08 INFO - Successfully installed mozsystemmonitor 09:24:08 INFO - Cleaning up... 09:24:08 INFO - Return code: 0 09:24:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:24:08 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:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:08 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:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:08 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 0x11d7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1495570>, '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 0x1496470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1496900>, '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': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', '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:08 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:08 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:08 INFO - Using env: {'DISPLAY': ':0', 09:24:08 INFO - 'HOME': '/home/cltbld', 09:24:08 INFO - 'LANG': 'en_US.UTF-8', 09:24:08 INFO - 'LANGUAGE': 'en_US:en', 09:24:08 INFO - 'LOGNAME': 'cltbld', 09:24:08 INFO - 'MAIL': '/var/mail/cltbld', 09:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:08 INFO - 'MOZ_NO_REMOTE': '1', 09:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:08 INFO - 'NO_EM_RESTART': '1', 09:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:08 INFO - 'PWD': '/builds/slave/test', 09:24:08 INFO - 'SHELL': '/bin/bash', 09:24:08 INFO - 'SHLVL': '1', 09:24:08 INFO - 'TERM': 'linux', 09:24:08 INFO - 'TMOUT': '86400', 09:24:08 INFO - 'USER': 'cltbld', 09:24:08 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', 09:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:08 INFO - '_': '/tools/buildbot/bin/python'} 09:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:08 INFO - Downloading/unpacking jsonschema==2.5.1 09:24:08 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:08 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:08 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:08 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:08 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:08 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:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:24:10 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:24:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:24:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:24:10 INFO - Downloading functools32-3.2.3-2.tar.gz 09:24:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:24:11 INFO - warning: no files found matching '*.txt' 09:24:11 INFO - no previously-included directories found matching 'build' 09:24:11 INFO - no previously-included directories found matching 'dist' 09:24:11 INFO - no previously-included directories found matching '.git*' 09:24:11 INFO - Installing collected packages: jsonschema, functools32 09:24:11 INFO - Running setup.py install for functools32 09:24:11 INFO - warning: no files found matching '*.txt' 09:24:11 INFO - no previously-included directories found matching 'build' 09:24:11 INFO - no previously-included directories found matching 'dist' 09:24:11 INFO - no previously-included directories found matching '.git*' 09:24:11 INFO - Successfully installed jsonschema functools32 09:24:11 INFO - Cleaning up... 09:24:11 INFO - Return code: 0 09:24:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:24:11 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:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:11 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:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:11 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 0x11d7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1495570>, '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 0x1496470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1496900>, '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': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', '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:11 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:11 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:11 INFO - Using env: {'DISPLAY': ':0', 09:24:11 INFO - 'HOME': '/home/cltbld', 09:24:11 INFO - 'LANG': 'en_US.UTF-8', 09:24:11 INFO - 'LANGUAGE': 'en_US:en', 09:24:11 INFO - 'LOGNAME': 'cltbld', 09:24:11 INFO - 'MAIL': '/var/mail/cltbld', 09:24:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:11 INFO - 'MOZ_NO_REMOTE': '1', 09:24:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:11 INFO - 'NO_EM_RESTART': '1', 09:24:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:11 INFO - 'PWD': '/builds/slave/test', 09:24:11 INFO - 'SHELL': '/bin/bash', 09:24:11 INFO - 'SHLVL': '1', 09:24:11 INFO - 'TERM': 'linux', 09:24:11 INFO - 'TMOUT': '86400', 09:24:11 INFO - 'USER': 'cltbld', 09:24:11 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', 09:24:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:11 INFO - '_': '/tools/buildbot/bin/python'} 09:24:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:11 INFO - Downloading/unpacking blobuploader==1.2.4 09:24:11 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:11 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:11 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:11 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:11 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:11 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:13 INFO - Downloading blobuploader-1.2.4.tar.gz 09:24:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:24:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:24:13 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:13 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:13 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:13 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:13 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:13 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:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:24:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:24:13 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:13 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:13 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:13 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:13 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:13 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:14 INFO - Downloading docopt-0.6.1.tar.gz 09:24:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:24:14 INFO - Installing collected packages: blobuploader, requests, docopt 09:24:14 INFO - Running setup.py install for blobuploader 09:24:14 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:24:14 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:24:14 INFO - Running setup.py install for requests 09:24:14 INFO - Running setup.py install for docopt 09:24:14 INFO - Successfully installed blobuploader requests docopt 09:24:14 INFO - Cleaning up... 09:24:14 INFO - Return code: 0 09:24:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:14 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 0x11d7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1495570>, '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 0x1496470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1496900>, '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': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', '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:14 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:24:14 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:24:14 INFO - Using env: {'DISPLAY': ':0', 09:24:14 INFO - 'HOME': '/home/cltbld', 09:24:14 INFO - 'LANG': 'en_US.UTF-8', 09:24:14 INFO - 'LANGUAGE': 'en_US:en', 09:24:14 INFO - 'LOGNAME': 'cltbld', 09:24:14 INFO - 'MAIL': '/var/mail/cltbld', 09:24:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:14 INFO - 'MOZ_NO_REMOTE': '1', 09:24:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:14 INFO - 'NO_EM_RESTART': '1', 09:24:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:14 INFO - 'PWD': '/builds/slave/test', 09:24:14 INFO - 'SHELL': '/bin/bash', 09:24:14 INFO - 'SHLVL': '1', 09:24:14 INFO - 'TERM': 'linux', 09:24:14 INFO - 'TMOUT': '86400', 09:24:14 INFO - 'USER': 'cltbld', 09:24:14 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', 09:24:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:14 INFO - '_': '/tools/buildbot/bin/python'} 09:24:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:14 INFO - Running setup.py (path:/tmp/pip-zpvI00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:15 INFO - Running setup.py (path:/tmp/pip-6A1e0k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:15 INFO - Running setup.py (path:/tmp/pip-ol2IvF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:15 INFO - Running setup.py (path:/tmp/pip-k5_RiK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:15 INFO - Running setup.py (path:/tmp/pip-53mmyn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:15 INFO - Running setup.py (path:/tmp/pip-yjd3Oj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:15 INFO - Running setup.py (path:/tmp/pip-7HcNvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:15 INFO - Running setup.py (path:/tmp/pip-p1uBUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:15 INFO - Running setup.py (path:/tmp/pip-vGMnWb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:15 INFO - Running setup.py (path:/tmp/pip-2HfGME-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:15 INFO - Running setup.py (path:/tmp/pip-RxLN_b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:15 INFO - Running setup.py (path:/tmp/pip-ZAQmMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:15 INFO - Running setup.py (path:/tmp/pip-9ClZF0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:15 INFO - Running setup.py (path:/tmp/pip-EX3EdK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:16 INFO - Running setup.py (path:/tmp/pip-eqPTqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:16 INFO - Running setup.py (path:/tmp/pip-dRwBpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:16 INFO - Running setup.py (path:/tmp/pip-l0Ybam-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:16 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:24:16 INFO - Running setup.py install for manifestparser 09:24:16 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:24:16 INFO - Running setup.py install for mozcrash 09:24:16 INFO - Running setup.py install for mozdebug 09:24:16 INFO - Running setup.py install for mozdevice 09:24:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:24:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:24:16 INFO - Running setup.py install for mozfile 09:24:16 INFO - Running setup.py install for mozhttpd 09:24:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:24:16 INFO - Running setup.py install for mozinfo 09:24:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:24:16 INFO - Running setup.py install for mozInstall 09:24:17 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:24:17 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:24:17 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:24:17 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:24:17 INFO - Running setup.py install for mozleak 09:24:17 INFO - Running setup.py install for mozlog 09:24:17 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:24:17 INFO - Running setup.py install for moznetwork 09:24:17 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:24:17 INFO - Running setup.py install for mozprocess 09:24:17 INFO - Running setup.py install for mozprofile 09:24:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:24:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:24:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:24:17 INFO - Running setup.py install for mozrunner 09:24:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:24:17 INFO - Running setup.py install for mozscreenshot 09:24:17 INFO - Running setup.py install for moztest 09:24:17 INFO - Running setup.py install for mozversion 09:24:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:24:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:24:17 INFO - Cleaning up... 09:24:18 INFO - Return code: 0 09:24:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:18 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 0x11d7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1495570>, '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 0x1496470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1496900>, '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': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', '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:18 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:24:18 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:24:18 INFO - Using env: {'DISPLAY': ':0', 09:24:18 INFO - 'HOME': '/home/cltbld', 09:24:18 INFO - 'LANG': 'en_US.UTF-8', 09:24:18 INFO - 'LANGUAGE': 'en_US:en', 09:24:18 INFO - 'LOGNAME': 'cltbld', 09:24:18 INFO - 'MAIL': '/var/mail/cltbld', 09:24:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:18 INFO - 'MOZ_NO_REMOTE': '1', 09:24:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:18 INFO - 'NO_EM_RESTART': '1', 09:24:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:18 INFO - 'PWD': '/builds/slave/test', 09:24:18 INFO - 'SHELL': '/bin/bash', 09:24:18 INFO - 'SHLVL': '1', 09:24:18 INFO - 'TERM': 'linux', 09:24:18 INFO - 'TMOUT': '86400', 09:24:18 INFO - 'USER': 'cltbld', 09:24:18 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', 09:24:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:18 INFO - '_': '/tools/buildbot/bin/python'} 09:24:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:24:18 INFO - Running setup.py (path:/tmp/pip-3ifheU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:24:18 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:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:24:18 INFO - Running setup.py (path:/tmp/pip-fp1snH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:24:18 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:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:24:18 INFO - Running setup.py (path:/tmp/pip-c4rTNg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:24:18 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:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:24:18 INFO - Running setup.py (path:/tmp/pip-SedtXf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:24:18 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:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:24:18 INFO - Running setup.py (path:/tmp/pip-1o0__i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:24:18 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:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:24:18 INFO - Running setup.py (path:/tmp/pip-zFNLb5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:24:18 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:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:24:18 INFO - Running setup.py (path:/tmp/pip-u1w956-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:24:18 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:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:24:18 INFO - Running setup.py (path:/tmp/pip-GpmaOP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:24:18 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:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:24:18 INFO - Running setup.py (path:/tmp/pip-l7hUA9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:24:18 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:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:24:18 INFO - Running setup.py (path:/tmp/pip-boIFlu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:24:18 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:24:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:24:18 INFO - Running setup.py (path:/tmp/pip-TDbX0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:24:19 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:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:24:19 INFO - Running setup.py (path:/tmp/pip-34S2dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:24:19 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:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:24:19 INFO - Running setup.py (path:/tmp/pip-TYoqsu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:24:19 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:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:24:19 INFO - Running setup.py (path:/tmp/pip-qGHbCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:24:19 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:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:19 INFO - Running setup.py (path:/tmp/pip-TpIigT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:24:19 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:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:24:19 INFO - Running setup.py (path:/tmp/pip-g9DUry-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:24:19 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:24:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:24:19 INFO - Running setup.py (path:/tmp/pip-v7_PuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:24:19 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:24:19 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:24:19 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:24:19 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:24:19 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:24:19 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:24:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:24:19 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:19 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:19 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:19 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:19 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:19 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:21 INFO - Downloading blessings-1.6.tar.gz 09:24:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:24:21 INFO - Installing collected packages: blessings 09:24:21 INFO - Running setup.py install for blessings 09:24:21 INFO - Successfully installed blessings 09:24:21 INFO - Cleaning up... 09:24:21 INFO - Return code: 0 09:24:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:24:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:21 INFO - Reading from file tmpfile_stdout 09:24:21 INFO - Current package versions: 09:24:21 INFO - argparse == 1.2.1 09:24:21 INFO - blessings == 1.6 09:24:21 INFO - blobuploader == 1.2.4 09:24:21 INFO - docopt == 0.6.1 09:24:21 INFO - functools32 == 3.2.3-2 09:24:21 INFO - jsonschema == 2.5.1 09:24:21 INFO - manifestparser == 1.1 09:24:21 INFO - mozInstall == 1.12 09:24:21 INFO - mozcrash == 0.17 09:24:21 INFO - mozdebug == 0.1 09:24:21 INFO - mozdevice == 0.48 09:24:21 INFO - mozfile == 1.2 09:24:21 INFO - mozhttpd == 0.7 09:24:21 INFO - mozinfo == 0.9 09:24:21 INFO - mozleak == 0.1 09:24:21 INFO - mozlog == 3.2 09:24:21 INFO - moznetwork == 0.27 09:24:21 INFO - mozprocess == 0.22 09:24:21 INFO - mozprofile == 0.28 09:24:21 INFO - mozrunner == 6.11 09:24:21 INFO - mozscreenshot == 0.1 09:24:21 INFO - mozsystemmonitor == 0.3 09:24:21 INFO - moztest == 0.7 09:24:21 INFO - mozversion == 1.4 09:24:21 INFO - psutil == 3.1.1 09:24:21 INFO - requests == 1.2.3 09:24:21 INFO - wsgiref == 0.1.2 09:24:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:21 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 0x11d7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1495570>, '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 0x1496470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1496900>, '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': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', '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:21 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:24:21 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:24:21 INFO - Using env: {'DISPLAY': ':0', 09:24:21 INFO - 'HOME': '/home/cltbld', 09:24:21 INFO - 'LANG': 'en_US.UTF-8', 09:24:21 INFO - 'LANGUAGE': 'en_US:en', 09:24:21 INFO - 'LOGNAME': 'cltbld', 09:24:21 INFO - 'MAIL': '/var/mail/cltbld', 09:24:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:21 INFO - 'MOZ_NO_REMOTE': '1', 09:24:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:21 INFO - 'NO_EM_RESTART': '1', 09:24:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:21 INFO - 'PWD': '/builds/slave/test', 09:24:21 INFO - 'SHELL': '/bin/bash', 09:24:21 INFO - 'SHLVL': '1', 09:24:21 INFO - 'TERM': 'linux', 09:24:21 INFO - 'TMOUT': '86400', 09:24:21 INFO - 'USER': 'cltbld', 09:24:21 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', 09:24:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:21 INFO - '_': '/tools/buildbot/bin/python'} 09:24:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:22 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:24:22 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:24:22 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:24:22 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:24:22 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:24:22 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:24:22 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:24:22 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:24:22 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:24:22 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:24:22 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:24:22 INFO - Cleaning up... 09:24:22 INFO - Return code: 0 09:24:22 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:22 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:24:22 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:24:22 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:24:22 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:24:22 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11d7030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x133a8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1406400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1495570>, '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 0x1496470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1496900>, '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': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', '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:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:24:22 INFO - Using env: {'DISPLAY': ':0', 09:24:22 INFO - 'HOME': '/home/cltbld', 09:24:22 INFO - 'LANG': 'en_US.UTF-8', 09:24:22 INFO - 'LANGUAGE': 'en_US:en', 09:24:22 INFO - 'LOGNAME': 'cltbld', 09:24:22 INFO - 'MAIL': '/var/mail/cltbld', 09:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:22 INFO - 'MOZ_NO_REMOTE': '1', 09:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:22 INFO - 'NO_EM_RESTART': '1', 09:24:22 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:22 INFO - 'PWD': '/builds/slave/test', 09:24:22 INFO - 'SHELL': '/bin/bash', 09:24:22 INFO - 'SHLVL': '1', 09:24:22 INFO - 'TERM': 'linux', 09:24:22 INFO - 'TMOUT': '86400', 09:24:22 INFO - 'USER': 'cltbld', 09:24:22 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', 09:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:22 INFO - '_': '/tools/buildbot/bin/python'} 09:24:22 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:24:22 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:24:22 INFO - Cleaning up... 09:24:22 INFO - Return code: 0 09:24:22 INFO - Running post-action listener: _resource_record_post_action 09:24:22 INFO - Running post-action listener: _start_resource_monitoring 09:24:22 INFO - Starting resource monitoring. 09:24:22 INFO - ##### 09:24:22 INFO - ##### Finished create-virtualenv step (success) 09:24:22 INFO - ##### 09:24:22 INFO - ##### 09:24:22 INFO - ##### Running install step. 09:24:22 INFO - ##### 09:24:22 INFO - Running pre-action listener: _resource_record_pre_action 09:24:22 INFO - Running main action method: install 09:24:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:24:22 INFO - Reading from file tmpfile_stdout 09:24:22 INFO - Detecting whether we're running mozinstall >=1.0... 09:24:22 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:24:22 INFO - Reading from file tmpfile_stdout 09:24:22 INFO - Output received: 09:24:22 INFO - Usage: mozinstall [options] installer 09:24:22 INFO - Options: 09:24:22 INFO - -h, --help show this help message and exit 09:24:22 INFO - -d DEST, --destination=DEST 09:24:22 INFO - Directory to install application into. [default: 09:24:22 INFO - "/builds/slave/test"] 09:24:22 INFO - --app=APP Application being installed. [default: firefox] 09:24:22 INFO - mkdir: /builds/slave/test/build/application 09:24:22 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:24:22 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:24:38 INFO - Reading from file tmpfile_stdout 09:24:38 INFO - Output received: 09:24:38 INFO - /builds/slave/test/build/application/firefox/firefox 09:24:38 INFO - Running post-action listener: _resource_record_post_action 09:24:38 INFO - ##### 09:24:38 INFO - ##### Finished install step (success) 09:24:38 INFO - ##### 09:24:38 INFO - ##### 09:24:38 INFO - ##### Running run-tests step. 09:24:38 INFO - ##### 09:24:38 INFO - Running pre-action listener: _resource_record_pre_action 09:24:38 INFO - Running main action method: run_tests 09:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:24:38 INFO - Python 2.7.3 09:24:38 INFO - Return code: 0 09:24:38 INFO - grabbing minidump binary from tooltool 09:24:38 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:38 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 0x1495570>, '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 0x1496470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1496900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:24:38 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:24:38 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:24:38 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:24:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:24:38 INFO - Return code: 0 09:24:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:24:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:24:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:24:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:24:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:24:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:24:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-024 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:24:38 INFO - Using env: {'DISPLAY': ':0', 09:24:38 INFO - 'HOME': '/home/cltbld', 09:24:38 INFO - 'LANG': 'en_US.UTF-8', 09:24:38 INFO - 'LANGUAGE': 'en_US:en', 09:24:38 INFO - 'LOGNAME': 'cltbld', 09:24:38 INFO - 'MAIL': '/var/mail/cltbld', 09:24:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:24:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:24:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:24:38 INFO - 'MOZ_NO_REMOTE': '1', 09:24:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:24:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:24:38 INFO - 'NO_EM_RESTART': '1', 09:24:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:24:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:24:38 INFO - 'PWD': '/builds/slave/test', 09:24:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:24:38 INFO - 'SHELL': '/bin/bash', 09:24:38 INFO - 'SHLVL': '1', 09:24:38 INFO - 'TERM': 'linux', 09:24:38 INFO - 'TMOUT': '86400', 09:24:38 INFO - 'USER': 'cltbld', 09:24:38 INFO - 'XDG_SESSION_COOKIE': '41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604', 09:24:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:24:38 INFO - '_': '/tools/buildbot/bin/python'} 09:24:38 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JpOpiI26SYKZvxxQd2wibQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-024', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:24:39 INFO - mozversion application_buildid: 20160706083823 09:24:39 INFO - mozversion application_changeset: df4803bab0bc40c206c6977a8cc7fcaeac677357 09:24:39 INFO - mozversion application_display_name: Nightly 09:24:39 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:24:39 INFO - mozversion application_name: Firefox 09:24:39 INFO - mozversion application_remotingname: firefox 09:24:39 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:24:39 INFO - mozversion application_vendor: Mozilla 09:24:39 INFO - mozversion application_version: 50.0a1 09:24:39 INFO - mozversion platform_buildid: 20160706083823 09:24:39 INFO - mozversion platform_changeset: df4803bab0bc40c206c6977a8cc7fcaeac677357 09:24:39 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:24:39 INFO - mozversion platform_version: 50.0a1 09:24:39 INFO - using testdate: 1467822279 09:24:39 INFO - actual date: 1467822279 09:24:39 INFO - starting webserver on 'localhost:57239' 09:24:39 INFO - SUITE-START | Running 2 tests 09:24:39 INFO - TEST-START | dromaeo_css 09:24:39 INFO - operating with platform_type : linux_ 09:24:39 INFO - Initialising browser for dromaeo_css test... 09:24:39 INFO - TEST-INFO | started process 20734 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvJAQsB/profile http://localhost:57239/getInfo.html) 09:24:43 INFO - PROCESS | 20734 | __metrics Screen width/height:1600/1200 09:24:43 INFO - PROCESS | 20734 | colorDepth:24 09:24:43 INFO - PROCESS | 20734 | Browser inner width/height: 1024/697 09:24:43 INFO - PROCESS | 20734 | __metrics 09:24:44 ERROR - PROCESS | 20734 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 09:24:45 INFO - TEST-INFO | 20734: exit 0 09:24:45 INFO - Browser initialized. 09:24:45 INFO - Running cycle 1/1 for dromaeo_css test... 09:24:45 INFO - TEST-INFO | started process 20856 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvJAQsB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:24:57 INFO - PROCESS | 20856 | RSS: Main: 169635840 09:24:57 INFO - PROCESS | 20856 | 09:25:47 INFO - PROCESS | 20856 | 1467822347057 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:27:59 INFO - PROCESS | 20856 | Cycle 1(1): loaded http://localhost:57239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57239/tests/dromaeo/cssquery-ext.html) 09:28:00 INFO - PROCESS | 20856 | RSS: Main: 172040192 09:28:00 INFO - PROCESS | 20856 | 09:31:02 INFO - PROCESS | 20856 | Cycle 1(1): loaded http://localhost:57239/tests/dromaeo/cssquery-ext.html (next: http://localhost:57239/tests/dromaeo/cssquery-jquery.html) 09:31:03 INFO - PROCESS | 20856 | RSS: Main: 169394176 09:31:03 INFO - PROCESS | 20856 | 09:34:05 INFO - PROCESS | 20856 | Cycle 1(1): loaded http://localhost:57239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57239/tests/dromaeo/cssquery-mootools.html) 09:34:05 INFO - PROCESS | 20856 | RSS: Main: 172855296 09:34:05 INFO - PROCESS | 20856 | 09:37:07 INFO - PROCESS | 20856 | Cycle 1(1): loaded http://localhost:57239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57239/tests/dromaeo/cssquery-prototype.html) 09:37:08 INFO - PROCESS | 20856 | RSS: Main: 168247296 09:37:08 INFO - PROCESS | 20856 | 09:40:11 INFO - PROCESS | 20856 | Cycle 1(1): loaded http://localhost:57239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57239/tests/dromaeo/cssquery-yui.html) 09:40:11 INFO - PROCESS | 20856 | RSS: Main: 170430464 09:40:11 INFO - PROCESS | 20856 | 09:43:14 INFO - PROCESS | 20856 | Cycle 1(1): loaded http://localhost:57239/tests/dromaeo/cssquery-yui.html (next: http://localhost:57239/tests/dromaeo/cssquery-dojo.html) 09:43:14 INFO - PROCESS | 20856 | RSS: Main: 171450368 09:43:14 INFO - PROCESS | 20856 | 09:43:14 INFO - PROCESS | 20856 | __start_tp_report 09:43:14 INFO - PROCESS | 20856 | _x_x_mozilla_page_load 09:43:14 INFO - PROCESS | 20856 | _x_x_mozilla_page_load_details 09:43:14 INFO - PROCESS | 20856 | |i|pagename|runs| 09:43:14 INFO - PROCESS | 20856 | |0;dojo.html;2623.6064590311453;2665.5068812269737;2670.0921686626543;2670.5593577059785;2679.0891097026993;4628.953710462899;4721.433427988642;4761.833335833247;4766;4775.973165769359;4755.6671033027615;4761.666683332168;4764.452088009872;4783.234682450809;4792.496787837279;4370.606645401913;4393.670474714393;4456.286994080931;4495.348174514694;4507.3689683444345;4158.584141585832;4491.146682130385;4505.941103840595;4529.682922195448;4557.225271703802;4321.65426765858;4358.106588149453;4387.62705170061;4389.758563279019;4499.595036446703;4391.033972526039;4412.382266482695;4468.218061839198;4472.418585583853;4498;4421.646268298528;4435.3125265583885;4440.755758433284;4481.126180394825;4501.144782491349;4549.09018196362;4614.5385461453925;4617.607503362218;4626.8149274029;4636.53634636537;4900.26496025599;4923.975380123076;4925.729084900329;4928.063667903087;4959.132151873408;4938.185199442088;4960.90078198434;5005.049040682259;5060.84817455477;5168.664036837631;4760.5001474844985;4803.759812009455;4806.2310030394965;4834.250691142878;4853.757312134415;5255.949920568177;5269.789208431696;5271.446498117719;5291.7354132294;5328.573714102862;4992.550670439678;4993.700377977333;5033.924491132636;5056.064628043824;5059.645824792303;5053.2420136979745;5141.38303403594;5151.2530683050745;5172.818951336685;5203.8178663746585;4993.300937868701;5022.3219865317715;5042.117629414838;5046.293518907356;5048.697078175322;4901.877453063631;5029.0947629427055;5039.647224694309;5045.495450454925;5089.058524172966;4200.6429453496185;4241.300185469425;4244.511881133709;4244.724092934011;4249.97875010623;3703.8888833335045;3733.533308336458;3739.5325584301963;3750.3811871041516;3760.360738674432;4387.627051700578;4459.687821852504;4461.933071003938;4464;4473.306637471197;5181.896362072813;5211.9478805211465;5225.294585230945;5227.973860130751;5274.841754747364;4466.57567531084;4498.280275155959;4500.054988452396;4504.729716216972;4527.864164075083;4507.256302710016;4553.476350219701;4598.195315819718;4612.7924243409125;4636.44362676481;4879.024195161053;4900.583450406755;4900.852974410774;4910.754105509315;4939.580135688435;5172.275881376535;5204.63567550283;5205.479452054916;5213.374395072616;5235.136202526541;4837.153498137882;4869.780859861386;4920.21276595743;4946.183879659816;4950.6782059166035;5143.665661731976;5178;5190.844274671766;5193.558547523503;5215.81744638951;5057.544820966131;5236.371635403776;5246.685198888079;5254.474552544868;5281.57747380201;4848.9757551212015;4939.259111133359;4968.205087186033;4984.1526940420945;4990.925136123034;4934.111859865258;5006.874828129326;5046.243063540498;5075.7969681212335;5079.085764562415;4936.679115857458;4967.850964471072;4980.701157930535;4983.053219888209;5005.549500544968;4937.604991600591;4954.033963377107;4994.550490455877;5002.674826136289;5109.412417571878;4875.634327425386;4908.116539022867;4918.729469879191;4941.975290123526;4989.25161225819 09:43:14 INFO - PROCESS | 20856 | |1;ext.html;563.963342382745;571.6912867051792;577.1861675038197;579.2180556249065;618.7308520793458;34980.82509587452;39638.80180599097;39745.40381894274;39772.20455590894;39849.40225896614;39506.209875802466;39839;39929.40105898414;39983;40031.19937601253;7591.810204744898;7730.265624765639;7734.458587898849;7737.497062690935;7757.030371203599;7815.5310681359015;7852.411069169807;7893.447458677895;7913.446058775888;7928.8810667840025;7957.72147974821;7960.800979975489;7993.720219792309;7999.320057795066;8010.239027292427;7821.569813660275;7860.489068210548;7903.091144518367;7923.366130709529;7927.841443171104;7757.612119394008;7846.293833555007;7849.489783164133;7857.332126769232;7858.1356050834365;38021.42967855457;38492;38512.22975540502;38540.614593853985;38795.80602097;2909.6072030275855;2975.3900450407614;2988.6264216972877;3005;3008.2329006103523;29801;29819;29986.08626515612;30044.8497757512;30207.395852082835;3349.5645566076255;3377.2738861144726;3424.6917777400154;3435.4159792835276;3465.7573969822124;260065;261385;261664;261955.69022154956;262858;54032.45967540353;54518;54605.1809222862;54951.72524137354;55025.44974550203;33145.17137071592;33913.66086339105;34073.31853362968;35866.64133358685;35948;15172.393104275927;15328.693426131415;15352.232388380537;15411.768823467657;15461.690766184613;11390.772184556263;11534.826977595343;11544.422778861024;11584.652460426201;11603.477843497063;18611.162497687637;18683.532911677317;18701.34545290908;18748.531286717942;18811.529711757317;6736.507492227809;6801.387875091265;6829.487788415889;6900.965495172492;7004.614746189009;836.8661014237692;911.4713466189594;953.4470007395694;974.2985050763439;983.1643103362085;28683.13950581486;29575;29664.703352966193;29766.40467190644;29893.252668683457;952.1383148250844;994.393420013791;1073.4364458659265;1083.128081894083;1087.3472322070409;14686.192259425834;14920.253987300592;14932.925335373253;15088.924555377373;15207.695846083016;400761;403643;404397;404885;405156;50072.24891626628;50749.746251269244;50897.74551127221;51050;51083.7445812776;1176.758764453285;1186.7804456175636;1206.3304865799566;1220.1215125109907;1222.5904322052213;26709.86645066762;27823;27888.16335509938;28271.717282827733;28314.43371132607;42286.788566056974;42575.7871210642;42937;43012.569874302106;43038.35442468428;295567;297836;361300;362242;362642;25061.624075639244;25088;25413.872930635967;25615;25635.871820640776;42699.7865010673;43032.354514681676;43290.78354608207;43565.34651980159;44381;37603.81198094101;37698.43452348272;37753.24493510169;37925.620743792206;38143.04642383962;36567.537298508825;37501.249975000894;37999.62000379961;38065.42901856419;38248;30226.790928362618;35447.82276088603;35771.46342804808;36321.27357452889;36960.815195923846;32303.51544726784;33718.831405842815;33788.66211337855;33958.83020584881;34086.31827363488;24502.63246051275;24837.751622483545;24877.87561062183;25016.62475062839;25146.49707005813 09:43:14 INFO - PROCESS | 20856 | |2;jquery.html;370.69788122680023;374.37292535003877;375.7125798763946;387.91465877506937;390.66402893511577;16513.339466421345;16745.246463909123;17500.82499175008;17692.646147077052;17742.935423874576;11014.944925275382;16521.586960325996;16943.813933024663;17485.213165407557;17502.649947001086;4615.676902616819;4764.523547645225;4805.20714082176;4805.735684537349;4808.975955120237;3495.5106285119978;5744.827655170351;6049.455549000589;6054.182685337489;6144.784932527363;5203.2975548301065;6029.758809647609;6063.2724073111285;6098.298695649991;6110.9388906111035;5498.505134537891;5516.91724624131;5592.189132575753;5595.21666966623;5609.859753506154;5319.0957537218765;5432.972835135839;5454.61817672763;5464.480874316933;5473.06957817168;20557.588848223102;20569.69145462819;20982.580348393098;21434;21434.35696929079;1892.81071892811;1896.6111947050822;1913.425972208332;1991.3926252492984;2476.6904136982876;9335.439873607605;10068.647597334058;10945.781084378268;11165.27425717334;13777.173369597856;1705.6247625522365;1751.6599801152129;1783.0460703523552;1820.5266630675987;1836.5592257858152;68828;70788;71737.64131179363;71990.64004679942;72597;10012.449315287584;10042.598296068221;10261.127804136582;10357.74105647365;10470.947645261725;14230.857691422952;14231.644208894653;14262.215578143301;14281.85718142826;14290;7306.342766818457;7432.182459929403;7510.774676759706;7595.772126836204;7834.334081603128;7268.23683513234;7329.340359367682;7411;7484.47608667399;7502.437317201123;4324.308110702335;4479.619232365286;4496.280595104768;4587.403637527167;4589.403377560896;1718.4758648612294;1770.1857145713116;1849.898255595955;1901.3250296144945;1901.3535397964758;845.8984921809299;870.4907629036958;889.0575989451203;912.2063804490136;947.7677968897664;17176.31294748221;17440.389586364417;17555.385561505285;17900.015499147412;18107.637847243244;842.5323945210345;851.0893344121854;887.2502735188755;894.1550235027967;902.0425676282483;9819.558119884623;9882.950585247028;9953.402795832273;9975.301728879054;10191.23565732573;380748;384346;390335;391709;392175;50301.74849125731;58015.709921450965;80491;84873.57563212268;86154;913.5934509143367;923.8845144356956;940.5203346293303;944.8252073366449;952.6522819171091;15275.694486110438;15339.539813805604;15607.84392156064;15629;15948.601284967968;36220.27559448849;37369;38055.238895222494;38804;39795;51333.68998395006;54473.72763136159;55338.72330638482;56525.43474565202;57044.714776425855;7729.536227826348;8073.273405393543;8102.351811854919;8110.918890811016;8208.507489550646;11451.541938322374;12011.099167562294;12086.928858313064;12419;12541.93729031349;10149.64476243328;10823.945880270549;11140.721481963015;11223.158263130135;11377.2604780689;9629.32594718391;9889.653862114792;10130.08829205375;10846.403447810446;11109.277896936674;10941.671749847517;11010;11243.550257989917;11277.436128193722;11390;7767;7819.41354398411;7861.646225919962;8090.514569125871;8151.30713889326;9167.587458564247;10593.788124237319;10727.731806704895;10765.246432749946;10988.780224395627 09:43:14 INFO - PROCESS | 20856 | |3;mootools.html;1388.0145096981144;1415.8017877497152;1502.4816438328774;1703.523013556203;1734.254270663614;6991.26591707871;7674.5778982156025;7753.10839253486;8238.752837414871;8243.670253189872;8005.679772809095;8023.67905283788;8058.073321568007;8097.392695547828;8105.91894081059;2168.1544197762846;2193.7806219378012;2206.2388475975763;2210.2153735423935;2211.1045026764104;2137.316058861165;2152.817010554097;2210.5689390568846;2218.1016688241207;2223.5775202711516;2172.978270217301;2190.5837890800776;2191.079746506471;2195.4511372156962;2208.006397121294;2147.3235930681863;2165.382865883216;2168.5012447137087;2176.3579743975565;2179.0521123311332;2082.885441300728;2123.5965166618294;2125.3730149605904;2125.7555381131215;2132.72274604302;8079.515229086273;8117.837643247161;8150.2664760171865;8152.470089444168;8170;4591.862244132648;4732.455767586737;4735.12400205963;4738.597219236369;4741.762911854428;2990.8055976361466;3018.547217917308;3062.724354808078;3087.4596945534668;3100.643426005993;899.5322432335149;913.5112714697672;932.7901222225013;933.7665583604099;943.1181844974902;11034.227604067719;11038.17213708967;11053.944730276378;11060.944695276552;11061.834072488919;4138.482689663792;4185.560516145761;4364.279893817548;4373;4385.122975404932;9352.719418417322;9411.247100231965;9425.481598512011;9426.293028022788;9435.386699864486;4753.453352864396;4782.497837727058;4784.593309568656;4785.688930219594;4797.784099715521;3757.098296408842;4174.979125104416;4299.9570004300185;4377.562243775661;4383.868483945486;3712.0534263763107;3730.4590834329415;3802.961970380316;3827.3684842001317;3837.6354246346555;1153.8326942593278;1156.919015668895;1164.0745607242263;1168.807146820765;1186.8160435132568;695.2977492732376;787.5038725602833;792.8572856885816;806.8386322735477;813.7436707437257;4928.827491037797;5151.793928242903;5230.137027390514;5367.355917289872;5495.917561236584;842.3471809347805;848.499385362639;852.0457088061411;884.8451520983803;888.5024386343539;3379.205886616643;3456.5333679953387;3462.324846654878;3484.007057988461;3522.4011917973494;9630.422174669542;9987.400755954666;10028.247881408923;10038.397696138256;10131.290809643402;9892.55483503244;9930.503474826375;9989.550470228856;9992.600295988079;10001.799964000826;7412.703491860373;7511.924880751122;7562.546247225184;7593.354564861938;7624.961875190588;5003.874903127451;5050.419201791841;5059.74067456561;5063.974680126576;5129.025485157808;9184;9255.490947997925;9255.67605133817;9278.675246366345;9280.814383712423;8733.825323493622;9068.365214434927;9132.634694612141;9274.072592740671;9342.205912497242;6110.541709371726;6596.472282217507;6864.897026544706;6868.416184624363;7036.612986285803;7738.535687858746;7755.185705500841;7762.650680719268;7793.883091753742;7840.176781437867;6697.665116744046;6777.1189745332795;6862.451003919575;6935.098437203334;7090.113735783028;6962.303769622998;6984.26665200167;7032.156141262876;7066.540674856118;7077.398421134261;6090.69546522681;6116.113163591165;6134.294556126102;6140.048292514489;6201.844953876009;4410.977945110382;4520.525344838745;4556.589906908394;4579.290210017452;4605.125026245003;4400.602439681241;4456.197884380843;4518.909621807611;4548.272276435754;4570.565796249351 09:43:14 INFO - PROCESS | 20856 | |4;prototype.html;299.0877822640943;301.43781846855615;304.96950304969505;313.42173689542784;313.7286247396003;4907.386576677915;4996.350474438318;5049.722265275408;5153.536181743642;5183.300254465651;5035;5069.808594980186;5071.061853557095;5088.8982220355665;5089.541941225289;3934.291827471054;3969.8809035728973;4031.9596804031876;4036.3945408188715;4057.736247143941;3942.4874766280345;3973.8013099344917;4019.6985226108013;4041.5352234493116;4044.676425885922;3988.660963818079;3995.3231335005617;3998.9600103999023;4009.9198016039663;4015.156817068419;4003.6997225207933;4009.5389030261604;4029.81865816039;4032.4354590357225;4038.586494726822;3562.0026392609852;3597.3524765542193;3597.982010089933;3603.207294395229;3605.5312809334882;4840.298156767284;4998.57512111471;5001.249812528114;5021.171506701427;5071.137906555894;4577.3362862384765;4600;4617.907641847144;4620.630349572026;4620.907581848378;5298.443663415363;5342.332208473941;5352.732363381854;5365.436629153961;5391.56867450603;3809.8189561236104;3870.806459677005;3878.564930975557;3903.7852918089493;3919.627635374635;5505.3393592768725;5514.621344663834;5549.944500554983;5573.27547418833;5598.1602759586385;3928.155446578999;3932.6657234134846;3947.5262968443394;3948.7433316834313;3966.127451960622;3909.4588517463308;3971.245463361952;4014.157027024299;4019.1157945252;4029.959700403017;4519.751413672214;4520.638348932078;4563.680542362003;4583.564561366665;4594.517575654575;5272.657277276965;5288.113236770971;5368.3826359968325;5390.191471279261;5394.622376433612;1298.6818229533824;1341.805438211454;1384.968198691981;1396.2041636267434;1400.5308221745624;946.2240962410895;952.9857052144223;967.1489089601106;969.1762002298132;971.8056388722284;4600.447946246405;4603.815847366068;4612.031473390559;4624.213883639789;4633.189191891405;5381.865453363619;5389.51494365509;5392.029434701792;5427.158790387496;5460.071787796084;4438.245498265303;4601.838935637236;4623.144718227139;4627.583517483443;4642.582167604932;2919.7518210952308;2933.990216701566;2938.911832645024;2942.6763056063814;2944.6466424028827;5193.896122077537;5208.114620514521;5210.973945130326;5229.633925625246;5231.738413079407;5379.193121031876;5614.933162699074;5625.156226566048;5644.463775941279;5656.906944430587;5132.307138536325;5184.5593124584075;5184.8963020739375;5195.662281951737;5197.532222099878;5450.345958485007;5484.890302194013;5502.174673798962;5515.145152501369;5561.193626924154;5234.424213336606;5393.892122157614;5409.78360865561;5410;5425.484578964992;5162.8967420652125;5173.870653233699;5178.2135163368575;5207.088759467154;5219.947800522098;3866.4007078902814;3872.1287710264965;3879.5732469428904;3886.145048089416;3900.551436584829;5193.76628051731;5333.5199832015305;5447;5484.341878974548;5484.504550429465;5100.693958362362;5270.025045366619;5292.650374154566;5305.973470132624;5319.840404787863;5272.578193744568;5275.709835958905;5276.947230527646;5293.444188360167;5320.57435405159;5050.207176452306;5173.896522069463;5174.223866419917;5188.688678679291;5216.191490319006;5284.313039304866;5290.550303224269;5318.601104917224;5337.092694242066;5375.274337964324;5164.870878228075;5172.327597412313;5240.580753539632;5262.184361423985;5267.3152490176035 09:43:14 INFO - PROCESS | 20856 | |5;yui.html;572.3618165745194;586.9090291004895;594.9018411962027;633.1041576169722;634.6985182038529;11528.365939873303;12256.571020014302;12320.137590368679;12394.380280985959;12413.131080824345;11613.47739351729;11713.062954963603;11751.588694395698;11772.47023883925;11779.116566257544;613.9877202455948;757.3600307739979;758.5372922517274;780.1262585903796;783.2872086401376;776.2586729673177;778.0624347661055;781.742025131708;781.9687212511493;783.34199272611;823.9464434811748;825;825.7151282807422;825.7894236969595;827.1976183102381;814.2346194577108;818.8198596308862;819.1767273889702;820.1060843680388;822.5023860564362;599.3018133874032;601.7502736364404;602.7588964414225;603.7766026570154;607.5079185859468;12262.325572093532;12266.81599776004;12279.201851879689;12294.385280735927;12360.196587221802;12975.87024129756;13443.798343024862;13460.125091868997;13477.797833032513;13529.932350338284;9827.754306142333;9874.703758887244;9990.650327238585;10040.648577299833;10154.89845101547;3114.4082624301536;3179.5230715392645;3200.647928727838;3202.151429871086;3204.8237346945907;59383.703081484746;59431.702841485945;59728.40271597272;61191.694041529954;62099;10172.491375431198;10203;10322.535485903152;10442.373457592417;10564.788704225872;19048;19258.71111933322;19275.903620482088;19649.31227407034;19731.506712332306;6655.367740064686;6673.1992160941;6774.903989732321;6829.385355318045;6858.554193977376;3578.355895938756;3632;3637.890863274106;3688.3545379559005;3714.6895467123077;2730.180945716277;2820.3513191965553;2829.3633932365055;2860.2992266894744;2861.2131663792206;471.4695967037083;471.8796706839734;479.76011994003;492.8890999525078;495.15823100728903;537.0360203434844;615.4522474997256;618.9102580125857;633.237028535248;644.3685188515282;7092.219855815856;7115.324044215895;7648.502847314907;7770.805729856799;8554.401191916506;584.5498965796398;597.6772542826825;608.5496732417979;613.0314103716117;623.9469645080128;3661.6338366163704;3884.3008258513173;3908.863189788344;3943.1719338939142;4002.6197511236387;93716.53141734384;93931;96394;96457.51771241099;97262;84546;84969;85396.57301713452;85412.57293713492;86048;45753;63586;69866;75604.62197689086;77333;7331.853362932605;7504.62476876165;7675.846483070419;7707.383409327353;7788.571628560484;30482.23794405069;38667.80666096652;38872.805635971636;39432;42426.363604546576;61341.079883802675;63549;65134.67432662806;65969.34030659632;67717;11531.942340288246;11636.12729045342;11716.472758726048;11726.179167458196;11750.23623464472;12831.486740530647;13013.544525941546;13315.66710832237;13908.095973761672;14050.578482645536;12295.754084918073;12526.373681315716;12688.619341419771;12737.172083814523;13236.47054117863;12301.630951071482;12506;12513.50154054463;12532.749345012866;13133.934330328288;11649.534018639159;11753.236039657395;11798.260869565218;12011;12049.33728644933;10204.897951020692;10432.791344172922;10508.316959397614;10920.672379828618;10925.399103049409;9672.661456848977;9854.458004809805;9860.802783944424;10067.093961543496;10071.0936015756 09:43:14 INFO - PROCESS | 20856 | __end_tp_report 09:43:14 INFO - PROCESS | 20856 | __start_cc_report 09:43:14 INFO - PROCESS | 20856 | _x_x_mozilla_cycle_collect,418 09:43:14 INFO - PROCESS | 20856 | __end_cc_report 09:43:14 INFO - PROCESS | 20856 | __startTimestamp1467823394624__endTimestamp 09:43:14 INFO - PROCESS | 20856 | 09:43:14 INFO - PROCESS | 20856 | ------- Summary: start ------- 09:43:14 INFO - PROCESS | 20856 | Number of tests: 6 09:43:14 INFO - PROCESS | 20856 | 09:43:14 INFO - PROCESS | 20856 | [#0] dojo.html Cycles:165 Average:4735.03 Median:4900.85 stddev:504.26 (10.3%) stddev-sans-first:477.83 09:43:14 INFO - PROCESS | 20856 | Values: 2623.6 2665.5 2670.1 2670.6 2679.1 4629.0 4721.4 4761.8 4766.0 4776.0 4755.7 4761.7 4764.5 4783.2 4792.5 4370.6 4393.7 4456.3 4495.3 4507.4 4158.6 4491.1 4505.9 4529.7 4557.2 4321.7 4358.1 4387.6 4389.8 4499.6 4391.0 4412.4 4468.2 4472.4 4498.0 4421.6 4435.3 4440.8 4481.1 4501.1 4549.1 4614.5 4617.6 4626.8 4636.5 4900.3 4924.0 4925.7 4928.1 4959.1 4938.2 4960.9 5005.0 5060.8 5168.7 4760.5 4803.8 4806.2 4834.3 4853.8 5255.9 5269.8 5271.4 5291.7 5328.6 4992.6 4993.7 5033.9 5056.1 5059.6 5053.2 5141.4 5151.3 5172.8 5203.8 4993.3 5022.3 5042.1 5046.3 5048.7 4901.9 5029.1 5039.6 5045.5 5089.1 4200.6 4241.3 4244.5 4244.7 4250.0 3703.9 3733.5 3739.5 3750.4 3760.4 4387.6 4459.7 4461.9 4464.0 4473.3 5181.9 5211.9 5225.3 5228.0 5274.8 4466.6 4498.3 4500.1 4504.7 4527.9 4507.3 4553.5 4598.2 4612.8 4636.4 4879.0 4900.6 4900.9 4910.8 4939.6 5172.3 5204.6 5205.5 5213.4 5235.1 4837.2 4869.8 4920.2 4946.2 4950.7 5143.7 5178.0 5190.8 5193.6 5215.8 5057.5 5236.4 5246.7 5254.5 5281.6 4849.0 4939.3 4968.2 4984.2 4990.9 4934.1 5006.9 5046.2 5075.8 5079.1 4936.7 4967.9 4980.7 4983.1 5005.5 4937.6 4954.0 4994.6 5002.7 5109.4 4875.6 4908.1 4918.7 4942.0 4989.3 09:43:14 INFO - PROCESS | 20856 | 09:43:14 INFO - PROCESS | 20856 | [#1] ext.html Cycles:180 Average:48415.14 Median:37552.53 stddev:89430.85 (238.1%) stddev-sans-first:89609.56 09:43:14 INFO - PROCESS | 20856 | Values: 564.0 571.7 577.2 579.2 618.7 34980.8 39638.8 39745.4 39772.2 39849.4 39506.2 39839.0 39929.4 39983.0 40031.2 7591.8 7730.3 7734.5 7737.5 7757.0 7815.5 7852.4 7893.4 7913.4 7928.9 7957.7 7960.8 7993.7 7999.3 8010.2 7821.6 7860.5 7903.1 7923.4 7927.8 7757.6 7846.3 7849.5 7857.3 7858.1 38021.4 38492.0 38512.2 38540.6 38795.8 2909.6 2975.4 2988.6 3005.0 3008.2 29801.0 29819.0 29986.1 30044.8 30207.4 3349.6 3377.3 3424.7 3435.4 3465.8 260065.0 261385.0 261664.0 261955.7 262858.0 54032.5 54518.0 54605.2 54951.7 55025.4 33145.2 33913.7 34073.3 35866.6 35948.0 15172.4 15328.7 15352.2 15411.8 15461.7 11390.8 11534.8 11544.4 11584.7 11603.5 18611.2 18683.5 18701.3 18748.5 18811.5 6736.5 6801.4 6829.5 6901.0 7004.6 836.9 911.5 953.4 974.3 983.2 28683.1 29575.0 29664.7 29766.4 29893.3 952.1 994.4 1073.4 1083.1 1087.3 14686.2 14920.3 14932.9 15088.9 15207.7 400761.0 403643.0 404397.0 404885.0 405156.0 50072.2 50749.7 50897.7 51050.0 51083.7 1176.8 1186.8 1206.3 1220.1 1222.6 26709.9 27823.0 27888.2 28271.7 28314.4 42286.8 42575.8 42937.0 43012.6 43038.4 295567.0 297836.0 361300.0 362242.0 362642.0 25061.6 25088.0 25413.9 25615.0 25635.9 42699.8 43032.4 43290.8 43565.3 44381.0 37603.8 37698.4 37753.2 37925.6 38143.0 36567.5 37501.2 37999.6 38065.4 38248.0 30226.8 35447.8 35771.5 36321.3 36960.8 32303.5 33718.8 33788.7 33958.8 34086.3 24502.6 24837.8 24877.9 25016.6 25146.5 09:43:14 INFO - PROCESS | 20856 | 09:43:14 INFO - PROCESS | 20856 | [#2] jquery.html Cycles:180 Average:24531.16 Median:391942.00 stddev:64046.04 (16.3%) stddev-sans-first:64200.02 09:43:14 INFO - PROCESS | 20856 | Values: 370.7 374.4 375.7 387.9 390.7 16513.3 16745.2 17500.8 17692.6 17742.9 11014.9 16521.6 16943.8 17485.2 17502.6 4615.7 4764.5 4805.2 4805.7 4809.0 3495.5 5744.8 6049.5 6054.2 6144.8 5203.3 6029.8 6063.3 6098.3 6110.9 5498.5 5516.9 5592.2 5595.2 5609.9 5319.1 5433.0 5454.6 5464.5 5473.1 20557.6 20569.7 20982.6 21434.0 21434.4 1892.8 1896.6 1913.4 1991.4 2476.7 9335.4 10068.6 10945.8 11165.3 13777.2 1705.6 1751.7 1783.0 1820.5 1836.6 68828.0 70788.0 71737.6 71990.6 72597.0 10012.4 10042.6 10261.1 10357.7 10470.9 14230.9 14231.6 14262.2 14281.9 14290.0 7306.3 7432.2 7510.8 7595.8 7834.3 7268.2 7329.3 7411.0 7484.5 7502.4 4324.3 4479.6 4496.3 4587.4 4589.4 1718.5 1770.2 1849.9 1901.3 1901.4 845.9 870.5 889.1 912.2 947.8 17176.3 17440.4 17555.4 17900.0 18107.6 842.5 851.1 887.3 894.2 902.0 9819.6 9883.0 9953.4 9975.3 10191.2 380748.0 384346.0 390335.0 391709.0 392175.0 50301.7 58015.7 80491.0 84873.6 86154.0 913.6 923.9 940.5 944.8 952.7 15275.7 15339.5 15607.8 15629.0 15948.6 36220.3 37369.0 38055.2 38804.0 39795.0 51333.7 54473.7 55338.7 56525.4 57044.7 7729.5 8073.3 8102.4 8110.9 8208.5 11451.5 12011.1 12086.9 12419.0 12541.9 10149.6 10823.9 11140.7 11223.2 11377.3 9629.3 9889.7 10130.1 10846.4 11109.3 10941.7 11010.0 11243.6 11277.4 11390.0 7767.0 7819.4 7861.6 8090.5 8151.3 9167.6 10593.8 10727.7 10765.2 10988.8 09:43:14 INFO - PROCESS | 20856 | 09:43:14 INFO - PROCESS | 20856 | [#3] mootools.html Cycles:180 Average:5236.48 Median:5027.15 stddev:2986.23 (59.4%) stddev-sans-first:2980.61 09:43:14 INFO - PROCESS | 20856 | Values: 1388.0 1415.8 1502.5 1703.5 1734.3 6991.3 7674.6 7753.1 8238.8 8243.7 8005.7 8023.7 8058.1 8097.4 8105.9 2168.2 2193.8 2206.2 2210.2 2211.1 2137.3 2152.8 2210.6 2218.1 2223.6 2173.0 2190.6 2191.1 2195.5 2208.0 2147.3 2165.4 2168.5 2176.4 2179.1 2082.9 2123.6 2125.4 2125.8 2132.7 8079.5 8117.8 8150.3 8152.5 8170.0 4591.9 4732.5 4735.1 4738.6 4741.8 2990.8 3018.5 3062.7 3087.5 3100.6 899.5 913.5 932.8 933.8 943.1 11034.2 11038.2 11053.9 11060.9 11061.8 4138.5 4185.6 4364.3 4373.0 4385.1 9352.7 9411.2 9425.5 9426.3 9435.4 4753.5 4782.5 4784.6 4785.7 4797.8 3757.1 4175.0 4300.0 4377.6 4383.9 3712.1 3730.5 3803.0 3827.4 3837.6 1153.8 1156.9 1164.1 1168.8 1186.8 695.3 787.5 792.9 806.8 813.7 4928.8 5151.8 5230.1 5367.4 5495.9 842.3 848.5 852.0 884.8 888.5 3379.2 3456.5 3462.3 3484.0 3522.4 9630.4 9987.4 10028.2 10038.4 10131.3 9892.6 9930.5 9989.6 9992.6 10001.8 7412.7 7511.9 7562.5 7593.4 7625.0 5003.9 5050.4 5059.7 5064.0 5129.0 9184.0 9255.5 9255.7 9278.7 9280.8 8733.8 9068.4 9132.6 9274.1 9342.2 6110.5 6596.5 6864.9 6868.4 7036.6 7738.5 7755.2 7762.7 7793.9 7840.2 6697.7 6777.1 6862.5 6935.1 7090.1 6962.3 6984.3 7032.2 7066.5 7077.4 6090.7 6116.1 6134.3 6140.0 6201.8 4411.0 4520.5 4556.6 4579.3 4605.1 4400.6 4456.2 4518.9 4548.3 4570.6 09:43:14 INFO - PROCESS | 20856 | 09:43:14 INFO - PROCESS | 20856 | [#4] prototype.html Cycles:180 Average:4436.13 Median:5071.10 stddev:1269.84 (25.0%) stddev-sans-first:1234.86 09:43:14 INFO - PROCESS | 20856 | Values: 299.1 301.4 305.0 313.4 313.7 4907.4 4996.4 5049.7 5153.5 5183.3 5035.0 5069.8 5071.1 5088.9 5089.5 3934.3 3969.9 4032.0 4036.4 4057.7 3942.5 3973.8 4019.7 4041.5 4044.7 3988.7 3995.3 3999.0 4009.9 4015.2 4003.7 4009.5 4029.8 4032.4 4038.6 3562.0 3597.4 3598.0 3603.2 3605.5 4840.3 4998.6 5001.2 5021.2 5071.1 4577.3 4600.0 4617.9 4620.6 4620.9 5298.4 5342.3 5352.7 5365.4 5391.6 3809.8 3870.8 3878.6 3903.8 3919.6 5505.3 5514.6 5549.9 5573.3 5598.2 3928.2 3932.7 3947.5 3948.7 3966.1 3909.5 3971.2 4014.2 4019.1 4030.0 4519.8 4520.6 4563.7 4583.6 4594.5 5272.7 5288.1 5368.4 5390.2 5394.6 1298.7 1341.8 1385.0 1396.2 1400.5 946.2 953.0 967.1 969.2 971.8 4600.4 4603.8 4612.0 4624.2 4633.2 5381.9 5389.5 5392.0 5427.2 5460.1 4438.2 4601.8 4623.1 4627.6 4642.6 2919.8 2934.0 2938.9 2942.7 2944.6 5193.9 5208.1 5211.0 5229.6 5231.7 5379.2 5614.9 5625.2 5644.5 5656.9 5132.3 5184.6 5184.9 5195.7 5197.5 5450.3 5484.9 5502.2 5515.1 5561.2 5234.4 5393.9 5409.8 5410.0 5425.5 5162.9 5173.9 5178.2 5207.1 5219.9 3866.4 3872.1 3879.6 3886.1 3900.6 5193.8 5333.5 5447.0 5484.3 5484.5 5100.7 5270.0 5292.7 5306.0 5319.8 5272.6 5275.7 5276.9 5293.4 5320.6 5050.2 5173.9 5174.2 5188.7 5216.2 5284.3 5290.6 5318.6 5337.1 5375.3 5164.9 5172.3 5240.6 5262.2 5267.3 09:43:14 INFO - PROCESS | 20856 | 09:43:14 INFO - PROCESS | 20856 | [#5] yui.html Cycles:180 Average:17332.57 Median:471.67 stddev:24694.30 (5235.5%) stddev-sans-first:24731.51 09:43:14 INFO - PROCESS | 20856 | Values: 572.4 586.9 594.9 633.1 634.7 11528.4 12256.6 12320.1 12394.4 12413.1 11613.5 11713.1 11751.6 11772.5 11779.1 614.0 757.4 758.5 780.1 783.3 776.3 778.1 781.7 782.0 783.3 823.9 825.0 825.7 825.8 827.2 814.2 818.8 819.2 820.1 822.5 599.3 601.8 602.8 603.8 607.5 12262.3 12266.8 12279.2 12294.4 12360.2 12975.9 13443.8 13460.1 13477.8 13529.9 9827.8 9874.7 9990.7 10040.6 10154.9 3114.4 3179.5 3200.6 3202.2 3204.8 59383.7 59431.7 59728.4 61191.7 62099.0 10172.5 10203.0 10322.5 10442.4 10564.8 19048.0 19258.7 19275.9 19649.3 19731.5 6655.4 6673.2 6774.9 6829.4 6858.6 3578.4 3632.0 3637.9 3688.4 3714.7 2730.2 2820.4 2829.4 2860.3 2861.2 471.5 471.9 479.8 492.9 495.2 537.0 615.5 618.9 633.2 644.4 7092.2 7115.3 7648.5 7770.8 8554.4 584.5 597.7 608.5 613.0 623.9 3661.6 3884.3 3908.9 3943.2 4002.6 93716.5 93931.0 96394.0 96457.5 97262.0 84546.0 84969.0 85396.6 85412.6 86048.0 45753.0 63586.0 69866.0 75604.6 77333.0 7331.9 7504.6 7675.8 7707.4 7788.6 30482.2 38667.8 38872.8 39432.0 42426.4 61341.1 63549.0 65134.7 65969.3 67717.0 11531.9 11636.1 11716.5 11726.2 11750.2 12831.5 13013.5 13315.7 13908.1 14050.6 12295.8 12526.4 12688.6 12737.2 13236.5 12301.6 12506.0 12513.5 12532.7 13133.9 11649.5 11753.2 11798.3 12011.0 12049.3 10204.9 10432.8 10508.3 10920.7 10925.4 9672.7 9854.5 9860.8 10067.1 10071.1 09:43:14 INFO - PROCESS | 20856 | -------- Summary: end -------- 09:43:14 INFO - PROCESS | 20856 | 09:43:15 INFO - TEST-INFO | 20856: exit 0 09:43:15 INFO - TEST-OK | dromaeo_css | took 1116276ms 09:43:15 INFO - TEST-START | kraken 09:43:15 INFO - operating with platform_type : linux_ 09:43:15 INFO - Initialising browser for kraken test... 09:43:15 INFO - TEST-INFO | started process 21095 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvp1m9A/profile http://localhost:57239/getInfo.html) 09:43:20 INFO - PROCESS | 21095 | __metrics Screen width/height:1600/1200 09:43:20 INFO - PROCESS | 21095 | colorDepth:24 09:43:20 INFO - PROCESS | 21095 | Browser inner width/height: 1024/697 09:43:20 INFO - PROCESS | 21095 | __metrics 09:43:20 ERROR - PROCESS | 21095 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 09:43:21 INFO - TEST-INFO | 21095: exit 0 09:43:21 INFO - Browser initialized. 09:43:21 INFO - Running cycle 1/1 for kraken test... 09:43:21 INFO - TEST-INFO | started process 21212 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpvp1m9A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:43:33 INFO - PROCESS | 21212 | RSS: Main: 169680896 09:43:33 INFO - PROCESS | 21212 | 09:43:36 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57239/tests/kraken/driver.html?testName=audio-beat-detection) 09:43:37 INFO - PROCESS | 21212 | RSS: Main: 174477312 09:43:37 INFO - PROCESS | 21212 | 09:43:40 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57239/tests/kraken/driver.html?testName=audio-dft) 09:43:40 INFO - PROCESS | 21212 | RSS: Main: 174575616 09:43:40 INFO - PROCESS | 21212 | 09:43:43 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57239/tests/kraken/driver.html?testName=audio-fft) 09:43:44 INFO - PROCESS | 21212 | RSS: Main: 169693184 09:43:44 INFO - PROCESS | 21212 | 09:43:46 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57239/tests/kraken/driver.html?testName=audio-oscillator) 09:43:47 INFO - PROCESS | 21212 | RSS: Main: 170065920 09:43:47 INFO - PROCESS | 21212 | 09:43:49 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:43:50 INFO - PROCESS | 21212 | RSS: Main: 170147840 09:43:50 INFO - PROCESS | 21212 | 09:43:53 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57239/tests/kraken/driver.html?testName=imaging-darkroom) 09:43:53 INFO - PROCESS | 21212 | RSS: Main: 170471424 09:43:53 INFO - PROCESS | 21212 | 09:43:57 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57239/tests/kraken/driver.html?testName=imaging-desaturate) 09:43:58 INFO - PROCESS | 21212 | RSS: Main: 167972864 09:43:58 INFO - PROCESS | 21212 | 09:44:01 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57239/tests/kraken/driver.html?testName=json-parse-financial) 09:44:01 INFO - PROCESS | 21212 | RSS: Main: 169488384 09:44:01 INFO - PROCESS | 21212 | 09:44:03 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:44:04 INFO - PROCESS | 21212 | RSS: Main: 169766912 09:44:04 INFO - PROCESS | 21212 | 09:44:05 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57239/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:44:06 INFO - PROCESS | 21212 | RSS: Main: 170291200 09:44:06 INFO - PROCESS | 21212 | 09:44:08 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:44:09 INFO - PROCESS | 21212 | RSS: Main: 170254336 09:44:09 INFO - PROCESS | 21212 | 09:44:12 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:44:12 INFO - PROCESS | 21212 | RSS: Main: 170467328 09:44:12 INFO - PROCESS | 21212 | 09:44:15 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:44:16 INFO - PROCESS | 21212 | RSS: Main: 170311680 09:44:16 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | Cycle 1(1): loaded http://localhost:57239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57239/tests/kraken/driver.html?testName=ai-astar) 09:44:18 INFO - PROCESS | 21212 | RSS: Main: 171560960 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | __start_tp_report 09:44:18 INFO - PROCESS | 21212 | _x_x_mozilla_page_load 09:44:18 INFO - PROCESS | 21212 | _x_x_mozilla_page_load_details 09:44:18 INFO - PROCESS | 21212 | |i|pagename|runs| 09:44:18 INFO - PROCESS | 21212 | |0;ai-astar;105;113;107;114;114;115;114;114;114;112 09:44:18 INFO - PROCESS | 21212 | |1;audio-beat-detection;158;124;147;171;125;164;148;133;188;126 09:44:18 INFO - PROCESS | 21212 | |2;audio-dft;163;164;163;168;169;163;162;164;162;164 09:44:18 INFO - PROCESS | 21212 | |3;audio-fft;76;75;77;159;77;76;79;74;159;77 09:44:18 INFO - PROCESS | 21212 | |4;audio-oscillator;87;85;134;86;86;85;132;86;85;133 09:44:18 INFO - PROCESS | 21212 | |5;imaging-gaussian-blur;117;118;121;119;120;118;118;118;121;118 09:44:18 INFO - PROCESS | 21212 | |6;imaging-darkroom;148;147;149;147;149;148;147;147;151;148 09:44:18 INFO - PROCESS | 21212 | |7;imaging-desaturate;96;96;96;98;96;96;96;96;95;95 09:44:18 INFO - PROCESS | 21212 | |8;json-parse-financial;65;64;64;65;66;64;64;65;64;67 09:44:18 INFO - PROCESS | 21212 | |9;json-stringify-tinderbox;65;64;64;66;65;64;65;66;65;66 09:44:18 INFO - PROCESS | 21212 | |10;stanford-crypto-aes;86;81;79;78;93;80;78;79;84;78 09:44:18 INFO - PROCESS | 21212 | |11;stanford-crypto-ccm;128;132;130;141;131;130;134;133;173;135 09:44:18 INFO - PROCESS | 21212 | |12;stanford-crypto-pbkdf2;169;172;166;175;165;168;168;167;169;164 09:44:18 INFO - PROCESS | 21212 | |13;stanford-crypto-sha256-iterative;68;68;68;71;68;66;67;68;65;66 09:44:18 INFO - PROCESS | 21212 | __end_tp_report 09:44:18 INFO - PROCESS | 21212 | __start_cc_report 09:44:18 INFO - PROCESS | 21212 | _x_x_mozilla_cycle_collect,1011 09:44:18 INFO - PROCESS | 21212 | __end_cc_report 09:44:18 INFO - PROCESS | 21212 | __startTimestamp1467823458412__endTimestamp 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | ------- Summary: start ------- 09:44:18 INFO - PROCESS | 21212 | Number of tests: 14 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#0] ai-astar Cycles:10 Average:112.20 Median:114.00 stddev:3.39 (3.0%) stddev-sans-first:2.40 09:44:18 INFO - PROCESS | 21212 | Values: 105.0 113.0 107.0 114.0 114.0 115.0 114.0 114.0 114.0 112.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#1] audio-beat-detection Cycles:10 Average:148.40 Median:153.00 stddev:21.85 (14.3%) stddev-sans-first:22.90 09:44:18 INFO - PROCESS | 21212 | Values: 158.0 124.0 147.0 171.0 125.0 164.0 148.0 133.0 188.0 126.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#2] audio-dft Cycles:10 Average:164.20 Median:164.00 stddev:2.39 (1.5%) stddev-sans-first:2.50 09:44:18 INFO - PROCESS | 21212 | Values: 163.0 164.0 163.0 168.0 169.0 163.0 162.0 164.0 162.0 164.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#3] audio-fft Cycles:10 Average:92.90 Median:76.50 stddev:34.86 (45.6%) stddev-sans-first:36.44 09:44:18 INFO - PROCESS | 21212 | Values: 76.0 75.0 77.0 159.0 77.0 76.0 79.0 74.0 159.0 77.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#4] audio-oscillator Cycles:10 Average:99.90 Median:85.50 stddev:22.85 (26.7%) stddev-sans-first:23.76 09:44:18 INFO - PROCESS | 21212 | Values: 87.0 85.0 134.0 86.0 86.0 85.0 132.0 86.0 85.0 133.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#5] imaging-gaussian-blur Cycles:10 Average:118.80 Median:118.50 stddev:1.40 (1.2%) stddev-sans-first:1.32 09:44:18 INFO - PROCESS | 21212 | Values: 117.0 118.0 121.0 119.0 120.0 118.0 118.0 118.0 121.0 118.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#6] imaging-darkroom Cycles:10 Average:148.10 Median:148.00 stddev:1.29 (0.9%) stddev-sans-first:1.36 09:44:18 INFO - PROCESS | 21212 | Values: 148.0 147.0 149.0 147.0 149.0 148.0 147.0 147.0 151.0 148.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.82 (0.9%) stddev-sans-first:0.87 09:44:18 INFO - PROCESS | 21212 | Values: 96.0 96.0 96.0 98.0 96.0 96.0 96.0 96.0 95.0 95.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#8] json-parse-financial Cycles:10 Average:64.80 Median:65.00 stddev:1.03 (1.6%) stddev-sans-first:1.09 09:44:18 INFO - PROCESS | 21212 | Values: 65.0 64.0 64.0 65.0 66.0 64.0 64.0 65.0 64.0 67.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:0.82 (1.3%) stddev-sans-first:0.87 09:44:18 INFO - PROCESS | 21212 | Values: 65.0 64.0 64.0 66.0 65.0 64.0 65.0 66.0 65.0 66.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#10] stanford-crypto-aes Cycles:10 Average:81.60 Median:80.50 stddev:4.84 (6.0%) stddev-sans-first:4.86 09:44:18 INFO - PROCESS | 21212 | Values: 86.0 81.0 79.0 78.0 93.0 80.0 78.0 79.0 84.0 78.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#11] stanford-crypto-ccm Cycles:10 Average:136.70 Median:133.50 stddev:13.25 (9.9%) stddev-sans-first:13.67 09:44:18 INFO - PROCESS | 21212 | Values: 128.0 132.0 130.0 141.0 131.0 130.0 134.0 133.0 173.0 135.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:168.30 Median:168.50 stddev:3.27 (1.9%) stddev-sans-first:3.46 09:44:18 INFO - PROCESS | 21212 | Values: 169.0 172.0 166.0 175.0 165.0 168.0 168.0 167.0 169.0 164.0 09:44:18 INFO - PROCESS | 21212 | 09:44:18 INFO - PROCESS | 21212 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.50 Median:68.00 stddev:1.65 (2.4%) stddev-sans-first:1.74 09:44:18 INFO - PROCESS | 21212 | Values: 68.0 68.0 68.0 71.0 68.0 66.0 67.0 68.0 65.0 66.0 09:44:18 INFO - PROCESS | 21212 | -------- Summary: end -------- 09:44:18 INFO - PROCESS | 21212 | 09:44:19 INFO - TEST-INFO | 21212: exit 0 09:44:19 INFO - TEST-OK | kraken | took 64092ms 09:44:19 INFO - SUITE-END | took 1180s 09:44:19 INFO - Completed test suite (00:19:40) 09:44:19 INFO - javascript benchmark 09:44:19 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6512.846738623237, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2623.6064590311453, 2665.5068812269737, 2670.0921686626543, 2670.5593577059785, 2679.0891097026993, 4628.953710462899, 4721.433427988642, 4761.833335833247, 4766.0, 4775.973165769359, 4755.6671033027615, 4761.666683332168, 4764.452088009872, 4783.234682450809, 4792.496787837279, 4370.606645401913, 4393.670474714393, 4456.286994080931, 4495.348174514694, 4507.3689683444345, 4158.584141585832, 4491.146682130385, 4505.941103840595, 4529.682922195448, 4557.225271703802, 4321.65426765858, 4358.106588149453, 4387.62705170061, 4389.758563279019, 4499.595036446703, 4391.033972526039, 4412.382266482695, 4468.218061839198, 4472.418585583853, 4498.0, 4421.646268298528, 4435.3125265583885, 4440.755758433284, 4481.126180394825, 4501.144782491349, 4549.09018196362, 4614.5385461453925, 4617.607503362218, 4626.8149274029, 4636.53634636537, 4900.26496025599, 4923.975380123076, 4925.729084900329, 4928.063667903087, 4959.132151873408, 4938.185199442088, 4960.90078198434, 5005.049040682259, 5060.84817455477, 5168.664036837631, 4760.5001474844985, 4803.759812009455, 4806.2310030394965, 4834.250691142878, 4853.757312134415, 5255.949920568177, 5269.789208431696, 5271.446498117719, 5291.7354132294, 5328.573714102862, 4992.550670439678, 4993.700377977333, 5033.924491132636, 5056.064628043824, 5059.645824792303, 5053.2420136979745, 5141.38303403594, 5151.2530683050745, 5172.818951336685, 5203.8178663746585, 4993.300937868701, 5022.3219865317715, 5042.117629414838, 5046.293518907356, 5048.697078175322, 4901.877453063631, 5029.0947629427055, 5039.647224694309, 5045.495450454925, 5089.058524172966, 4200.6429453496185, 4241.300185469425, 4244.511881133709, 4244.724092934011, 4249.97875010623, 3703.8888833335045, 3733.533308336458, 3739.5325584301963, 3750.3811871041516, 3760.360738674432, 4387.627051700578, 4459.687821852504, 4461.933071003938, 4464.0, 4473.306637471197, 5181.896362072813, 5211.9478805211465, 5225.294585230945, 5227.973860130751, 5274.841754747364, 4466.57567531084, 4498.280275155959, 4500.054988452396, 4504.729716216972, 4527.864164075083, 4507.256302710016, 4553.476350219701, 4598.195315819718, 4612.7924243409125, 4636.44362676481, 4879.024195161053, 4900.583450406755, 4900.852974410774, 4910.754105509315, 4939.580135688435, 5172.275881376535, 5204.63567550283, 5205.479452054916, 5213.374395072616, 5235.136202526541, 4837.153498137882, 4869.780859861386, 4920.21276595743, 4946.183879659816, 4950.6782059166035, 5143.665661731976, 5178.0, 5190.844274671766, 5193.558547523503, 5215.81744638951, 5057.544820966131, 5236.371635403776, 5246.685198888079, 5254.474552544868, 5281.57747380201, 4848.9757551212015, 4939.259111133359, 4968.205087186033, 4984.1526940420945, 4990.925136123034, 4934.111859865258, 5006.874828129326, 5046.243063540498, 5075.7969681212335, 5079.085764562415, 4936.679115857458, 4967.850964471072, 4980.701157930535, 4983.053219888209, 5005.549500544968, 4937.604991600591, 4954.033963377107, 4994.550490455877, 5002.674826136289, 5109.412417571878, 4875.634327425386, 4908.116539022867, 4918.729469879191, 4941.975290123526, 4989.25161225819], "value": 4702.325204522347, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [563.963342382745, 571.6912867051792, 577.1861675038197, 579.2180556249065, 618.7308520793458, 34980.82509587452, 39638.80180599097, 39745.40381894274, 39772.20455590894, 39849.40225896614, 39506.209875802466, 39839.0, 39929.40105898414, 39983.0, 40031.19937601253, 7591.810204744898, 7730.265624765639, 7734.458587898849, 7737.497062690935, 7757.030371203599, 7815.5310681359015, 7852.411069169807, 7893.447458677895, 7913.446058775888, 7928.8810667840025, 7957.72147974821, 7960.800979975489, 7993.720219792309, 7999.320057795066, 8010.239027292427, 7821.569813660275, 7860.489068210548, 7903.091144518367, 7923.366130709529, 7927.841443171104, 7757.612119394008, 7846.293833555007, 7849.489783164133, 7857.332126769232, 7858.1356050834365, 38021.42967855457, 38492.0, 38512.22975540502, 38540.614593853985, 38795.80602097, 2909.6072030275855, 2975.3900450407614, 2988.6264216972877, 3005.0, 3008.2329006103523, 29801.0, 29819.0, 29986.08626515612, 30044.8497757512, 30207.395852082835, 3349.5645566076255, 3377.2738861144726, 3424.6917777400154, 3435.4159792835276, 3465.7573969822124, 260065.0, 261385.0, 261664.0, 261955.69022154956, 262858.0, 54032.45967540353, 54518.0, 54605.1809222862, 54951.72524137354, 55025.44974550203, 33145.17137071592, 33913.66086339105, 34073.31853362968, 35866.64133358685, 35948.0, 15172.393104275927, 15328.693426131415, 15352.232388380537, 15411.768823467657, 15461.690766184613, 11390.772184556263, 11534.826977595343, 11544.422778861024, 11584.652460426201, 11603.477843497063, 18611.162497687637, 18683.532911677317, 18701.34545290908, 18748.531286717942, 18811.529711757317, 6736.507492227809, 6801.387875091265, 6829.487788415889, 6900.965495172492, 7004.614746189009, 836.8661014237692, 911.4713466189594, 953.4470007395694, 974.2985050763439, 983.1643103362085, 28683.13950581486, 29575.0, 29664.703352966193, 29766.40467190644, 29893.252668683457, 952.1383148250844, 994.393420013791, 1073.4364458659265, 1083.128081894083, 1087.3472322070409, 14686.192259425834, 14920.253987300592, 14932.925335373253, 15088.924555377373, 15207.695846083016, 400761.0, 403643.0, 404397.0, 404885.0, 405156.0, 50072.24891626628, 50749.746251269244, 50897.74551127221, 51050.0, 51083.7445812776, 1176.758764453285, 1186.7804456175636, 1206.3304865799566, 1220.1215125109907, 1222.5904322052213, 26709.86645066762, 27823.0, 27888.16335509938, 28271.717282827733, 28314.43371132607, 42286.788566056974, 42575.7871210642, 42937.0, 43012.569874302106, 43038.35442468428, 295567.0, 297836.0, 361300.0, 362242.0, 362642.0, 25061.624075639244, 25088.0, 25413.872930635967, 25615.0, 25635.871820640776, 42699.7865010673, 43032.354514681676, 43290.78354608207, 43565.34651980159, 44381.0, 37603.81198094101, 37698.43452348272, 37753.24493510169, 37925.620743792206, 38143.04642383962, 36567.537298508825, 37501.249975000894, 37999.62000379961, 38065.42901856419, 38248.0, 30226.790928362618, 35447.82276088603, 35771.46342804808, 36321.27357452889, 36960.815195923846, 32303.51544726784, 33718.831405842815, 33788.66211337855, 33958.83020584881, 34086.31827363488, 24502.63246051275, 24837.751622483545, 24877.87561062183, 25016.62475062839, 25146.49707005813], "value": 17597.553650817616, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [370.69788122680023, 374.37292535003877, 375.7125798763946, 387.91465877506937, 390.66402893511577, 16513.339466421345, 16745.246463909123, 17500.82499175008, 17692.646147077052, 17742.935423874576, 11014.944925275382, 16521.586960325996, 16943.813933024663, 17485.213165407557, 17502.649947001086, 4615.676902616819, 4764.523547645225, 4805.20714082176, 4805.735684537349, 4808.975955120237, 3495.5106285119978, 5744.827655170351, 6049.455549000589, 6054.182685337489, 6144.784932527363, 5203.2975548301065, 6029.758809647609, 6063.2724073111285, 6098.298695649991, 6110.9388906111035, 5498.505134537891, 5516.91724624131, 5592.189132575753, 5595.21666966623, 5609.859753506154, 5319.0957537218765, 5432.972835135839, 5454.61817672763, 5464.480874316933, 5473.06957817168, 20557.588848223102, 20569.69145462819, 20982.580348393098, 21434.0, 21434.35696929079, 1892.81071892811, 1896.6111947050822, 1913.425972208332, 1991.3926252492984, 2476.6904136982876, 9335.439873607605, 10068.647597334058, 10945.781084378268, 11165.27425717334, 13777.173369597856, 1705.6247625522365, 1751.6599801152129, 1783.0460703523552, 1820.5266630675987, 1836.5592257858152, 68828.0, 70788.0, 71737.64131179363, 71990.64004679942, 72597.0, 10012.449315287584, 10042.598296068221, 10261.127804136582, 10357.74105647365, 10470.947645261725, 14230.857691422952, 14231.644208894653, 14262.215578143301, 14281.85718142826, 14290.0, 7306.342766818457, 7432.182459929403, 7510.774676759706, 7595.772126836204, 7834.334081603128, 7268.23683513234, 7329.340359367682, 7411.0, 7484.47608667399, 7502.437317201123, 4324.308110702335, 4479.619232365286, 4496.280595104768, 4587.403637527167, 4589.403377560896, 1718.4758648612294, 1770.1857145713116, 1849.898255595955, 1901.3250296144945, 1901.3535397964758, 845.8984921809299, 870.4907629036958, 889.0575989451203, 912.2063804490136, 947.7677968897664, 17176.31294748221, 17440.389586364417, 17555.385561505285, 17900.015499147412, 18107.637847243244, 842.5323945210345, 851.0893344121854, 887.2502735188755, 894.1550235027967, 902.0425676282483, 9819.558119884623, 9882.950585247028, 9953.402795832273, 9975.301728879054, 10191.23565732573, 380748.0, 384346.0, 390335.0, 391709.0, 392175.0, 50301.74849125731, 58015.709921450965, 80491.0, 84873.57563212268, 86154.0, 913.5934509143367, 923.8845144356956, 940.5203346293303, 944.8252073366449, 952.6522819171091, 15275.694486110438, 15339.539813805604, 15607.84392156064, 15629.0, 15948.601284967968, 36220.27559448849, 37369.0, 38055.238895222494, 38804.0, 39795.0, 51333.68998395006, 54473.72763136159, 55338.72330638482, 56525.43474565202, 57044.714776425855, 7729.536227826348, 8073.273405393543, 8102.351811854919, 8110.918890811016, 8208.507489550646, 11451.541938322374, 12011.099167562294, 12086.928858313064, 12419.0, 12541.93729031349, 10149.64476243328, 10823.945880270549, 11140.721481963015, 11223.158263130135, 11377.2604780689, 9629.32594718391, 9889.653862114792, 10130.08829205375, 10846.403447810446, 11109.277896936674, 10941.671749847517, 11010.0, 11243.550257989917, 11277.436128193722, 11390.0, 7767.0, 7819.41354398411, 7861.646225919962, 8090.514569125871, 8151.30713889326, 9167.587458564247, 10593.788124237319, 10727.731806704895, 10765.246432749946, 10988.780224395627], "value": 8449.419228884228, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1388.0145096981144, 1415.8017877497152, 1502.4816438328774, 1703.523013556203, 1734.254270663614, 6991.26591707871, 7674.5778982156025, 7753.10839253486, 8238.752837414871, 8243.670253189872, 8005.679772809095, 8023.67905283788, 8058.073321568007, 8097.392695547828, 8105.91894081059, 2168.1544197762846, 2193.7806219378012, 2206.2388475975763, 2210.2153735423935, 2211.1045026764104, 2137.316058861165, 2152.817010554097, 2210.5689390568846, 2218.1016688241207, 2223.5775202711516, 2172.978270217301, 2190.5837890800776, 2191.079746506471, 2195.4511372156962, 2208.006397121294, 2147.3235930681863, 2165.382865883216, 2168.5012447137087, 2176.3579743975565, 2179.0521123311332, 2082.885441300728, 2123.5965166618294, 2125.3730149605904, 2125.7555381131215, 2132.72274604302, 8079.515229086273, 8117.837643247161, 8150.2664760171865, 8152.470089444168, 8170.0, 4591.862244132648, 4732.455767586737, 4735.12400205963, 4738.597219236369, 4741.762911854428, 2990.8055976361466, 3018.547217917308, 3062.724354808078, 3087.4596945534668, 3100.643426005993, 899.5322432335149, 913.5112714697672, 932.7901222225013, 933.7665583604099, 943.1181844974902, 11034.227604067719, 11038.17213708967, 11053.944730276378, 11060.944695276552, 11061.834072488919, 4138.482689663792, 4185.560516145761, 4364.279893817548, 4373.0, 4385.122975404932, 9352.719418417322, 9411.247100231965, 9425.481598512011, 9426.293028022788, 9435.386699864486, 4753.453352864396, 4782.497837727058, 4784.593309568656, 4785.688930219594, 4797.784099715521, 3757.098296408842, 4174.979125104416, 4299.9570004300185, 4377.562243775661, 4383.868483945486, 3712.0534263763107, 3730.4590834329415, 3802.961970380316, 3827.3684842001317, 3837.6354246346555, 1153.8326942593278, 1156.919015668895, 1164.0745607242263, 1168.807146820765, 1186.8160435132568, 695.2977492732376, 787.5038725602833, 792.8572856885816, 806.8386322735477, 813.7436707437257, 4928.827491037797, 5151.793928242903, 5230.137027390514, 5367.355917289872, 5495.917561236584, 842.3471809347805, 848.499385362639, 852.0457088061411, 884.8451520983803, 888.5024386343539, 3379.205886616643, 3456.5333679953387, 3462.324846654878, 3484.007057988461, 3522.4011917973494, 9630.422174669542, 9987.400755954666, 10028.247881408923, 10038.397696138256, 10131.290809643402, 9892.55483503244, 9930.503474826375, 9989.550470228856, 9992.600295988079, 10001.799964000826, 7412.703491860373, 7511.924880751122, 7562.546247225184, 7593.354564861938, 7624.961875190588, 5003.874903127451, 5050.419201791841, 5059.74067456561, 5063.974680126576, 5129.025485157808, 9184.0, 9255.490947997925, 9255.67605133817, 9278.675246366345, 9280.814383712423, 8733.825323493622, 9068.365214434927, 9132.634694612141, 9274.072592740671, 9342.205912497242, 6110.541709371726, 6596.472282217507, 6864.897026544706, 6868.416184624363, 7036.612986285803, 7738.535687858746, 7755.185705500841, 7762.650680719268, 7793.883091753742, 7840.176781437867, 6697.665116744046, 6777.1189745332795, 6862.451003919575, 6935.098437203334, 7090.113735783028, 6962.303769622998, 6984.26665200167, 7032.156141262876, 7066.540674856118, 7077.398421134261, 6090.69546522681, 6116.113163591165, 6134.294556126102, 6140.048292514489, 6201.844953876009, 4410.977945110382, 4520.525344838745, 4556.589906908394, 4579.290210017452, 4605.125026245003, 4400.602439681241, 4456.197884380843, 4518.909621807611, 4548.272276435754, 4570.565796249351], "value": 4187.788259175798, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [299.0877822640943, 301.43781846855615, 304.96950304969505, 313.42173689542784, 313.7286247396003, 4907.386576677915, 4996.350474438318, 5049.722265275408, 5153.536181743642, 5183.300254465651, 5035.0, 5069.808594980186, 5071.061853557095, 5088.8982220355665, 5089.541941225289, 3934.291827471054, 3969.8809035728973, 4031.9596804031876, 4036.3945408188715, 4057.736247143941, 3942.4874766280345, 3973.8013099344917, 4019.6985226108013, 4041.5352234493116, 4044.676425885922, 3988.660963818079, 3995.3231335005617, 3998.9600103999023, 4009.9198016039663, 4015.156817068419, 4003.6997225207933, 4009.5389030261604, 4029.81865816039, 4032.4354590357225, 4038.586494726822, 3562.0026392609852, 3597.3524765542193, 3597.982010089933, 3603.207294395229, 3605.5312809334882, 4840.298156767284, 4998.57512111471, 5001.249812528114, 5021.171506701427, 5071.137906555894, 4577.3362862384765, 4600.0, 4617.907641847144, 4620.630349572026, 4620.907581848378, 5298.443663415363, 5342.332208473941, 5352.732363381854, 5365.436629153961, 5391.56867450603, 3809.8189561236104, 3870.806459677005, 3878.564930975557, 3903.7852918089493, 3919.627635374635, 5505.3393592768725, 5514.621344663834, 5549.944500554983, 5573.27547418833, 5598.1602759586385, 3928.155446578999, 3932.6657234134846, 3947.5262968443394, 3948.7433316834313, 3966.127451960622, 3909.4588517463308, 3971.245463361952, 4014.157027024299, 4019.1157945252, 4029.959700403017, 4519.751413672214, 4520.638348932078, 4563.680542362003, 4583.564561366665, 4594.517575654575, 5272.657277276965, 5288.113236770971, 5368.3826359968325, 5390.191471279261, 5394.622376433612, 1298.6818229533824, 1341.805438211454, 1384.968198691981, 1396.2041636267434, 1400.5308221745624, 946.2240962410895, 952.9857052144223, 967.1489089601106, 969.1762002298132, 971.8056388722284, 4600.447946246405, 4603.815847366068, 4612.031473390559, 4624.213883639789, 4633.189191891405, 5381.865453363619, 5389.51494365509, 5392.029434701792, 5427.158790387496, 5460.071787796084, 4438.245498265303, 4601.838935637236, 4623.144718227139, 4627.583517483443, 4642.582167604932, 2919.7518210952308, 2933.990216701566, 2938.911832645024, 2942.6763056063814, 2944.6466424028827, 5193.896122077537, 5208.114620514521, 5210.973945130326, 5229.633925625246, 5231.738413079407, 5379.193121031876, 5614.933162699074, 5625.156226566048, 5644.463775941279, 5656.906944430587, 5132.307138536325, 5184.5593124584075, 5184.8963020739375, 5195.662281951737, 5197.532222099878, 5450.345958485007, 5484.890302194013, 5502.174673798962, 5515.145152501369, 5561.193626924154, 5234.424213336606, 5393.892122157614, 5409.78360865561, 5410.0, 5425.484578964992, 5162.8967420652125, 5173.870653233699, 5178.2135163368575, 5207.088759467154, 5219.947800522098, 3866.4007078902814, 3872.1287710264965, 3879.5732469428904, 3886.145048089416, 3900.551436584829, 5193.76628051731, 5333.5199832015305, 5447.0, 5484.341878974548, 5484.504550429465, 5100.693958362362, 5270.025045366619, 5292.650374154566, 5305.973470132624, 5319.840404787863, 5272.578193744568, 5275.709835958905, 5276.947230527646, 5293.444188360167, 5320.57435405159, 5050.207176452306, 5173.896522069463, 5174.223866419917, 5188.688678679291, 5216.191490319006, 5284.313039304866, 5290.550303224269, 5318.601104917224, 5337.092694242066, 5375.274337964324, 5164.870878228075, 5172.327597412313, 5240.580753539632, 5262.184361423985, 5267.3152490176035], "value": 4032.274215368309, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [572.3618165745194, 586.9090291004895, 594.9018411962027, 633.1041576169722, 634.6985182038529, 11528.365939873303, 12256.571020014302, 12320.137590368679, 12394.380280985959, 12413.131080824345, 11613.47739351729, 11713.062954963603, 11751.588694395698, 11772.47023883925, 11779.116566257544, 613.9877202455948, 757.3600307739979, 758.5372922517274, 780.1262585903796, 783.2872086401376, 776.2586729673177, 778.0624347661055, 781.742025131708, 781.9687212511493, 783.34199272611, 823.9464434811748, 825.0, 825.7151282807422, 825.7894236969595, 827.1976183102381, 814.2346194577108, 818.8198596308862, 819.1767273889702, 820.1060843680388, 822.5023860564362, 599.3018133874032, 601.7502736364404, 602.7588964414225, 603.7766026570154, 607.5079185859468, 12262.325572093532, 12266.81599776004, 12279.201851879689, 12294.385280735927, 12360.196587221802, 12975.87024129756, 13443.798343024862, 13460.125091868997, 13477.797833032513, 13529.932350338284, 9827.754306142333, 9874.703758887244, 9990.650327238585, 10040.648577299833, 10154.89845101547, 3114.4082624301536, 3179.5230715392645, 3200.647928727838, 3202.151429871086, 3204.8237346945907, 59383.703081484746, 59431.702841485945, 59728.40271597272, 61191.694041529954, 62099.0, 10172.491375431198, 10203.0, 10322.535485903152, 10442.373457592417, 10564.788704225872, 19048.0, 19258.71111933322, 19275.903620482088, 19649.31227407034, 19731.506712332306, 6655.367740064686, 6673.1992160941, 6774.903989732321, 6829.385355318045, 6858.554193977376, 3578.355895938756, 3632.0, 3637.890863274106, 3688.3545379559005, 3714.6895467123077, 2730.180945716277, 2820.3513191965553, 2829.3633932365055, 2860.2992266894744, 2861.2131663792206, 471.4695967037083, 471.8796706839734, 479.76011994003, 492.8890999525078, 495.15823100728903, 537.0360203434844, 615.4522474997256, 618.9102580125857, 633.237028535248, 644.3685188515282, 7092.219855815856, 7115.324044215895, 7648.502847314907, 7770.805729856799, 8554.401191916506, 584.5498965796398, 597.6772542826825, 608.5496732417979, 613.0314103716117, 623.9469645080128, 3661.6338366163704, 3884.3008258513173, 3908.863189788344, 3943.1719338939142, 4002.6197511236387, 93716.53141734384, 93931.0, 96394.0, 96457.51771241099, 97262.0, 84546.0, 84969.0, 85396.57301713452, 85412.57293713492, 86048.0, 45753.0, 63586.0, 69866.0, 75604.62197689086, 77333.0, 7331.853362932605, 7504.62476876165, 7675.846483070419, 7707.383409327353, 7788.571628560484, 30482.23794405069, 38667.80666096652, 38872.805635971636, 39432.0, 42426.363604546576, 61341.079883802675, 63549.0, 65134.67432662806, 65969.34030659632, 67717.0, 11531.942340288246, 11636.12729045342, 11716.472758726048, 11726.179167458196, 11750.23623464472, 12831.486740530647, 13013.544525941546, 13315.66710832237, 13908.095973761672, 14050.578482645536, 12295.754084918073, 12526.373681315716, 12688.619341419771, 12737.172083814523, 13236.47054117863, 12301.630951071482, 12506.0, 12513.50154054463, 12532.749345012866, 13133.934330328288, 11649.534018639159, 11753.236039657395, 11798.260869565218, 12011.0, 12049.33728644933, 10204.897951020692, 10432.791344172922, 10508.316959397614, 10920.672379828618, 10925.399103049409, 9672.661456848977, 9854.458004809805, 9860.802783944424, 10067.093961543496, 10071.0936015756], "value": 6463.260041028896, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1564.3999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [105.0, 113.0, 107.0, 114.0, 114.0, 115.0, 114.0, 114.0, 114.0, 112.0], "value": 112.2, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [158.0, 124.0, 147.0, 171.0, 125.0, 164.0, 148.0, 133.0, 188.0, 126.0], "value": 148.4, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 163.0, 168.0, 169.0, 163.0, 162.0, 164.0, 162.0, 164.0], "value": 164.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 75.0, 77.0, 159.0, 77.0, 76.0, 79.0, 74.0, 159.0, 77.0], "value": 92.9, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 134.0, 86.0, 86.0, 85.0, 132.0, 86.0, 85.0, 133.0], "value": 99.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 118.0, 121.0, 119.0, 120.0, 118.0, 118.0, 118.0, 121.0, 118.0], "value": 118.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [148.0, 147.0, 149.0, 147.0, 149.0, 148.0, 147.0, 147.0, 151.0, 148.0], "value": 148.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [96.0, 96.0, 96.0, 98.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 65.0, 66.0, 64.0, 64.0, 65.0, 64.0, 67.0], "value": 64.8, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 64.0, 64.0, 66.0, 65.0, 64.0, 65.0, 66.0, 65.0, 66.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 81.0, 79.0, 78.0, 93.0, 80.0, 78.0, 79.0, 84.0, 78.0], "value": 81.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [128.0, 132.0, 130.0, 141.0, 131.0, 130.0, 134.0, 133.0, 173.0, 135.0], "value": 136.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 172.0, 166.0, 175.0, 165.0, 168.0, 168.0, 167.0, 169.0, 164.0], "value": 168.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 71.0, 68.0, 66.0, 67.0, 68.0, 65.0, 66.0], "value": 67.5, "unit": "score"}]}]} 09:44:19 INFO - Return code: 0 09:44:19 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:44:19 ERROR - # TBPL SUCCESS # 09:44:19 INFO - Running post-action listener: _resource_record_post_action 09:44:19 INFO - ##### 09:44:19 INFO - ##### Finished run-tests step (success) 09:44:19 INFO - ##### 09:44:19 INFO - Running post-run listener: _resource_record_post_run 09:44:19 INFO - Total resource usage - Wall time: 1197s; CPU: 13.0%; Read bytes: 0; Write bytes: 539676672; Read time: 0; Write time: 379552 09:44:19 INFO - TinderboxPrint: CPU usage
13.3% 09:44:19 INFO - TinderboxPrint: I/O read bytes / time
0 / 0 09:44:19 INFO - TinderboxPrint: I/O write bytes / time
539,676,672 / 379,552 09:44:19 INFO - TinderboxPrint: CPU idle
8,279.9 (86.7%) 09:44:19 INFO - TinderboxPrint: CPU user
1,218.4 (12.8%) 09:44:19 INFO - TinderboxPrint: Swap in / out
0 / 0 09:44:19 INFO - install - Wall time: 17s; CPU: 14.0%; Read bytes: 0; Write bytes: 256528384; Read time: 0; Write time: 232212 09:44:19 INFO - run-tests - Wall time: 1181s; CPU: 13.0%; Read bytes: 0; Write bytes: 283148288; Read time: 0; Write time: 147340 09:44:20 INFO - Running post-run listener: _upload_blobber_files 09:44:20 INFO - Blob upload gear active. 09:44:20 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:44:20 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 09:44:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team-Non-PGO', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:44:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team-Non-PGO -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:44:20 INFO - (blobuploader) - INFO - Open directory for files ... 09:44:20 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:44:20 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:20 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:21 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:44:21 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:21 INFO - (blobuploader) - INFO - Done attempting. 09:44:21 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:44:21 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:21 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:24 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:44:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:24 INFO - (blobuploader) - INFO - Done attempting. 09:44:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:44:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:44:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:44:25 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:44:25 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:44:25 INFO - (blobuploader) - INFO - Done attempting. 09:44:25 INFO - (blobuploader) - INFO - Iteration through files over. 09:44:25 INFO - Return code: 0 09:44:25 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:44:25 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:44:25 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2687b05b30fda34b9d42b2547331f0f1c0f522faf41e39f8e87852751920156f38bfeb6029ca500b52775bde03a200d97e066e3f78b129b685cb1082bb12ed95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d64d07ebe1710db9069e4726f33db45c83147d2c1733667f939d0dbc95d388674db9c702ac2692d8475db3f1aed6a02d7c1d7a3accba30c45e148ac1f2a35c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/030617bf679d561f687fe6e22af83127093efd58b435a28a5adce61157e884d63fa11abe1875b706da8751a1320ccfbcb955fc4f53eac5ad543ba59d927d5a63"} 09:44:25 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:44:25 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:44:25 INFO - Contents: 09:44:25 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2687b05b30fda34b9d42b2547331f0f1c0f522faf41e39f8e87852751920156f38bfeb6029ca500b52775bde03a200d97e066e3f78b129b685cb1082bb12ed95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d64d07ebe1710db9069e4726f33db45c83147d2c1733667f939d0dbc95d388674db9c702ac2692d8475db3f1aed6a02d7c1d7a3accba30c45e148ac1f2a35c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/030617bf679d561f687fe6e22af83127093efd58b435a28a5adce61157e884d63fa11abe1875b706da8751a1320ccfbcb955fc4f53eac5ad543ba59d927d5a63"} 09:44:25 INFO - Running post-run listener: copy_logs_to_upload_dir 09:44:25 INFO - Copying logs to upload dir... 09:44:25 INFO - mkdir: /builds/slave/test/build/upload/logs 09:44:25 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1234.731680 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 34 secs) (at 2016-07-06 09:44:25.681052) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 09:44:25.684675) ========= 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=41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2687b05b30fda34b9d42b2547331f0f1c0f522faf41e39f8e87852751920156f38bfeb6029ca500b52775bde03a200d97e066e3f78b129b685cb1082bb12ed95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d64d07ebe1710db9069e4726f33db45c83147d2c1733667f939d0dbc95d388674db9c702ac2692d8475db3f1aed6a02d7c1d7a3accba30c45e148ac1f2a35c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/030617bf679d561f687fe6e22af83127093efd58b435a28a5adce61157e884d63fa11abe1875b706da8751a1320ccfbcb955fc4f53eac5ad543ba59d927d5a63"} 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.011208 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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2687b05b30fda34b9d42b2547331f0f1c0f522faf41e39f8e87852751920156f38bfeb6029ca500b52775bde03a200d97e066e3f78b129b685cb1082bb12ed95", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/0d64d07ebe1710db9069e4726f33db45c83147d2c1733667f939d0dbc95d388674db9c702ac2692d8475db3f1aed6a02d7c1d7a3accba30c45e148ac1f2a35c6", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/030617bf679d561f687fe6e22af83127093efd58b435a28a5adce61157e884d63fa11abe1875b706da8751a1320ccfbcb955fc4f53eac5ad543ba59d927d5a63"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-06 09:44:25.714549) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:44:25.715019) ========= 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=41a7e32711b8e08598a63237000001d6-1467822228.58138-826106604 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004413 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-06 09:44:25.799121) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 09:44:25.799851) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-06 09:44:25.800544) ========= ========= Total master_lag: 0.20 =========