builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-045 starttime: 1467911932.33 results: success (0) buildid: 20160707084422 builduid: e75de5fb021a49f98b5030f5445a451f revision: 5eee8c97b40876ba9b529d70bd6ccec249fc5dce ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:52.334581) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:52.335066) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:52.335410) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:52.355632) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:52.356005) ========= 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=4300f881736b422476174874000001bc-1467911931.529568-1934334358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-07 10:18:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2016-07-07 10:18:52 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.137645 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:52.511690) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:52.512060) ========= 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=4300f881736b422476174874000001bc-1467911931.529568-1934334358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018691 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:52.562834) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 10:18:52.563214) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 5eee8c97b40876ba9b529d70bd6ccec249fc5dce --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 5eee8c97b40876ba9b529d70bd6ccec249fc5dce --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=4300f881736b422476174874000001bc-1467911931.529568-1934334358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-07 10:18:52,838 truncating revision to first 12 chars 2016-07-07 10:18:52,838 Setting DEBUG logging. 2016-07-07 10:18:52,838 attempt 1/10 2016-07-07 10:18:52,838 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/5eee8c97b408?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-07 10:18:53,779 unpacking tar archive at: fx-team-5eee8c97b408/testing/mozharness/ program finished with exit code 0 elapsedTime=1.296008 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-07 10:18:53.880522) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:53.881113) ========= script_repo_revision: 5eee8c97b40876ba9b529d70bd6ccec249fc5dce ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:53.881589) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:53.881907) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-07 10:18:53.893031) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-07 10:18:53.893575) ========= /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=4300f881736b422476174874000001bc-1467911931.529568-1934334358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:18:54 INFO - MultiFileLogger online at 20160707 10:18:54 in /builds/slave/test 10:18:54 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 10:18:54 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:18:54 INFO - {'append_to_log': False, 10:18:54 INFO - 'base_work_dir': '/builds/slave/test', 10:18:54 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 10:18:54 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:18:54 INFO - 'branch': 'Fx-Team-Non-PGO', 10:18:54 INFO - 'buildbot_json_path': 'buildprops.json', 10:18:54 INFO - 'config_files': ('talos/linux_config.py',), 10:18:54 INFO - 'default_actions': ('clobber', 10:18:54 INFO - 'read-buildbot-config', 10:18:54 INFO - 'download-and-extract', 10:18:54 INFO - 'populate-webroot', 10:18:54 INFO - 'create-virtualenv', 10:18:54 INFO - 'install', 10:18:54 INFO - 'run-tests'), 10:18:54 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:18:54 INFO - 'download_minidump_stackwalk': True, 10:18:54 INFO - 'download_symbols': 'ondemand', 10:18:54 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:18:54 INFO - 'tooltool.py': '/tools/tooltool.py', 10:18:54 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:18:54 INFO - '/tools/misc-python/virtualenv.py')}, 10:18:54 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:18:54 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:18:54 INFO - 'installer_path': 'installer.exe', 10:18:54 INFO - 'log_level': 'info', 10:18:54 INFO - 'log_name': 'talos', 10:18:54 INFO - 'log_to_console': True, 10:18:54 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:18:54 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:18:54 INFO - 'opt_config_files': (), 10:18:54 INFO - 'pip_index': False, 10:18:54 INFO - 'sps_profile': False, 10:18:54 INFO - 'sps_profile_interval': 0, 10:18:54 INFO - 'suite': 'dromaeojs-e10s', 10:18:54 INFO - 'system_bits': '32', 10:18:54 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:18:54 INFO - 'title': 'talos-linux64-ix-045', 10:18:54 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:18:54 INFO - 'use_talos_json': True, 10:18:54 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:18:54 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:18:54 INFO - 'work_dir': 'build'} 10:18:54 INFO - ##### 10:18:54 INFO - ##### Running clobber step. 10:18:54 INFO - ##### 10:18:54 INFO - Running pre-action listener: _resource_record_pre_action 10:18:54 INFO - Running main action method: clobber 10:18:54 INFO - rmtree: /builds/slave/test/build 10:18:54 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:18:54 INFO - Running post-action listener: _resource_record_post_action 10:18:54 INFO - ##### 10:18:54 INFO - ##### Finished clobber step (success) 10:18:54 INFO - ##### 10:18:54 INFO - ##### 10:18:54 INFO - ##### Running read-buildbot-config step. 10:18:54 INFO - ##### 10:18:54 INFO - Running pre-action listener: _resource_record_pre_action 10:18:54 INFO - Running main action method: read_buildbot_config 10:18:54 INFO - Using buildbot properties: 10:18:54 INFO - { 10:18:54 INFO - "project": "", 10:18:54 INFO - "product": "firefox", 10:18:54 INFO - "script_repo_revision": "production", 10:18:54 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 10:18:54 INFO - "repository": "", 10:18:54 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 10:18:54 INFO - "buildid": "20160707084422", 10:18:54 INFO - "pgo_build": "False", 10:18:54 INFO - "basedir": "/builds/slave/test", 10:18:54 INFO - "buildnumber": 1469, 10:18:54 INFO - "slavename": "talos-linux64-ix-045", 10:18:54 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 10:18:54 INFO - "platform": "ubuntu64_hw", 10:18:54 INFO - "scheduler": "tests-fx-team-linux64-talos", 10:18:54 INFO - "branch": "fx-team", 10:18:54 INFO - "repo_path": "integration/fx-team", 10:18:54 INFO - "revision": "5eee8c97b40876ba9b529d70bd6ccec249fc5dce", 10:18:54 INFO - "stage_platform": "linux64", 10:18:54 INFO - "builduid": "e75de5fb021a49f98b5030f5445a451f", 10:18:54 INFO - "slavebuilddir": "test" 10:18:54 INFO - } 10:18:54 INFO - Found installer url https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:18:54 INFO - Running post-action listener: _resource_record_post_action 10:18:54 INFO - ##### 10:18:54 INFO - ##### Finished read-buildbot-config step (success) 10:18:54 INFO - ##### 10:18:54 INFO - ##### 10:18:54 INFO - ##### Running download-and-extract step. 10:18:54 INFO - ##### 10:18:54 INFO - Running pre-action listener: _resource_record_pre_action 10:18:54 INFO - Running main action method: download_and_extract 10:18:54 INFO - mkdir: /builds/slave/test/build/tests 10:18: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')]} 10:18:54 INFO - https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:18:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:18:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:18:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/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 10:18:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/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 10:18:55 INFO - Downloaded 1361 bytes. 10:18:55 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:18:55 INFO - Using the following test package requirements: 10:18:55 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:18:55 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:18:55 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:18:55 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:55 INFO - u'jsshell-linux-x86_64.zip'], 10:18:55 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:18:55 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:18:55 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:18:55 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:18:55 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:18:55 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:18:55 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:18:55 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:18:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:18:55 INFO - https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:18:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/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 10:18:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/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 10:18:56 INFO - Downloaded 22734517 bytes. 10:18: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'] 10:18: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 10:18:58 INFO - Return code: 0 10:18:58 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 10:18: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')]} 10:18:58 INFO - https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:18:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:18:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/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 10:18:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/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 10:18:59 INFO - Downloaded 22734517 bytes. 10:18:59 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'] 10:18:59 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 10:19:00 INFO - Return code: 0 10:19:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:00 INFO - https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:19:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:19:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/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 10:19:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/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 10:19:01 INFO - Downloaded 14403333 bytes. 10:19:01 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:19:01 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip -d /builds/slave/test/build/tests 10:19:02 INFO - Return code: 0 10:19:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:02 INFO - https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:19:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:19:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:19:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/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 10:19:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/JbtWWRLuQFmverP6BGTZJQ/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 10:19:03 INFO - Downloaded 56642350 bytes. 10:19:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:19:03 INFO - mkdir: /builds/slave/test/properties 10:19:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:19:03 INFO - Writing to file /builds/slave/test/properties/build_url 10:19:03 INFO - Contents: 10:19:03 INFO - build_url:https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:19:04 INFO - Running post-action listener: _resource_record_post_action 10:19:04 INFO - Running post-action listener: set_extra_try_arguments 10:19:04 INFO - ##### 10:19:04 INFO - ##### Finished download-and-extract step (success) 10:19:04 INFO - ##### 10:19:04 INFO - ##### 10:19:04 INFO - ##### Running populate-webroot step. 10:19:04 INFO - ##### 10:19:04 INFO - Running pre-action listener: _resource_record_pre_action 10:19:04 INFO - Running main action method: populate_webroot 10:19:04 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:19:04 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:19:04 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:19:04 INFO - '--tppagecycles', 10:19:04 INFO - '7'], 10:19:04 INFO - 'tests': ['tsvgm']}}, 10:19:04 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:19:04 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:19:04 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:19:04 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:19:04 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:19:04 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:19:04 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:04 INFO - 'talos_options': ['--disable-e10s'], 10:19:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:04 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:04 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:19:04 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:04 INFO - 'talos_options': ['--disable-e10s'], 10:19:04 INFO - 'tests': ['damp', 'tps']}, 10:19:04 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:04 INFO - 'tests': ['damp', 'tps']}, 10:19:04 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:19:04 INFO - 'tests': ['dromaeo_dom']}, 10:19:04 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:19:04 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:19:04 INFO - 'tests': ['basic_compositor_video']}, 10:19:04 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:19:04 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:19:04 INFO - 'tests': ['a11yr', 10:19:04 INFO - 'ts_paint', 10:19:04 INFO - 'tpaint', 10:19:04 INFO - 'sessionrestore', 10:19:04 INFO - 'sessionrestore_no_auto_restore', 10:19:04 INFO - 'tabpaint']}, 10:19:04 INFO - 'other-e10s': {'tests': ['a11yr', 10:19:04 INFO - 'ts_paint', 10:19:04 INFO - 'tpaint', 10:19:04 INFO - 'sessionrestore', 10:19:04 INFO - 'sessionrestore_no_auto_restore', 10:19:04 INFO - 'tabpaint']}, 10:19:04 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:19:04 INFO - 'ts_paint', 10:19:04 INFO - 'tpaint', 10:19:04 INFO - 'sessionrestore', 10:19:04 INFO - 'sessionrestore_no_auto_restore', 10:19:04 INFO - 'tabpaint']}, 10:19:04 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:19:04 INFO - 'ts_paint', 10:19:04 INFO - 'tpaint', 10:19:04 INFO - 'sessionrestore', 10:19:04 INFO - 'sessionrestore_no_auto_restore', 10:19:04 INFO - 'tabpaint']}, 10:19:04 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:19:04 INFO - 'tests': ['a11yr', 10:19:04 INFO - 'ts_paint', 10:19:04 INFO - 'tpaint', 10:19:04 INFO - 'sessionrestore', 10:19:04 INFO - 'sessionrestore_no_auto_restore', 10:19:04 INFO - 'tabpaint']}, 10:19:04 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:19:04 INFO - 'tests': ['a11yr', 10:19:04 INFO - 'ts_paint', 10:19:04 INFO - 'tpaint', 10:19:04 INFO - 'sessionrestore', 10:19:04 INFO - 'sessionrestore_no_auto_restore', 10:19:04 INFO - 'tabpaint']}, 10:19:04 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:19:04 INFO - 'tests': ['tsvgx', 10:19:04 INFO - 'tsvgr_opacity', 10:19:04 INFO - 'tart', 10:19:04 INFO - 'tscrollx', 10:19:04 INFO - 'cart']}, 10:19:04 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:19:04 INFO - 'tsvgr_opacity', 10:19:04 INFO - 'tart', 10:19:04 INFO - 'tscrollx', 10:19:04 INFO - 'cart']}, 10:19:04 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:04 INFO - 'talos_options': ['--disable-e10s'], 10:19:04 INFO - 'tests': ['tp5o']}, 10:19:04 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:04 INFO - 'tests': ['tp5o']}, 10:19:04 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:04 INFO - 'talos_options': ['--disable-e10s', 10:19:04 INFO - '--xperf_path', 10:19:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:04 INFO - 'tests': ['tp5n']}, 10:19:04 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:19:04 INFO - 'talos_options': ['--xperf_path', 10:19:04 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:19:04 INFO - 'tests': ['tp5n']}}, 10:19:04 INFO - 'talos.zip': {'path': '', 10:19:04 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:19:04 INFO - Running post-action listener: _resource_record_post_action 10:19:04 INFO - ##### 10:19:04 INFO - ##### Finished populate-webroot step (success) 10:19:04 INFO - ##### 10:19:04 INFO - ##### 10:19:04 INFO - ##### Running create-virtualenv step. 10:19:04 INFO - ##### 10:19:04 INFO - Running pre-action listener: _resource_record_pre_action 10:19:04 INFO - Running main action method: create_virtualenv 10:19:04 INFO - Creating virtualenv /builds/slave/test/build/venv 10:19:04 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 10:19:04 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:19:04 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:19:04 INFO - Using real prefix '/usr' 10:19:04 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:19:04 INFO - Installing distribute.............................................................................................................................................................................................done. 10:19:06 INFO - Installing pip.................done. 10:19:06 INFO - Return code: 0 10:19:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9570>, '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 0x13fa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa900>, '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': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', '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 10:19: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', 'pip>=1.5'] in /builds/slave/test/build 10:19: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 pip>=1.5 10:19:06 INFO - Using env: {'DISPLAY': ':0', 10:19:06 INFO - 'HOME': '/home/cltbld', 10:19:06 INFO - 'LANG': 'en_US.UTF-8', 10:19:06 INFO - 'LANGUAGE': 'en_US:en', 10:19:06 INFO - 'LOGNAME': 'cltbld', 10:19:06 INFO - 'MAIL': '/var/mail/cltbld', 10:19:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:06 INFO - 'MOZ_NO_REMOTE': '1', 10:19:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:06 INFO - 'NO_EM_RESTART': '1', 10:19:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:06 INFO - 'PWD': '/builds/slave/test', 10:19:06 INFO - 'SHELL': '/bin/bash', 10:19:06 INFO - 'SHLVL': '1', 10:19:06 INFO - 'TERM': 'linux', 10:19:06 INFO - 'TMOUT': '86400', 10:19:06 INFO - 'USER': 'cltbld', 10:19:06 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', 10:19:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:06 INFO - '_': '/tools/buildbot/bin/python'} 10:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:07 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 10:19:07 INFO - Cleaning up... 10:19:07 INFO - Return code: 0 10:19:07 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9570>, '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 0x13fa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa900>, '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': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', '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 10:19:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:19:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:19:07 INFO - Using env: {'DISPLAY': ':0', 10:19:07 INFO - 'HOME': '/home/cltbld', 10:19:07 INFO - 'LANG': 'en_US.UTF-8', 10:19:07 INFO - 'LANGUAGE': 'en_US:en', 10:19:07 INFO - 'LOGNAME': 'cltbld', 10:19:07 INFO - 'MAIL': '/var/mail/cltbld', 10:19:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:07 INFO - 'MOZ_NO_REMOTE': '1', 10:19:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:07 INFO - 'NO_EM_RESTART': '1', 10:19:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:07 INFO - 'PWD': '/builds/slave/test', 10:19:07 INFO - 'SHELL': '/bin/bash', 10:19:07 INFO - 'SHLVL': '1', 10:19:07 INFO - 'TERM': 'linux', 10:19:07 INFO - 'TMOUT': '86400', 10:19:07 INFO - 'USER': 'cltbld', 10:19:07 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', 10:19:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:07 INFO - '_': '/tools/buildbot/bin/python'} 10:19:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:07 INFO - Downloading/unpacking psutil>=3.1.1 10:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:19:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:09 INFO - Installing collected packages: psutil 10:19:09 INFO - Running setup.py install for psutil 10:19:09 INFO - building 'psutil._psutil_linux' extension 10:19:09 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 10:19:09 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 10:19:09 INFO - building 'psutil._psutil_posix' extension 10:19:09 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 10:19:09 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 10:19:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:19:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:19:09 INFO - Successfully installed psutil 10:19:09 INFO - Cleaning up... 10:19:09 INFO - Return code: 0 10:19:09 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:19:09 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')]} 10:19:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:09 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')]} 10:19:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:09 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 0x113b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9570>, '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 0x13fa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa900>, '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': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', '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 10:19:09 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 10:19:09 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 10:19:09 INFO - Using env: {'DISPLAY': ':0', 10:19:09 INFO - 'HOME': '/home/cltbld', 10:19:09 INFO - 'LANG': 'en_US.UTF-8', 10:19:09 INFO - 'LANGUAGE': 'en_US:en', 10:19:09 INFO - 'LOGNAME': 'cltbld', 10:19:09 INFO - 'MAIL': '/var/mail/cltbld', 10:19:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:09 INFO - 'MOZ_NO_REMOTE': '1', 10:19:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:09 INFO - 'NO_EM_RESTART': '1', 10:19:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:09 INFO - 'PWD': '/builds/slave/test', 10:19:09 INFO - 'SHELL': '/bin/bash', 10:19:09 INFO - 'SHLVL': '1', 10:19:09 INFO - 'TERM': 'linux', 10:19:09 INFO - 'TMOUT': '86400', 10:19:09 INFO - 'USER': 'cltbld', 10:19:09 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', 10:19:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:09 INFO - '_': '/tools/buildbot/bin/python'} 10:19:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:10 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19: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 10:19:11 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:19:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:19:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:19:11 INFO - Installing collected packages: mozsystemmonitor 10:19:11 INFO - Running setup.py install for mozsystemmonitor 10:19:12 INFO - Successfully installed mozsystemmonitor 10:19:12 INFO - Cleaning up... 10:19:12 INFO - Return code: 0 10:19:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9570>, '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 0x13fa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa900>, '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': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', '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 10:19:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:19:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:19:12 INFO - Using env: {'DISPLAY': ':0', 10:19:12 INFO - 'HOME': '/home/cltbld', 10:19:12 INFO - 'LANG': 'en_US.UTF-8', 10:19:12 INFO - 'LANGUAGE': 'en_US:en', 10:19:12 INFO - 'LOGNAME': 'cltbld', 10:19:12 INFO - 'MAIL': '/var/mail/cltbld', 10:19:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:12 INFO - 'MOZ_NO_REMOTE': '1', 10:19:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:12 INFO - 'NO_EM_RESTART': '1', 10:19:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:12 INFO - 'PWD': '/builds/slave/test', 10:19:12 INFO - 'SHELL': '/bin/bash', 10:19:12 INFO - 'SHLVL': '1', 10:19:12 INFO - 'TERM': 'linux', 10:19:12 INFO - 'TMOUT': '86400', 10:19:12 INFO - 'USER': 'cltbld', 10:19:12 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', 10:19:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:12 INFO - '_': '/tools/buildbot/bin/python'} 10:19:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:12 INFO - Downloading/unpacking jsonschema==2.5.1 10:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:19:14 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:14 INFO - Downloading functools32-3.2.3-2.tar.gz 10:19:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:19:14 INFO - warning: no files found matching '*.txt' 10:19:14 INFO - no previously-included directories found matching 'build' 10:19:14 INFO - no previously-included directories found matching 'dist' 10:19:14 INFO - no previously-included directories found matching '.git*' 10:19:14 INFO - Installing collected packages: jsonschema, functools32 10:19:14 INFO - Running setup.py install for functools32 10:19:14 INFO - warning: no files found matching '*.txt' 10:19:14 INFO - no previously-included directories found matching 'build' 10:19:14 INFO - no previously-included directories found matching 'dist' 10:19:14 INFO - no previously-included directories found matching '.git*' 10:19:14 INFO - Successfully installed jsonschema functools32 10:19:14 INFO - Cleaning up... 10:19:14 INFO - Return code: 0 10:19:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:14 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 0x113b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9570>, '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 0x13fa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa900>, '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': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', '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 10:19:14 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 10:19:14 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 10:19:14 INFO - Using env: {'DISPLAY': ':0', 10:19:14 INFO - 'HOME': '/home/cltbld', 10:19:14 INFO - 'LANG': 'en_US.UTF-8', 10:19:14 INFO - 'LANGUAGE': 'en_US:en', 10:19:14 INFO - 'LOGNAME': 'cltbld', 10:19:14 INFO - 'MAIL': '/var/mail/cltbld', 10:19:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:14 INFO - 'MOZ_NO_REMOTE': '1', 10:19:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:14 INFO - 'NO_EM_RESTART': '1', 10:19:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:14 INFO - 'PWD': '/builds/slave/test', 10:19:14 INFO - 'SHELL': '/bin/bash', 10:19:14 INFO - 'SHLVL': '1', 10:19:14 INFO - 'TERM': 'linux', 10:19:14 INFO - 'TMOUT': '86400', 10:19:14 INFO - 'USER': 'cltbld', 10:19:14 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', 10:19:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:14 INFO - '_': '/tools/buildbot/bin/python'} 10:19:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:14 INFO - Downloading/unpacking blobuploader==1.2.4 10:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:16 INFO - Downloading blobuploader-1.2.4.tar.gz 10:19:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:19:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:16 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 10:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:19:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:19:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:19:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:19:17 INFO - Downloading docopt-0.6.1.tar.gz 10:19:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:19:17 INFO - Installing collected packages: blobuploader, requests, docopt 10:19:17 INFO - Running setup.py install for blobuploader 10:19:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:19:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:19:17 INFO - Running setup.py install for requests 10:19:18 INFO - Running setup.py install for docopt 10:19:18 INFO - Successfully installed blobuploader requests docopt 10:19:18 INFO - Cleaning up... 10:19:18 INFO - Return code: 0 10:19:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9570>, '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 0x13fa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa900>, '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': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', '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 10:19:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:19:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:18 INFO - Using env: {'DISPLAY': ':0', 10:19:18 INFO - 'HOME': '/home/cltbld', 10:19:18 INFO - 'LANG': 'en_US.UTF-8', 10:19:18 INFO - 'LANGUAGE': 'en_US:en', 10:19:18 INFO - 'LOGNAME': 'cltbld', 10:19:18 INFO - 'MAIL': '/var/mail/cltbld', 10:19:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:18 INFO - 'MOZ_NO_REMOTE': '1', 10:19:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:18 INFO - 'NO_EM_RESTART': '1', 10:19:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:18 INFO - 'PWD': '/builds/slave/test', 10:19:18 INFO - 'SHELL': '/bin/bash', 10:19:18 INFO - 'SHLVL': '1', 10:19:18 INFO - 'TERM': 'linux', 10:19:18 INFO - 'TMOUT': '86400', 10:19:18 INFO - 'USER': 'cltbld', 10:19:18 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', 10:19:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:18 INFO - '_': '/tools/buildbot/bin/python'} 10:19:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:18 INFO - Running setup.py (path:/tmp/pip-XnVl7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:18 INFO - Running setup.py (path:/tmp/pip-VaZAJo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:18 INFO - Running setup.py (path:/tmp/pip-mVx6kU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:18 INFO - Running setup.py (path:/tmp/pip-ljjc76-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:18 INFO - Running setup.py (path:/tmp/pip-BNCb9r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:18 INFO - Running setup.py (path:/tmp/pip-tTsrMX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:18 INFO - Running setup.py (path:/tmp/pip-Pnyc0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:18 INFO - Running setup.py (path:/tmp/pip-v8tpiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:19 INFO - Running setup.py (path:/tmp/pip-IBQU7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:19 INFO - Running setup.py (path:/tmp/pip-OFadlg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:19 INFO - Running setup.py (path:/tmp/pip-v1ZJiT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:19 INFO - Running setup.py (path:/tmp/pip-0DOdmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:19 INFO - Running setup.py (path:/tmp/pip-MdVJV3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:19 INFO - Running setup.py (path:/tmp/pip-MkA0LU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:19 INFO - Running setup.py (path:/tmp/pip-d0rNua-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:19 INFO - Running setup.py (path:/tmp/pip-zIi2iW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:19 INFO - Running setup.py (path:/tmp/pip-W4lqgP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:19 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:19:19 INFO - Running setup.py install for manifestparser 10:19:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:19:19 INFO - Running setup.py install for mozcrash 10:19:19 INFO - Running setup.py install for mozdebug 10:19:20 INFO - Running setup.py install for mozdevice 10:19:20 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Running setup.py install for mozfile 10:19:20 INFO - Running setup.py install for mozhttpd 10:19:20 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Running setup.py install for mozinfo 10:19:20 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Running setup.py install for mozInstall 10:19:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Running setup.py install for mozleak 10:19:20 INFO - Running setup.py install for mozlog 10:19:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Running setup.py install for moznetwork 10:19:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:19:20 INFO - Running setup.py install for mozprocess 10:19:20 INFO - Running setup.py install for mozprofile 10:19:21 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozrunner 10:19:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Running setup.py install for mozscreenshot 10:19:21 INFO - Running setup.py install for moztest 10:19:21 INFO - Running setup.py install for mozversion 10:19:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:19:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:19:21 INFO - Cleaning up... 10:19:21 INFO - Return code: 0 10:19:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19: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')]} 10:19:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19: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')]} 10:19:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9570>, '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 0x13fa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa900>, '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': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', '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 10:19:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 10:19:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:21 INFO - Using env: {'DISPLAY': ':0', 10:19:21 INFO - 'HOME': '/home/cltbld', 10:19:21 INFO - 'LANG': 'en_US.UTF-8', 10:19:21 INFO - 'LANGUAGE': 'en_US:en', 10:19:21 INFO - 'LOGNAME': 'cltbld', 10:19:21 INFO - 'MAIL': '/var/mail/cltbld', 10:19:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:21 INFO - 'MOZ_NO_REMOTE': '1', 10:19:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:21 INFO - 'NO_EM_RESTART': '1', 10:19:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:21 INFO - 'PWD': '/builds/slave/test', 10:19:21 INFO - 'SHELL': '/bin/bash', 10:19:21 INFO - 'SHLVL': '1', 10:19:21 INFO - 'TERM': 'linux', 10:19:21 INFO - 'TMOUT': '86400', 10:19:21 INFO - 'USER': 'cltbld', 10:19:21 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', 10:19:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:21 INFO - '_': '/tools/buildbot/bin/python'} 10:19:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:19:21 INFO - Running setup.py (path:/tmp/pip-CjHaMs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:19:21 INFO - Running setup.py (path:/tmp/pip-f7p0tI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:19:21 INFO - Running setup.py (path:/tmp/pip-UCKgbE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:19:21 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)) 10:19:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:19:21 INFO - Running setup.py (path:/tmp/pip-Tnpcs9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:19:22 INFO - Running setup.py (path:/tmp/pip-CQsUKe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:19:22 INFO - Running setup.py (path:/tmp/pip-wm4rnu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:19:22 INFO - Running setup.py (path:/tmp/pip-KWS33P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:19:22 INFO - Running setup.py (path:/tmp/pip-AWBpnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:19:22 INFO - Running setup.py (path:/tmp/pip-IghdAN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:19:22 INFO - Running setup.py (path:/tmp/pip-Iq_d7_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.2 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:19:22 INFO - Running setup.py (path:/tmp/pip-6fVaOR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:19:22 INFO - Running setup.py (path:/tmp/pip-PsNeE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:19:22 INFO - Running setup.py (path:/tmp/pip-CQDgcg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:19:22 INFO - Running setup.py (path:/tmp/pip-fPJMGe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:19:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:22 INFO - Running setup.py (path:/tmp/pip-lHSUjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:19:22 INFO - Running setup.py (path:/tmp/pip-HWEjQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:19:22 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)) 10:19:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:19:22 INFO - Running setup.py (path:/tmp/pip-j24xku-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:19:22 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)) 10:19:22 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)) 10:19:22 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)) 10:19:22 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)) 10:19:22 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)) 10:19:22 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)) 10:19:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:19:22 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 10:19:22 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 10:19:22 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 10:19:22 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 10:19:22 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 10:19:22 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 10:19:24 INFO - Downloading blessings-1.6.tar.gz 10:19:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:19:24 INFO - Installing collected packages: blessings 10:19:24 INFO - Running setup.py install for blessings 10:19:25 INFO - Successfully installed blessings 10:19:25 INFO - Cleaning up... 10:19:25 INFO - Return code: 0 10:19:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:25 INFO - Reading from file tmpfile_stdout 10:19:25 INFO - Current package versions: 10:19:25 INFO - argparse == 1.2.1 10:19:25 INFO - blessings == 1.6 10:19:25 INFO - blobuploader == 1.2.4 10:19:25 INFO - docopt == 0.6.1 10:19:25 INFO - functools32 == 3.2.3-2 10:19:25 INFO - jsonschema == 2.5.1 10:19:25 INFO - manifestparser == 1.1 10:19:25 INFO - mozInstall == 1.12 10:19:25 INFO - mozcrash == 0.17 10:19:25 INFO - mozdebug == 0.1 10:19:25 INFO - mozdevice == 0.48 10:19:25 INFO - mozfile == 1.2 10:19:25 INFO - mozhttpd == 0.7 10:19:25 INFO - mozinfo == 0.9 10:19:25 INFO - mozleak == 0.1 10:19:25 INFO - mozlog == 3.2 10:19:25 INFO - moznetwork == 0.27 10:19:25 INFO - mozprocess == 0.23 10:19:25 INFO - mozprofile == 0.28 10:19:25 INFO - mozrunner == 6.12 10:19:25 INFO - mozscreenshot == 0.1 10:19:25 INFO - mozsystemmonitor == 0.3 10:19:25 INFO - moztest == 0.7 10:19:25 INFO - mozversion == 1.4 10:19:25 INFO - psutil == 3.1.1 10:19:25 INFO - requests == 1.2.3 10:19:25 INFO - wsgiref == 0.1.2 10:19:25 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9570>, '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 0x13fa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa900>, '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': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', '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 10:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 10:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 10:19:25 INFO - Using env: {'DISPLAY': ':0', 10:19:25 INFO - 'HOME': '/home/cltbld', 10:19:25 INFO - 'LANG': 'en_US.UTF-8', 10:19:25 INFO - 'LANGUAGE': 'en_US:en', 10:19:25 INFO - 'LOGNAME': 'cltbld', 10:19:25 INFO - 'MAIL': '/var/mail/cltbld', 10:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:25 INFO - 'MOZ_NO_REMOTE': '1', 10:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:25 INFO - 'NO_EM_RESTART': '1', 10:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:25 INFO - 'PWD': '/builds/slave/test', 10:19:25 INFO - 'SHELL': '/bin/bash', 10:19:25 INFO - 'SHLVL': '1', 10:19:25 INFO - 'TERM': 'linux', 10:19:25 INFO - 'TMOUT': '86400', 10:19:25 INFO - 'USER': 'cltbld', 10:19:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', 10:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:25 INFO - '_': '/tools/buildbot/bin/python'} 10:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 10:19:25 INFO - Cleaning up... 10:19:25 INFO - Return code: 0 10:19:25 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:25 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:19:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:19:25 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x113b030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x129e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x136a400>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9570>, '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 0x13fa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa900>, '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': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', '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 10:19:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 10:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 10:19:25 INFO - Using env: {'DISPLAY': ':0', 10:19:25 INFO - 'HOME': '/home/cltbld', 10:19:25 INFO - 'LANG': 'en_US.UTF-8', 10:19:25 INFO - 'LANGUAGE': 'en_US:en', 10:19:25 INFO - 'LOGNAME': 'cltbld', 10:19:25 INFO - 'MAIL': '/var/mail/cltbld', 10:19:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:25 INFO - 'MOZ_NO_REMOTE': '1', 10:19:25 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:25 INFO - 'NO_EM_RESTART': '1', 10:19:25 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:25 INFO - 'PWD': '/builds/slave/test', 10:19:25 INFO - 'SHELL': '/bin/bash', 10:19:25 INFO - 'SHLVL': '1', 10:19:25 INFO - 'TERM': 'linux', 10:19:25 INFO - 'TMOUT': '86400', 10:19:25 INFO - 'USER': 'cltbld', 10:19:25 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', 10:19:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:25 INFO - '_': '/tools/buildbot/bin/python'} 10:19:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:19:25 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:19:25 INFO - Cleaning up... 10:19:25 INFO - Return code: 0 10:19:25 INFO - Running post-action listener: _resource_record_post_action 10:19:25 INFO - Running post-action listener: _start_resource_monitoring 10:19:25 INFO - Starting resource monitoring. 10:19:25 INFO - ##### 10:19:25 INFO - ##### Finished create-virtualenv step (success) 10:19:25 INFO - ##### 10:19:25 INFO - ##### 10:19:25 INFO - ##### Running install step. 10:19:25 INFO - ##### 10:19:25 INFO - Running pre-action listener: _resource_record_pre_action 10:19:25 INFO - Running main action method: install 10:19:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:19:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:19:26 INFO - Reading from file tmpfile_stdout 10:19:26 INFO - Detecting whether we're running mozinstall >=1.0... 10:19:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:19:26 INFO - Reading from file tmpfile_stdout 10:19:26 INFO - Output received: 10:19:26 INFO - Usage: mozinstall [options] installer 10:19:26 INFO - Options: 10:19:26 INFO - -h, --help show this help message and exit 10:19:26 INFO - -d DEST, --destination=DEST 10:19:26 INFO - Directory to install application into. [default: 10:19:26 INFO - "/builds/slave/test"] 10:19:26 INFO - --app=APP Application being installed. [default: firefox] 10:19:26 INFO - mkdir: /builds/slave/test/build/application 10:19:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 10:19:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 10:19:42 INFO - Reading from file tmpfile_stdout 10:19:42 INFO - Output received: 10:19:42 INFO - /builds/slave/test/build/application/firefox/firefox 10:19:42 INFO - Running post-action listener: _resource_record_post_action 10:19:42 INFO - ##### 10:19:42 INFO - ##### Finished install step (success) 10:19:42 INFO - ##### 10:19:42 INFO - ##### 10:19:42 INFO - ##### Running run-tests step. 10:19:42 INFO - ##### 10:19:42 INFO - Running pre-action listener: _resource_record_pre_action 10:19:42 INFO - Running main action method: run_tests 10:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:19:42 INFO - Python 2.7.3 10:19:42 INFO - Return code: 0 10:19:42 INFO - grabbing minidump binary from tooltool 10:19:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:19:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13f9570>, '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 0x13fa470>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x13fa900>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:19:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 10:19:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 10:19:42 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 10:19:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:19:42 INFO - Return code: 0 10:19:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:19:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:19:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:19:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:19:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:19:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 10:19:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --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 10:19:42 INFO - Using env: {'DISPLAY': ':0', 10:19:42 INFO - 'HOME': '/home/cltbld', 10:19:42 INFO - 'LANG': 'en_US.UTF-8', 10:19:42 INFO - 'LANGUAGE': 'en_US:en', 10:19:42 INFO - 'LOGNAME': 'cltbld', 10:19:42 INFO - 'MAIL': '/var/mail/cltbld', 10:19:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:19:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:19:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:19:42 INFO - 'MOZ_NO_REMOTE': '1', 10:19:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:19:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:19:42 INFO - 'NO_EM_RESTART': '1', 10:19:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:19:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:19:42 INFO - 'PWD': '/builds/slave/test', 10:19:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:19:42 INFO - 'SHELL': '/bin/bash', 10:19:42 INFO - 'SHLVL': '1', 10:19:42 INFO - 'TERM': 'linux', 10:19:42 INFO - 'TMOUT': '86400', 10:19:42 INFO - 'USER': 'cltbld', 10:19:42 INFO - 'XDG_SESSION_COOKIE': '4300f881736b422476174874000001bc-1467911931.529568-1934334358', 10:19:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:19:42 INFO - '_': '/tools/buildbot/bin/python'} 10:19:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--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 10:19:42 INFO - mozversion application_buildid: 20160707084422 10:19:42 INFO - mozversion application_changeset: 5eee8c97b40876ba9b529d70bd6ccec249fc5dce 10:19:42 INFO - mozversion application_display_name: Nightly 10:19:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:19:42 INFO - mozversion application_name: Firefox 10:19:42 INFO - mozversion application_remotingname: firefox 10:19:42 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 10:19:42 INFO - mozversion application_vendor: Mozilla 10:19:42 INFO - mozversion application_version: 50.0a1 10:19:42 INFO - mozversion platform_buildid: 20160707084422 10:19:42 INFO - mozversion platform_changeset: 5eee8c97b40876ba9b529d70bd6ccec249fc5dce 10:19:42 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 10:19:42 INFO - mozversion platform_version: 50.0a1 10:19:42 INFO - using testdate: 1467911982 10:19:42 INFO - actual date: 1467911982 10:19:42 INFO - starting webserver on 'localhost:45809' 10:19:42 INFO - SUITE-START | Running 2 tests 10:19:42 INFO - TEST-START | dromaeo_css 10:19:42 INFO - operating with platform_type : linux_ 10:19:42 INFO - Initialising browser for dromaeo_css test... 10:19:42 INFO - TEST-INFO | started process 15461 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTIqbj2/profile http://localhost:45809/getInfo.html) 10:19:48 INFO - PROCESS | 15461 | __metrics Screen width/height:1600/1200 10:19:48 INFO - PROCESS | 15461 | colorDepth:24 10:19:48 INFO - PROCESS | 15461 | Browser inner width/height: 1024/697 10:19:48 INFO - PROCESS | 15461 | __metrics 10:19:48 ERROR - PROCESS | 15461 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 10:19:49 INFO - TEST-INFO | 15461: exit 0 10:19:49 INFO - Browser initialized. 10:19:49 INFO - Running cycle 1/1 for dromaeo_css test... 10:19:49 INFO - TEST-INFO | started process 15580 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTIqbj2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:20:01 INFO - PROCESS | 15580 | RSS: Main: 168710144 10:20:01 INFO - PROCESS | 15580 | 10:20:51 INFO - PROCESS | 15580 | 1467912051097 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] 10:23:03 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:45809/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45809/tests/dromaeo/cssquery-ext.html) 10:23:04 INFO - PROCESS | 15580 | RSS: Main: 171016192 10:23:04 INFO - PROCESS | 15580 | 10:26:06 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:45809/tests/dromaeo/cssquery-ext.html (next: http://localhost:45809/tests/dromaeo/cssquery-jquery.html) 10:26:07 INFO - PROCESS | 15580 | RSS: Main: 168542208 10:26:07 INFO - PROCESS | 15580 | 10:29:09 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:45809/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45809/tests/dromaeo/cssquery-mootools.html) 10:29:10 INFO - PROCESS | 15580 | RSS: Main: 171081728 10:29:10 INFO - PROCESS | 15580 | 10:32:12 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:45809/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45809/tests/dromaeo/cssquery-prototype.html) 10:32:12 INFO - PROCESS | 15580 | RSS: Main: 166629376 10:32:12 INFO - PROCESS | 15580 | 10:35:15 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:45809/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45809/tests/dromaeo/cssquery-yui.html) 10:35:16 INFO - PROCESS | 15580 | RSS: Main: 168325120 10:35:16 INFO - PROCESS | 15580 | 10:38:18 INFO - PROCESS | 15580 | Cycle 1(1): loaded http://localhost:45809/tests/dromaeo/cssquery-yui.html (next: http://localhost:45809/tests/dromaeo/cssquery-dojo.html) 10:38:19 INFO - PROCESS | 15580 | RSS: Main: 169984000 10:38:19 INFO - PROCESS | 15580 | 10:38:19 INFO - PROCESS | 15580 | __start_tp_report 10:38:19 INFO - PROCESS | 15580 | _x_x_mozilla_page_load 10:38:19 INFO - PROCESS | 15580 | _x_x_mozilla_page_load_details 10:38:19 INFO - PROCESS | 15580 | |i|pagename|runs| 10:38:19 INFO - PROCESS | 15580 | |0;dojo.html;2590.5596048671723;2634.301909993852;2635.9209223723283;2636.1037247335903;2639.630451736757;4674.766261686915;4677.22825733754;4714.811407543699;4777.52224777522;4824.2040063389495;4664.090502352043;4733.455652599952;4738.407699037621;4753.738544380058;4795.256735206049;4318.654507639381;4364.192624364487;4433.623142032931;4445.799939002736;4459.219636563605;4152.813123409439;4445.177642136199;4455.1089782043555;4491.191585514606;4492.640588752892;4265.317549192146;4269.978650106729;4288.871333859989;4366.716163449366;4424.358468022118;4340.52254252032;4345.087531618364;4354.259775838083;4362.062156636339;4401.5598440156045;4377.868663940087;4380.561943805626;4382.868513944587;4397.626201772853;4436.822527098912;4783.928241076386;4802.543758342952;4809.567138957511;4841.298011788306;4844.975775121102;5116.923246151311;5125.179971204627;5133.460986596391;5135.152699804527;5163.199704045879;5065.746712664389;5141.537261646432;5164.45773193813;5175.45657705943;5191.844244672666;4723.716577005391;4764.928526072112;4766.713997160182;4766.856994290177;4817.879553011167;5232.73836308183;5237.580993520509;5241.711705856214;5245;5261.158214685632;5003.899922001539;5013.047520971004;5019.67372120811;5026.969471258383;5039.748012599355;5075.416327122354;5125.205593133071;5138.152204886227;5146.552364906746;5147.279380886679;4866.732329721899;4915.090708218991;4920.704757714477;4974.701517908937;4983.127952608279;4975.0796102721115;4978.427480839678;5050.419201791768;5068.974655126701;5071.695698258116;4158.2307273154565;4191.601797829201;4273.700840941105;4301.505326887385;4319.33050377192;3715.9628403716156;3738.1776009277914;3741.56971948224;3773.0755964788254;3776.9244615108096;4340.110277393127;4342.478902531653;4361.956380436219;4369.934450983238;4391.4730232371685;4969.875753106129;5100;5137.2037334213255;5143.562797162208;5147.099257629975;4375.890602734957;4377.562243775597;4399.538048504861;4414.293713005968;4418.911621767611;4549.454065512094;4566.360709500673;4585.862424127282;4598.080383923162;4662.673612847136;4657.534246575316;4704.435467743892;4714.481407045291;4763.642726795573;4797.592204662573;5123.923141152811;5126.512981266774;5135.281060651587;5141.460146684544;5186.844394668166;4755.476897541199;4765.76171191446;4768.165571025126;4768.904621907612;4830.66185367035;4941.728204948762;5000.699958002531;5048.5203905628905;5066.72133032672;5066.721330326867;5129.974350128375;5158.587313014875;5166.974165129151;5172.069027574922;5210.296609957607;4846.39420072491;4995.62532810048;4997.800087996585;4999.550040496373;5011.949880501148;4843.588294994824;4888.0468308679465;4920.852374428773;4961.429435614806;4978.054169707744;4876.146674332049;4891.877703057452;4902.754862256802;4903.754812259302;4985.626078044089;5024.246363045572;5024.497550244946;5024.547790698854;5025.924611130763;5036.043151801146;4801.135795556834;4853.684510506947;4900.044491324157;4920.138975679313;4932.580730637936 10:38:19 INFO - PROCESS | 15580 | |1;ext.html;550.0868558193399;550.7328945461453;553.606939073258;559.7201399300351;590.2179612014082;35534.644653553456;39481.21037579246;39489.21021579567;39711.80144099283;39733.60266397335;39547.802260988654;39553.802230988804;39882.8005859971;39998.40002399966;40198.19603607926;7699.538027718327;7834.960825195894;7835.608219589027;7841.176676448977;7866.134725180225;7718.305352518272;7816.140224575292;7834.960825195866;7873.330766884793;7895.8815617765495;7860.646270917794;7895.8420831583335;7907.723229686962;7909.683612655487;7925.524468531907;7787.377009839256;7829.491083079582;7839.764807055797;7848.921510784905;7863.8034049148655;7715.922840771633;7719.073711154698;7732.729354472566;7750.224977502261;7751.147373788879;38218.23563528742;38694.61305386938;38712.225755485015;38727;38832.805835970925;2951.144168191222;2998.250437390652;3077.723004929567;3095.520194369876;3158.3051728619666;29795.10614681563;30248.395032099455;30690.53964190539;30870.691293087006;30923.69076309253;3081.691830816923;3085.4754691702465;3131.6398614159434;3147.559341692142;3216.404965081444;186514;186580;186782;186956;187219;52987;52997.735011324694;53135.73432132892;53307.20039199415;53314.466855331724;33145.50281745776;34313.313733725685;34414.31171376609;55093.173602396;55228;15070.698586028218;15197.544073677807;15210;15241.923790380977;15251.542453726406;10730.839037414446;10792.082672972729;10804.1896857736;10816.351018938889;10824.296420732628;18509;18532.629347413247;18542.351017714314;18567.628647426976;18709.158087886077;6754.763583274562;6936.20233673134;7005.824854378681;7027.929720702829;7085;789.9249571290718;855.6406309349964;911.3939230411835;912.6212621762027;992.7518120469882;27901;28590.285242869093;28702.71297287042;29272.121836344944;29369.706302937124;999.3204620857887;1004.4877112672443;1005.3214080495636;1015.6851376073294;1031.7317497450567;15187.772183417257;15292.694146117015;15435.922820386051;15580.610484737972;15755.763663545056;342902;421114;431521;431664;641324;51115;51457.48542514527;51784.785825701154;51806.74096629493;51900.74049629728;1186.163754553038;1189.9524019039316;1192.48723049088;1197.6766273106211;1207.5230284037932;28063.298417539725;29758.172973567478;30131.849340753157;30454.543181852732;30523.236919076313;44105.33841992437;44394.77802610966;44713.32930005987;44897.10205795801;44935;344327;344393;345367;346577;347275;25572.232833015038;26328.868355658098;26704.732952671002;26724.331891702863;26769;41991.7900410496;42235.78882105693;42333.5766642342;43730.56269437392;43846.56153438425;36331;37631.62368376281;37998.24003519969;38091.61908380881;38378.808105959295;36830;37348.81325593355;37356.81321593375;37773.62226377811;38004;36195.095122622144;37150.81424592968;38121;38278.80860595791;40336.79831600823;31578.210544736565;34356;34702.30595388028;34767.4784878222;34951.82524087363;26140.92771006143;26148.477030459664;26304;26537;26622.733772662024 10:38:19 INFO - PROCESS | 15580 | |2;jquery.html;367.40663827917905;367.5589292848582;371.1500663480629;378.3605706356258;382.5371300726121;16187;16578.253978570963;17802.643947121065;17836.286548538075;17855.107244637747;16324.510264692048;16509.09199994;17102.144892755343;17354;17376.82623173768;4964.726940018307;5148.150555158394;5162.1224391853475;5163.483651634844;5173.793048278064;5033.723145227011;5101.591872650179;5128.974355128219;5131.230315452674;5132.23016547519;4956.851294461154;5063.063333283354;5069.087564238435;5080;5103.770330335144;5013.724245166514;5042.697438153704;5076.03555324489;5078.289039534468;5118.129917913963;4537.228671125917;4551.067031258584;4551.226291530448;4569.725816451024;4573.519780423074;20195.697064543896;20291.188352465884;20400.28598999028;20860.26989055391;20983.895080524653;1883.6138591588692;1963.2049020146862;1985.9205631774712;2252.40311317501;2268.8995837019033;12348.75302493954;12883.162594431333;12964.157329773629;13025.609231723063;13394.933025334909;1638.1072315587915;1715.485354393677;1748.8251174882537;1795.6678014567347;1801.3605170164665;45731.5426845734;58784.99999999957;60887.391126088616;67366;70238.29761702368;9206.401583897024;9218.124278193562;9598.616055357708;9784.608615655436;9816.411015339103;13093.607191784262;13137.080404371602;13180;13207.207567545978;13267.203967761965;7294.27057294277;7404.333609975128;7539.736109236151;7554.622268886534;7686.769396918102;7338.633068346561;7355.852882942419;7390.5196162249285;7451.1431185413285;7470.991416158858;5926.970365148147;5992.191054207713;6112.327643959161;6122.938770612237;6206.844828879314;1726.464795913271;1769.5222289981891;1804.756357891694;1807.403556826244;1828.1955939386628;900.5677274907949;939.793245485992;942.8962814090445;942.9434233945985;953.1469334945185;17060.31758729637;17411.390601328894;17483.65032699339;17576.648467030587;17834.37579684705;808.6441965535146;855.8202777416813;895.1451363947415;901.5312037740339;952.9083661363379;9235.953820230856;9323.953380233055;9426.481543515036;9490.572924218288;9649.083337082966;351415;353527;354424;356140;374215.2947101267;57366.139507907414;79068.60465697749;80749;83746.58126709328;84749;936.2229349639919;942.6182396129578;952.2001518724443;974.4445665970329;975.2831668723483;14036.947228958074;14078.507252246121;15488.84511154874;15615.891854599939;16090.195490225677;37145.25709485849;37533.06167345838;39314.606853931095;39551.40672889967;41809.37285940774;54479.18281225706;56559.15161272502;57442;57646.42353576578;57816.710916446835;6844.623545704835;6898.689558969959;7118.683043636944;7179.389751871149;7233.132024157135;9048.276137909083;9938.602455901682;10027.849582256418;10158.593656253963;10270.6405275815;9172.587233574372;9312.394694344846;9314.161725444743;9341.532923353669;9493.525323733647;8967.417117887317;8975.147361000694;9239.676611318571;9303.534823258675;9509.096635819586;9246.352755307063;9304.209142222717;9437.716868493957;9479.146876781122;9571.664991725256;6853.760118395832;6999.440044796506;7022.473314501331;7125.216226215009;7139.250378710369;7810.648520816463;9290.16388525036;9333.626654933727;9438.480883551196;9588.232941364813 10:38:19 INFO - PROCESS | 15580 | |3;mootools.html;1374.5463996881026;1410;1521.216573464665;1684.6799108169455;1709.2821015173627;6689.8996515052195;7517.323440890319;7559.206283340252;8043.075046369662;8075.232852878982;7633;7846.529208247509;7871.134175240719;7888.290053895148;7891.960540197291;2207.1171531387495;2249.0441562336023;2250.1449449209276;2250.167438047916;2254.1546919905036;2196.2752291743686;2200.6919031335624;2227.354067320475;2249.055396733376;2250.504888924434;2162.643163877958;2180.2260197629853;2180.9890950545223;2224.822014238857;2242.6523888797183;2200.4168895242774;2211.5245222277126;2220.311703371952;2227.8440509164366;2233.0732745910427;2174.184680744721;2174.64118420462;2178.0743184146672;2194.221051526701;2198.1537108213292;7987.960060199662;7989.121196668362;8021.478603890729;8040.316573091294;8054.43618946674;4529.2526733089;4642.234031384817;4668.813247470097;4676.181668208084;4680.602148817321;2774.3618967637353;2935.8678859451375;2943.043510858958;2957.4085182963495;2971.5988341573825;822.8148666550038;843.7468759372164;857.8884744983112;867.3668222197831;871.1027641529236;10638.893611063868;10684.25210235276;10691.144708423386;10702.732431689192;10743.785124297548;4138.6482149017065;4207.6633869291;4295.140971805651;4335.761533115646;4337.891552711208;9120;9169.679061232824;9177.90822091784;9181.35730498872;9215;4778.617710583145;4793.281007848781;4796.712197268175;4801.855944321676;4820.39745031871;3595.478655594924;4199.68502362324;4362.650987920959;4370.2352088384405;4395.978020109879;3657.396529572644;3693.5013773140818;3732.496113024761;3759.248150369937;3819.6753275971296;1196.7247533067268;1233.6237447578396;1241.3793103448277;1241.4289426863563;1243.9129260951647;682.4165338635495;803.2730379007008;819.2954059508818;842.3850589070013;842.9789255268668;5063.746812659426;5263.421023687391;5264.657797243243;5358.705271210121;5409.43200963901;418.16367265469063;421.652136986987;425.4957874918232;426.83353492138093;429.03253164115347;3427.246005878703;3452.7755695879687;3502.9824850875584;3512.455569386749;3520.119970007498;9410.858837117448;9651.131398174199;9692.46691431978;9746.415215087118;9822.705318840446;9098.681546145854;9544.42733435996;9643.517824108767;9662.661806836726;9757.707268781947;7279.745208917769;7395.445341599401;7475.140358858801;7519.887201691979;7522.398208143335;5163.199704045879;5366.3560372753955;5509.449055094458;5511.476409741068;5529.142982837667;8576.571171441277;8882.511461869659;9032.729018129467;9064.365494415328;9130.132637399436;8924.68763593271;9203.76990575241;9349.719508414759;9359.15767580921;9363.625454981724;5668.858278543069;6463.256725476443;6670.7665231716655;6854.691538880663;6969.651517424007;7509.9249007509225;7516.736914207976;7525.88711169322;7536.208698086842;7575.962120189364;6468;6700.162479690039;6722.19333679942;6750.1562304711915;6776.966115169393;6674.43267322283;6726.39462448382;6812.182538095461;6842.144731908512;6902.275261097512;5724.198612194379;5782.508486778671;5789.131630255495;5855.648661080349;5866.266716660418;4562.8018005052345;4593.977030114828;4671.532846715301;4697.412823397075;4700.905981880412;4321.978390108029;4487.977560112178;4540.818367265405;4584.977075114603;4600.677952543289 10:38:19 INFO - PROCESS | 15580 | |4;prototype.html;290.40901764908415;301.3265351938418;305.38312608530754;306.92480342316134;308.3770783018303;4876.658633895629;4944.629152813535;4999.200127979524;5084.415292241389;5116.692998420097;4986.900261994758;5003.374578177728;5019.523145301199;5041.890784027508;5050.772715227814;3960.6831453483796;3961.8217180226957;3972.3048466518244;3984.780837053961;3984.9203015939665;3865.724310977371;3929.44987701722;3939.72421930465;3966.821493032806;3982.064214909494;3890.8054597270025;3910.1984093260958;3922.8234729437245;3929.390944403622;3931.9213615727667;3904.12157264616;3905.7656540607654;3915.686745060388;3916.725829191958;3933.3509970854775;3300.966990330114;3420.811855347955;3424.8972530824117;3435.381631306364;3439.6216416194197;5000.2749601307605;5005.374328208974;5014.724190169539;5018.422881368653;5028.170351891933;4477.977610111961;4506.932396014063;4508.391367165424;4522.819087236539;4548.565832796251;4977.875553111165;5289.973550132263;5323.361196656388;5344.14493681013;5344.91982620261;3681.7054635629083;3693.8522459101605;3702.685271751904;3708.554973403209;3715.609860964587;5506.834794956158;5541.002619528484;5542.778288868481;5546.223528705985;5568.777248910039;3610.5306310180035;3779.281936432124;3819;3819.1788765415567;3819.312523745697;3865.7873816939777;3882.4176373544196;3886.9805650971566;3899.629535194152;3903.746256493319;4428.158649856581;4455.1535208310315;4463.553644635511;4472.8210871565425;4496.426250812189;5158.926626398683;5360.785568577213;5365.946340536622;5367.329083864517;5380.596455265871;1329.6144118205611;1353.35715535122;1354.1739538881275;1355.735631551838;1356.7625665508497;818.8935438392971;836.7991681996277;842.1536355962219;868.3877866104381;874.0822136756381;4075.735077219971;4106.938395924063;4109.773962432035;4110.835566577363;4135.875923722293;4848.660593758474;4853.4468969929985;4860.975695121572;4861.538153875376;4879.243717223836;4048.7570745755347;4074.348104303297;4079.8164082616354;4116.58834116592;4129.587041295907;2494.663220465214;2498.523331364435;2589.2491177558295;2593.6628238328894;2595.8053146014126;4482.305242687388;4485.46174459067;4504.117364886475;4507.57178068083;4508.887277818081;4884.267359895973;4934.8766280843265;4956.926705442576;4963.255511673278;4968.925466118011;4523.050159466483;4734.621230301567;5057.595392368528;5084.1102807009365;5108.2848401223855;5471.151971444432;5480.561555075664;5490.176473529003;5503.9174412383045;5520.309961254843;5222.4671034547455;5341.305630268041;5361.249425080414;5376.892462150813;5412.78348866041;5009.749512524287;5033.924491132562;5084.720340381315;5095.617828662939;5115.232715092766;3590.1742599202853;3638.326909521747;3731.552213734369;3748.100455890621;3805.8097095145686;5460.071787796005;5507.953488837108;5518.2826232589505;5519.530839878656;5529.30883639545;5281.498257665516;5304.336957880265;5330.520253177233;5335.413104558418;5360.973195133999;5152.4847515248175;5269.868253293698;5287.9471205287455;5296.232046353334;5309.123994541012;5179.171332586768;5193.506616871391;5200.713960732196;5211.1922651989;5243.764030618555;5040.697558146523;5254.894902102013;5262.342362156061;5271.71005594696;5289.391719952101;5189.558887494454;5195.68825870449;5211.739413029258;5218.130028484243;5262 10:38:19 INFO - PROCESS | 15580 | |5;yui.html;660.3033799341694;671.1778071861967;697.1111832413669;740.3484933258732;773.3349319585158;11731.530738770449;12644.557440489585;12731.872681273184;12733;13971.79042314366;14584.635384115403;15213.163276019815;15287.082775033477;15295.15876626785;15324.310406031727;621.2606997672755;769.6228847864534;788.1369899959535;795.5306369242146;795.7095660084057;758.5865703191746;784.6586734770393;785.4423359414823;786.0724345272577;787.8345547435046;824.8061705499202;828.2587084559316;829.7096016394244;830.489249111795;832.4755404095441;825.9256666900008;826.0005393473933;826.8098337382405;828.6436832162168;828.7099515169702;603.6559161278074;603.8792241551707;604.0245004318039;604.1873679900526;605.7576969212306;14029.64925876851;14063;14068.507602233873;14093.929530352385;14095.50665726705;13456.125351852099;13527.797083043763;13690.178589284675;13717.862821371858;13764.793528096987;9911.950440247752;10120;10200.3369780964;10246.333988290737;10285.79428411435;3245.578074850278;3291.703746662788;3309.7683162178655;3317.1872891141584;3317.3696997570382;60913.695431523;61433.385666143215;61827.38172618261;62464.37535624631;62498;9651.227901767841;9941.552630131517;10126.645567405105;10199.490025498695;10268.691939241835;15871.841281587267;18073.63852722938;18080.457586272434;18149.092545372943;18179;6933.341332573498;7024.2273349931465;7097.290270972861;7099.07711997437;7102;3730.0488375464083;3747.2130852521277;3847.9038024049623;3896.298666240047;3923.941140882889;2995.5356919677483;3091.072678196577;3105.3789242151206;3106.5650808886776;3109.766767492402;533.8505218538737;537.9220013098079;538.2222688215569;541.0585581088877;549.1789774287466;498.35463075316824;583.3146053387253;588.2705445247861;603.101378945377;615.2432508015077;8622.568871556397;8865.140506650614;8908.599113039929;8950.731478055668;9169.220616247694;583.3583058635467;594.9315828679671;617.6818938246806;618.1191801682585;642.7653906324158;4019.5176578810147;4196.454460920061;4211.789410529461;4220.11377610699;4374.978125109354;79042.6047869757;81163;82342.17657823465;93135.53432232795;104369.47815261027;80456;82877;83029.16970830335;83223.16776832154;83406;73648.63175684195;75016;76215.23784762081;76339;76715.61642191642;8586.91413085886;8963.731088067369;9093.665048181887;9164;9381.671641492516;41100;43499.56500434955;44424.555754442044;44733;46154;55336.72331638316;55904;59251.40748592459;62223;63771.04343434759;11431.428428578703;11785.351805650771;12020.459079341626;12083.214591051554;12090.576829810914;13479.730405392034;13737.175769453865;13795.862041379458;14053.578392648236;14662.853371466148;11754.353510557;12113.69715757113;12273.509059637514;12382.938085309515;12437;12676.176048556814;12829;12829.93585032069;12844.935775321064;12855.1001429899;11232.719182020515;11403.429828508708;11413;11637;11851.822222666839;10598.735031624272;10974.615888443866;10999.34003959765;11014.44927753625;11098.667039988813;10107.191424686154;10275.383476991405;10325.253987668864;10411.796439489191;10429.374237545771 10:38:19 INFO - PROCESS | 15580 | __end_tp_report 10:38:19 INFO - PROCESS | 15580 | __start_cc_report 10:38:19 INFO - PROCESS | 15580 | _x_x_mozilla_cycle_collect,397 10:38:19 INFO - PROCESS | 15580 | __end_cc_report 10:38:19 INFO - PROCESS | 15580 | __startTimestamp1467913099034__endTimestamp 10:38:19 INFO - PROCESS | 15580 | 10:38:19 INFO - PROCESS | 15580 | ------- Summary: start ------- 10:38:19 INFO - PROCESS | 15580 | Number of tests: 6 10:38:19 INFO - PROCESS | 15580 | 10:38:19 INFO - PROCESS | 15580 | [#0] dojo.html Cycles:165 Average:4703.21 Median:4824.20 stddev:504.72 (10.5%) stddev-sans-first:478.28 10:38:19 INFO - PROCESS | 15580 | Values: 2590.6 2634.3 2635.9 2636.1 2639.6 4674.8 4677.2 4714.8 4777.5 4824.2 4664.1 4733.5 4738.4 4753.7 4795.3 4318.7 4364.2 4433.6 4445.8 4459.2 4152.8 4445.2 4455.1 4491.2 4492.6 4265.3 4270.0 4288.9 4366.7 4424.4 4340.5 4345.1 4354.3 4362.1 4401.6 4377.9 4380.6 4382.9 4397.6 4436.8 4783.9 4802.5 4809.6 4841.3 4845.0 5116.9 5125.2 5133.5 5135.2 5163.2 5065.7 5141.5 5164.5 5175.5 5191.8 4723.7 4764.9 4766.7 4766.9 4817.9 5232.7 5237.6 5241.7 5245.0 5261.2 5003.9 5013.0 5019.7 5027.0 5039.7 5075.4 5125.2 5138.2 5146.6 5147.3 4866.7 4915.1 4920.7 4974.7 4983.1 4975.1 4978.4 5050.4 5069.0 5071.7 4158.2 4191.6 4273.7 4301.5 4319.3 3716.0 3738.2 3741.6 3773.1 3776.9 4340.1 4342.5 4362.0 4369.9 4391.5 4969.9 5100.0 5137.2 5143.6 5147.1 4375.9 4377.6 4399.5 4414.3 4418.9 4549.5 4566.4 4585.9 4598.1 4662.7 4657.5 4704.4 4714.5 4763.6 4797.6 5123.9 5126.5 5135.3 5141.5 5186.8 4755.5 4765.8 4768.2 4768.9 4830.7 4941.7 5000.7 5048.5 5066.7 5066.7 5130.0 5158.6 5167.0 5172.1 5210.3 4846.4 4995.6 4997.8 4999.6 5011.9 4843.6 4888.0 4920.9 4961.4 4978.1 4876.1 4891.9 4902.8 4903.8 4985.6 5024.2 5024.5 5024.5 5025.9 5036.0 4801.1 4853.7 4900.0 4920.1 4932.6 10:38:19 INFO - PROCESS | 15580 | 10:38:19 INFO - PROCESS | 15580 | [#1] ext.html Cycles:180 Average:48416.69 Median:37702.62 stddev:93397.01 (247.7%) stddev-sans-first:93589.86 10:38:19 INFO - PROCESS | 15580 | Values: 550.1 550.7 553.6 559.7 590.2 35534.6 39481.2 39489.2 39711.8 39733.6 39547.8 39553.8 39882.8 39998.4 40198.2 7699.5 7835.0 7835.6 7841.2 7866.1 7718.3 7816.1 7835.0 7873.3 7895.9 7860.6 7895.8 7907.7 7909.7 7925.5 7787.4 7829.5 7839.8 7848.9 7863.8 7715.9 7719.1 7732.7 7750.2 7751.1 38218.2 38694.6 38712.2 38727.0 38832.8 2951.1 2998.3 3077.7 3095.5 3158.3 29795.1 30248.4 30690.5 30870.7 30923.7 3081.7 3085.5 3131.6 3147.6 3216.4 186514.0 186580.0 186782.0 186956.0 187219.0 52987.0 52997.7 53135.7 53307.2 53314.5 33145.5 34313.3 34414.3 55093.2 55228.0 15070.7 15197.5 15210.0 15241.9 15251.5 10730.8 10792.1 10804.2 10816.4 10824.3 18509.0 18532.6 18542.4 18567.6 18709.2 6754.8 6936.2 7005.8 7027.9 7085.0 789.9 855.6 911.4 912.6 992.8 27901.0 28590.3 28702.7 29272.1 29369.7 999.3 1004.5 1005.3 1015.7 1031.7 15187.8 15292.7 15435.9 15580.6 15755.8 342902.0 421114.0 431521.0 431664.0 641324.0 51115.0 51457.5 51784.8 51806.7 51900.7 1186.2 1190.0 1192.5 1197.7 1207.5 28063.3 29758.2 30131.8 30454.5 30523.2 44105.3 44394.8 44713.3 44897.1 44935.0 344327.0 344393.0 345367.0 346577.0 347275.0 25572.2 26328.9 26704.7 26724.3 26769.0 41991.8 42235.8 42333.6 43730.6 43846.6 36331.0 37631.6 37998.2 38091.6 38378.8 36830.0 37348.8 37356.8 37773.6 38004.0 36195.1 37150.8 38121.0 38278.8 40336.8 31578.2 34356.0 34702.3 34767.5 34951.8 26140.9 26148.5 26304.0 26537.0 26622.7 10:38:19 INFO - PROCESS | 15580 | 10:38:19 INFO - PROCESS | 15580 | [#2] jquery.html Cycles:180 Average:23318.80 Median:5155.14 stddev:59339.08 (1151.1%) stddev-sans-first:59480.52 10:38:19 INFO - PROCESS | 15580 | Values: 367.4 367.6 371.2 378.4 382.5 16187.0 16578.3 17802.6 17836.3 17855.1 16324.5 16509.1 17102.1 17354.0 17376.8 4964.7 5148.2 5162.1 5163.5 5173.8 5033.7 5101.6 5129.0 5131.2 5132.2 4956.9 5063.1 5069.1 5080.0 5103.8 5013.7 5042.7 5076.0 5078.3 5118.1 4537.2 4551.1 4551.2 4569.7 4573.5 20195.7 20291.2 20400.3 20860.3 20983.9 1883.6 1963.2 1985.9 2252.4 2268.9 12348.8 12883.2 12964.2 13025.6 13394.9 1638.1 1715.5 1748.8 1795.7 1801.4 45731.5 58785.0 60887.4 67366.0 70238.3 9206.4 9218.1 9598.6 9784.6 9816.4 13093.6 13137.1 13180.0 13207.2 13267.2 7294.3 7404.3 7539.7 7554.6 7686.8 7338.6 7355.9 7390.5 7451.1 7471.0 5927.0 5992.2 6112.3 6122.9 6206.8 1726.5 1769.5 1804.8 1807.4 1828.2 900.6 939.8 942.9 942.9 953.1 17060.3 17411.4 17483.7 17576.6 17834.4 808.6 855.8 895.1 901.5 952.9 9236.0 9324.0 9426.5 9490.6 9649.1 351415.0 353527.0 354424.0 356140.0 374215.3 57366.1 79068.6 80749.0 83746.6 84749.0 936.2 942.6 952.2 974.4 975.3 14036.9 14078.5 15488.8 15615.9 16090.2 37145.3 37533.1 39314.6 39551.4 41809.4 54479.2 56559.2 57442.0 57646.4 57816.7 6844.6 6898.7 7118.7 7179.4 7233.1 9048.3 9938.6 10027.8 10158.6 10270.6 9172.6 9312.4 9314.2 9341.5 9493.5 8967.4 8975.1 9239.7 9303.5 9509.1 9246.4 9304.2 9437.7 9479.1 9571.7 6853.8 6999.4 7022.5 7125.2 7139.3 7810.6 9290.2 9333.6 9438.5 9588.2 10:38:19 INFO - PROCESS | 15580 | 10:38:19 INFO - PROCESS | 15580 | [#3] mootools.html Cycles:180 Average:5144.93 Median:5113.47 stddev:2903.99 (56.8%) stddev-sans-first:2898.31 10:38:19 INFO - PROCESS | 15580 | Values: 1374.5 1410.0 1521.2 1684.7 1709.3 6689.9 7517.3 7559.2 8043.1 8075.2 7633.0 7846.5 7871.1 7888.3 7892.0 2207.1 2249.0 2250.1 2250.2 2254.2 2196.3 2200.7 2227.4 2249.1 2250.5 2162.6 2180.2 2181.0 2224.8 2242.7 2200.4 2211.5 2220.3 2227.8 2233.1 2174.2 2174.6 2178.1 2194.2 2198.2 7988.0 7989.1 8021.5 8040.3 8054.4 4529.3 4642.2 4668.8 4676.2 4680.6 2774.4 2935.9 2943.0 2957.4 2971.6 822.8 843.7 857.9 867.4 871.1 10638.9 10684.3 10691.1 10702.7 10743.8 4138.6 4207.7 4295.1 4335.8 4337.9 9120.0 9169.7 9177.9 9181.4 9215.0 4778.6 4793.3 4796.7 4801.9 4820.4 3595.5 4199.7 4362.7 4370.2 4396.0 3657.4 3693.5 3732.5 3759.2 3819.7 1196.7 1233.6 1241.4 1241.4 1243.9 682.4 803.3 819.3 842.4 843.0 5063.7 5263.4 5264.7 5358.7 5409.4 418.2 421.7 425.5 426.8 429.0 3427.2 3452.8 3503.0 3512.5 3520.1 9410.9 9651.1 9692.5 9746.4 9822.7 9098.7 9544.4 9643.5 9662.7 9757.7 7279.7 7395.4 7475.1 7519.9 7522.4 5163.2 5366.4 5509.4 5511.5 5529.1 8576.6 8882.5 9032.7 9064.4 9130.1 8924.7 9203.8 9349.7 9359.2 9363.6 5668.9 6463.3 6670.8 6854.7 6969.7 7509.9 7516.7 7525.9 7536.2 7576.0 6468.0 6700.2 6722.2 6750.2 6777.0 6674.4 6726.4 6812.2 6842.1 6902.3 5724.2 5782.5 5789.1 5855.6 5866.3 4562.8 4594.0 4671.5 4697.4 4700.9 4322.0 4488.0 4540.8 4585.0 4600.7 10:38:19 INFO - PROCESS | 15580 | 10:38:19 INFO - PROCESS | 15580 | [#4] prototype.html Cycles:180 Average:4290.02 Median:4869.10 stddev:1268.84 (26.1%) stddev-sans-first:1236.37 10:38:19 INFO - PROCESS | 15580 | Values: 290.4 301.3 305.4 306.9 308.4 4876.7 4944.6 4999.2 5084.4 5116.7 4986.9 5003.4 5019.5 5041.9 5050.8 3960.7 3961.8 3972.3 3984.8 3984.9 3865.7 3929.4 3939.7 3966.8 3982.1 3890.8 3910.2 3922.8 3929.4 3931.9 3904.1 3905.8 3915.7 3916.7 3933.4 3301.0 3420.8 3424.9 3435.4 3439.6 5000.3 5005.4 5014.7 5018.4 5028.2 4478.0 4506.9 4508.4 4522.8 4548.6 4977.9 5290.0 5323.4 5344.1 5344.9 3681.7 3693.9 3702.7 3708.6 3715.6 5506.8 5541.0 5542.8 5546.2 5568.8 3610.5 3779.3 3819.0 3819.2 3819.3 3865.8 3882.4 3887.0 3899.6 3903.7 4428.2 4455.2 4463.6 4472.8 4496.4 5158.9 5360.8 5365.9 5367.3 5380.6 1329.6 1353.4 1354.2 1355.7 1356.8 818.9 836.8 842.2 868.4 874.1 4075.7 4106.9 4109.8 4110.8 4135.9 4848.7 4853.4 4861.0 4861.5 4879.2 4048.8 4074.3 4079.8 4116.6 4129.6 2494.7 2498.5 2589.2 2593.7 2595.8 4482.3 4485.5 4504.1 4507.6 4508.9 4884.3 4934.9 4956.9 4963.3 4968.9 4523.1 4734.6 5057.6 5084.1 5108.3 5471.2 5480.6 5490.2 5503.9 5520.3 5222.5 5341.3 5361.2 5376.9 5412.8 5009.7 5033.9 5084.7 5095.6 5115.2 3590.2 3638.3 3731.6 3748.1 3805.8 5460.1 5508.0 5518.3 5519.5 5529.3 5281.5 5304.3 5330.5 5335.4 5361.0 5152.5 5269.9 5287.9 5296.2 5309.1 5179.2 5193.5 5200.7 5211.2 5243.8 5040.7 5254.9 5262.3 5271.7 5289.4 5189.6 5195.7 5211.7 5218.1 5262.0 10:38:19 INFO - PROCESS | 15580 | 10:38:19 INFO - PROCESS | 15580 | [#5] yui.html Cycles:180 Average:17610.76 Median:44578.78 stddev:24257.60 (54.4%) stddev-sans-first:24292.26 10:38:19 INFO - PROCESS | 15580 | Values: 660.3 671.2 697.1 740.3 773.3 11731.5 12644.6 12731.9 12733.0 13971.8 14584.6 15213.2 15287.1 15295.2 15324.3 621.3 769.6 788.1 795.5 795.7 758.6 784.7 785.4 786.1 787.8 824.8 828.3 829.7 830.5 832.5 825.9 826.0 826.8 828.6 828.7 603.7 603.9 604.0 604.2 605.8 14029.6 14063.0 14068.5 14093.9 14095.5 13456.1 13527.8 13690.2 13717.9 13764.8 9912.0 10120.0 10200.3 10246.3 10285.8 3245.6 3291.7 3309.8 3317.2 3317.4 60913.7 61433.4 61827.4 62464.4 62498.0 9651.2 9941.6 10126.6 10199.5 10268.7 15871.8 18073.6 18080.5 18149.1 18179.0 6933.3 7024.2 7097.3 7099.1 7102.0 3730.0 3747.2 3847.9 3896.3 3923.9 2995.5 3091.1 3105.4 3106.6 3109.8 533.9 537.9 538.2 541.1 549.2 498.4 583.3 588.3 603.1 615.2 8622.6 8865.1 8908.6 8950.7 9169.2 583.4 594.9 617.7 618.1 642.8 4019.5 4196.5 4211.8 4220.1 4375.0 79042.6 81163.0 82342.2 93135.5 104369.5 80456.0 82877.0 83029.2 83223.2 83406.0 73648.6 75016.0 76215.2 76339.0 76715.6 8586.9 8963.7 9093.7 9164.0 9381.7 41100.0 43499.6 44424.6 44733.0 46154.0 55336.7 55904.0 59251.4 62223.0 63771.0 11431.4 11785.4 12020.5 12083.2 12090.6 13479.7 13737.2 13795.9 14053.6 14662.9 11754.4 12113.7 12273.5 12382.9 12437.0 12676.2 12829.0 12829.9 12844.9 12855.1 11232.7 11403.4 11413.0 11637.0 11851.8 10598.7 10974.6 10999.3 11014.4 11098.7 10107.2 10275.4 10325.3 10411.8 10429.4 10:38:19 INFO - PROCESS | 15580 | -------- Summary: end -------- 10:38:19 INFO - PROCESS | 15580 | 10:38:19 INFO - TEST-INFO | 15580: exit 0 10:38:19 INFO - TEST-OK | dromaeo_css | took 1117132ms 10:38:19 INFO - TEST-START | kraken 10:38:19 INFO - operating with platform_type : linux_ 10:38:19 INFO - Initialising browser for kraken test... 10:38:19 INFO - TEST-INFO | started process 15825 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLwoWQp/profile http://localhost:45809/getInfo.html) 10:38:25 INFO - PROCESS | 15825 | __metrics Screen width/height:1600/1200 10:38:25 INFO - PROCESS | 15825 | colorDepth:24 10:38:25 INFO - PROCESS | 15825 | Browser inner width/height: 1024/697 10:38:25 INFO - PROCESS | 15825 | __metrics 10:38:25 ERROR - PROCESS | 15825 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2957: TypeError: this.tabs is undefined 10:38:26 INFO - TEST-INFO | 15825: exit 0 10:38:26 INFO - Browser initialized. 10:38:26 INFO - Running cycle 1/1 for kraken test... 10:38:26 INFO - TEST-INFO | started process 15943 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpLwoWQp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:38:38 INFO - PROCESS | 15943 | RSS: Main: 168996864 10:38:38 INFO - PROCESS | 15943 | 10:38:41 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45809/tests/kraken/driver.html?testName=audio-beat-detection) 10:38:42 INFO - PROCESS | 15943 | RSS: Main: 174456832 10:38:42 INFO - PROCESS | 15943 | 10:38:44 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45809/tests/kraken/driver.html?testName=audio-dft) 10:38:45 INFO - PROCESS | 15943 | RSS: Main: 174395392 10:38:45 INFO - PROCESS | 15943 | 10:38:48 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45809/tests/kraken/driver.html?testName=audio-fft) 10:38:49 INFO - PROCESS | 15943 | RSS: Main: 169586688 10:38:49 INFO - PROCESS | 15943 | 10:38:51 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45809/tests/kraken/driver.html?testName=audio-oscillator) 10:38:51 INFO - PROCESS | 15943 | RSS: Main: 169828352 10:38:51 INFO - PROCESS | 15943 | 10:38:54 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45809/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:38:54 INFO - PROCESS | 15943 | RSS: Main: 169918464 10:38:54 INFO - PROCESS | 15943 | 10:38:58 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45809/tests/kraken/driver.html?testName=imaging-darkroom) 10:38:58 INFO - PROCESS | 15943 | RSS: Main: 170176512 10:38:58 INFO - PROCESS | 15943 | 10:39:02 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45809/tests/kraken/driver.html?testName=imaging-desaturate) 10:39:02 INFO - PROCESS | 15943 | RSS: Main: 167567360 10:39:02 INFO - PROCESS | 15943 | 10:39:05 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45809/tests/kraken/driver.html?testName=json-parse-financial) 10:39:06 INFO - PROCESS | 15943 | RSS: Main: 168620032 10:39:06 INFO - PROCESS | 15943 | 10:39:08 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45809/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:39:08 INFO - PROCESS | 15943 | RSS: Main: 169000960 10:39:08 INFO - PROCESS | 15943 | 10:39:10 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45809/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:39:11 INFO - PROCESS | 15943 | RSS: Main: 169803776 10:39:11 INFO - PROCESS | 15943 | 10:39:13 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45809/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:39:14 INFO - PROCESS | 15943 | RSS: Main: 170029056 10:39:14 INFO - PROCESS | 15943 | 10:39:17 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:39:17 INFO - PROCESS | 15943 | RSS: Main: 170237952 10:39:17 INFO - PROCESS | 15943 | 10:39:20 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:39:21 INFO - PROCESS | 15943 | RSS: Main: 169779200 10:39:21 INFO - PROCESS | 15943 | 10:39:22 INFO - PROCESS | 15943 | Cycle 1(1): loaded http://localhost:45809/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45809/tests/kraken/driver.html?testName=ai-astar) 10:39:23 INFO - PROCESS | 15943 | RSS: Main: 170606592 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | __start_tp_report 10:39:23 INFO - PROCESS | 15943 | _x_x_mozilla_page_load 10:39:23 INFO - PROCESS | 15943 | _x_x_mozilla_page_load_details 10:39:23 INFO - PROCESS | 15943 | |i|pagename|runs| 10:39:23 INFO - PROCESS | 15943 | |0;ai-astar;107;118;108;114;115;114;116;115;114;113 10:39:23 INFO - PROCESS | 15943 | |1;audio-beat-detection;153;122;145;174;129;155;150;124;182;126 10:39:23 INFO - PROCESS | 15943 | |2;audio-dft;163;164;162;166;169;164;163;162;164;162 10:39:23 INFO - PROCESS | 15943 | |3;audio-fft;76;77;77;158;77;76;75;77;156;76 10:39:23 INFO - PROCESS | 15943 | |4;audio-oscillator;90;87;142;86;86;86;139;86;89;142 10:39:23 INFO - PROCESS | 15943 | |5;imaging-gaussian-blur;118;117;119;118;118;118;117;117;118;118 10:39:23 INFO - PROCESS | 15943 | |6;imaging-darkroom;149;149;147;147;147;147;148;148;148;148 10:39:23 INFO - PROCESS | 15943 | |7;imaging-desaturate;99;96;95;96;96;96;95;95;97;95 10:39:23 INFO - PROCESS | 15943 | |8;json-parse-financial;65;66;69;65;66;67;67;65;65;67 10:39:23 INFO - PROCESS | 15943 | |9;json-stringify-tinderbox;66;69;64;64;65;64;64;64;65;65 10:39:23 INFO - PROCESS | 15943 | |10;stanford-crypto-aes;79;79;80;80;80;80;89;81;86;84 10:39:23 INFO - PROCESS | 15943 | |11;stanford-crypto-ccm;131;140;135;129;145;134;134;133;194;143 10:39:23 INFO - PROCESS | 15943 | |12;stanford-crypto-pbkdf2;167;165;166;167;164;163;165;166;167;165 10:39:23 INFO - PROCESS | 15943 | |13;stanford-crypto-sha256-iterative;68;68;68;68;70;66;67;67;66;71 10:39:23 INFO - PROCESS | 15943 | __end_tp_report 10:39:23 INFO - PROCESS | 15943 | __start_cc_report 10:39:23 INFO - PROCESS | 15943 | _x_x_mozilla_cycle_collect,993 10:39:23 INFO - PROCESS | 15943 | __end_cc_report 10:39:23 INFO - PROCESS | 15943 | __startTimestamp1467913163213__endTimestamp 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | ------- Summary: start ------- 10:39:23 INFO - PROCESS | 15943 | Number of tests: 14 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#0] ai-astar Cycles:10 Average:113.40 Median:114.50 stddev:3.41 (3.0%) stddev-sans-first:2.71 10:39:23 INFO - PROCESS | 15943 | Values: 107.0 118.0 108.0 114.0 115.0 114.0 116.0 115.0 114.0 113.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#1] audio-beat-detection Cycles:10 Average:146.00 Median:151.50 stddev:21.02 (13.9%) stddev-sans-first:22.14 10:39:23 INFO - PROCESS | 15943 | Values: 153.0 122.0 145.0 174.0 129.0 155.0 150.0 124.0 182.0 126.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#2] audio-dft Cycles:10 Average:163.90 Median:164.00 stddev:2.18 (1.3%) stddev-sans-first:2.29 10:39:23 INFO - PROCESS | 15943 | Values: 163.0 164.0 162.0 166.0 169.0 164.0 163.0 162.0 164.0 162.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#3] audio-fft Cycles:10 Average:92.50 Median:76.50 stddev:34.00 (44.4%) stddev-sans-first:35.54 10:39:23 INFO - PROCESS | 15943 | Values: 76.0 77.0 77.0 158.0 77.0 76.0 75.0 77.0 156.0 76.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#4] audio-oscillator Cycles:10 Average:103.30 Median:86.00 stddev:26.06 (30.3%) stddev-sans-first:27.20 10:39:23 INFO - PROCESS | 15943 | Values: 90.0 87.0 142.0 86.0 86.0 86.0 139.0 86.0 89.0 142.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#5] imaging-gaussian-blur Cycles:10 Average:117.80 Median:118.00 stddev:0.63 (0.5%) stddev-sans-first:0.67 10:39:23 INFO - PROCESS | 15943 | Values: 118.0 117.0 119.0 118.0 118.0 118.0 117.0 117.0 118.0 118.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.79 (0.5%) stddev-sans-first:0.71 10:39:23 INFO - PROCESS | 15943 | Values: 149.0 149.0 147.0 147.0 147.0 147.0 148.0 148.0 148.0 148.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:1.25 (1.3%) stddev-sans-first:0.71 10:39:23 INFO - PROCESS | 15943 | Values: 99.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 97.0 95.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#8] json-parse-financial Cycles:10 Average:66.20 Median:66.50 stddev:1.32 (2.0%) stddev-sans-first:1.32 10:39:23 INFO - PROCESS | 15943 | Values: 65.0 66.0 69.0 65.0 66.0 67.0 67.0 65.0 65.0 67.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#9] json-stringify-tinderbox Cycles:10 Average:65.00 Median:65.00 stddev:1.56 (2.4%) stddev-sans-first:1.62 10:39:23 INFO - PROCESS | 15943 | Values: 66.0 69.0 64.0 64.0 65.0 64.0 64.0 64.0 65.0 65.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#10] stanford-crypto-aes Cycles:10 Average:81.80 Median:80.50 stddev:3.39 (4.2%) stddev-sans-first:3.44 10:39:23 INFO - PROCESS | 15943 | Values: 79.0 79.0 80.0 80.0 80.0 80.0 89.0 81.0 86.0 84.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#11] stanford-crypto-ccm Cycles:10 Average:141.80 Median:137.50 stddev:19.05 (13.9%) stddev-sans-first:19.80 10:39:23 INFO - PROCESS | 15943 | Values: 131.0 140.0 135.0 129.0 145.0 134.0 134.0 133.0 194.0 143.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.50 Median:166.00 stddev:1.35 (0.8%) stddev-sans-first:1.32 10:39:23 INFO - PROCESS | 15943 | Values: 167.0 165.0 166.0 167.0 164.0 163.0 165.0 166.0 167.0 165.0 10:39:23 INFO - PROCESS | 15943 | 10:39:23 INFO - PROCESS | 15943 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:1.60 (2.3%) stddev-sans-first:1.69 10:39:23 INFO - PROCESS | 15943 | Values: 68.0 68.0 68.0 68.0 70.0 66.0 67.0 67.0 66.0 71.0 10:39:23 INFO - PROCESS | 15943 | -------- Summary: end -------- 10:39:23 INFO - PROCESS | 15943 | 10:39:24 INFO - TEST-INFO | 15943: exit 0 10:39:24 INFO - TEST-OK | kraken | took 64418ms 10:39:24 INFO - SUITE-END | took 1181s 10:39:24 INFO - Completed test suite (00:19:41) 10:39:24 INFO - javascript benchmark 10:39:24 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 6440.047029796801, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2590.5596048671723, 2634.301909993852, 2635.9209223723283, 2636.1037247335903, 2639.630451736757, 4674.766261686915, 4677.22825733754, 4714.811407543699, 4777.52224777522, 4824.2040063389495, 4664.090502352043, 4733.455652599952, 4738.407699037621, 4753.738544380058, 4795.256735206049, 4318.654507639381, 4364.192624364487, 4433.623142032931, 4445.799939002736, 4459.219636563605, 4152.813123409439, 4445.177642136199, 4455.1089782043555, 4491.191585514606, 4492.640588752892, 4265.317549192146, 4269.978650106729, 4288.871333859989, 4366.716163449366, 4424.358468022118, 4340.52254252032, 4345.087531618364, 4354.259775838083, 4362.062156636339, 4401.5598440156045, 4377.868663940087, 4380.561943805626, 4382.868513944587, 4397.626201772853, 4436.822527098912, 4783.928241076386, 4802.543758342952, 4809.567138957511, 4841.298011788306, 4844.975775121102, 5116.923246151311, 5125.179971204627, 5133.460986596391, 5135.152699804527, 5163.199704045879, 5065.746712664389, 5141.537261646432, 5164.45773193813, 5175.45657705943, 5191.844244672666, 4723.716577005391, 4764.928526072112, 4766.713997160182, 4766.856994290177, 4817.879553011167, 5232.73836308183, 5237.580993520509, 5241.711705856214, 5245.0, 5261.158214685632, 5003.899922001539, 5013.047520971004, 5019.67372120811, 5026.969471258383, 5039.748012599355, 5075.416327122354, 5125.205593133071, 5138.152204886227, 5146.552364906746, 5147.279380886679, 4866.732329721899, 4915.090708218991, 4920.704757714477, 4974.701517908937, 4983.127952608279, 4975.0796102721115, 4978.427480839678, 5050.419201791768, 5068.974655126701, 5071.695698258116, 4158.2307273154565, 4191.601797829201, 4273.700840941105, 4301.505326887385, 4319.33050377192, 3715.9628403716156, 3738.1776009277914, 3741.56971948224, 3773.0755964788254, 3776.9244615108096, 4340.110277393127, 4342.478902531653, 4361.956380436219, 4369.934450983238, 4391.4730232371685, 4969.875753106129, 5100.0, 5137.2037334213255, 5143.562797162208, 5147.099257629975, 4375.890602734957, 4377.562243775597, 4399.538048504861, 4414.293713005968, 4418.911621767611, 4549.454065512094, 4566.360709500673, 4585.862424127282, 4598.080383923162, 4662.673612847136, 4657.534246575316, 4704.435467743892, 4714.481407045291, 4763.642726795573, 4797.592204662573, 5123.923141152811, 5126.512981266774, 5135.281060651587, 5141.460146684544, 5186.844394668166, 4755.476897541199, 4765.76171191446, 4768.165571025126, 4768.904621907612, 4830.66185367035, 4941.728204948762, 5000.699958002531, 5048.5203905628905, 5066.72133032672, 5066.721330326867, 5129.974350128375, 5158.587313014875, 5166.974165129151, 5172.069027574922, 5210.296609957607, 4846.39420072491, 4995.62532810048, 4997.800087996585, 4999.550040496373, 5011.949880501148, 4843.588294994824, 4888.0468308679465, 4920.852374428773, 4961.429435614806, 4978.054169707744, 4876.146674332049, 4891.877703057452, 4902.754862256802, 4903.754812259302, 4985.626078044089, 5024.246363045572, 5024.497550244946, 5024.547790698854, 5025.924611130763, 5036.043151801146, 4801.135795556834, 4853.684510506947, 4900.044491324157, 4920.138975679313, 4932.580730637936], "value": 4670.153745148856, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [550.0868558193399, 550.7328945461453, 553.606939073258, 559.7201399300351, 590.2179612014082, 35534.644653553456, 39481.21037579246, 39489.21021579567, 39711.80144099283, 39733.60266397335, 39547.802260988654, 39553.802230988804, 39882.8005859971, 39998.40002399966, 40198.19603607926, 7699.538027718327, 7834.960825195894, 7835.608219589027, 7841.176676448977, 7866.134725180225, 7718.305352518272, 7816.140224575292, 7834.960825195866, 7873.330766884793, 7895.8815617765495, 7860.646270917794, 7895.8420831583335, 7907.723229686962, 7909.683612655487, 7925.524468531907, 7787.377009839256, 7829.491083079582, 7839.764807055797, 7848.921510784905, 7863.8034049148655, 7715.922840771633, 7719.073711154698, 7732.729354472566, 7750.224977502261, 7751.147373788879, 38218.23563528742, 38694.61305386938, 38712.225755485015, 38727.0, 38832.805835970925, 2951.144168191222, 2998.250437390652, 3077.723004929567, 3095.520194369876, 3158.3051728619666, 29795.10614681563, 30248.395032099455, 30690.53964190539, 30870.691293087006, 30923.69076309253, 3081.691830816923, 3085.4754691702465, 3131.6398614159434, 3147.559341692142, 3216.404965081444, 186514.0, 186580.0, 186782.0, 186956.0, 187219.0, 52987.0, 52997.735011324694, 53135.73432132892, 53307.20039199415, 53314.466855331724, 33145.50281745776, 34313.313733725685, 34414.31171376609, 55093.173602396, 55228.0, 15070.698586028218, 15197.544073677807, 15210.0, 15241.923790380977, 15251.542453726406, 10730.839037414446, 10792.082672972729, 10804.1896857736, 10816.351018938889, 10824.296420732628, 18509.0, 18532.629347413247, 18542.351017714314, 18567.628647426976, 18709.158087886077, 6754.763583274562, 6936.20233673134, 7005.824854378681, 7027.929720702829, 7085.0, 789.9249571290718, 855.6406309349964, 911.3939230411835, 912.6212621762027, 992.7518120469882, 27901.0, 28590.285242869093, 28702.71297287042, 29272.121836344944, 29369.706302937124, 999.3204620857887, 1004.4877112672443, 1005.3214080495636, 1015.6851376073294, 1031.7317497450567, 15187.772183417257, 15292.694146117015, 15435.922820386051, 15580.610484737972, 15755.763663545056, 342902.0, 421114.0, 431521.0, 431664.0, 641324.0, 51115.0, 51457.48542514527, 51784.785825701154, 51806.74096629493, 51900.74049629728, 1186.163754553038, 1189.9524019039316, 1192.48723049088, 1197.6766273106211, 1207.5230284037932, 28063.298417539725, 29758.172973567478, 30131.849340753157, 30454.543181852732, 30523.236919076313, 44105.33841992437, 44394.77802610966, 44713.32930005987, 44897.10205795801, 44935.0, 344327.0, 344393.0, 345367.0, 346577.0, 347275.0, 25572.232833015038, 26328.868355658098, 26704.732952671002, 26724.331891702863, 26769.0, 41991.7900410496, 42235.78882105693, 42333.5766642342, 43730.56269437392, 43846.56153438425, 36331.0, 37631.62368376281, 37998.24003519969, 38091.61908380881, 38378.808105959295, 36830.0, 37348.81325593355, 37356.81321593375, 37773.62226377811, 38004.0, 36195.095122622144, 37150.81424592968, 38121.0, 38278.80860595791, 40336.79831600823, 31578.210544736565, 34356.0, 34702.30595388028, 34767.4784878222, 34951.82524087363, 26140.92771006143, 26148.477030459664, 26304.0, 26537.0, 26622.733772662024], "value": 17622.95100490662, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [367.40663827917905, 367.5589292848582, 371.1500663480629, 378.3605706356258, 382.5371300726121, 16187.0, 16578.253978570963, 17802.643947121065, 17836.286548538075, 17855.107244637747, 16324.510264692048, 16509.09199994, 17102.144892755343, 17354.0, 17376.82623173768, 4964.726940018307, 5148.150555158394, 5162.1224391853475, 5163.483651634844, 5173.793048278064, 5033.723145227011, 5101.591872650179, 5128.974355128219, 5131.230315452674, 5132.23016547519, 4956.851294461154, 5063.063333283354, 5069.087564238435, 5080.0, 5103.770330335144, 5013.724245166514, 5042.697438153704, 5076.03555324489, 5078.289039534468, 5118.129917913963, 4537.228671125917, 4551.067031258584, 4551.226291530448, 4569.725816451024, 4573.519780423074, 20195.697064543896, 20291.188352465884, 20400.28598999028, 20860.26989055391, 20983.895080524653, 1883.6138591588692, 1963.2049020146862, 1985.9205631774712, 2252.40311317501, 2268.8995837019033, 12348.75302493954, 12883.162594431333, 12964.157329773629, 13025.609231723063, 13394.933025334909, 1638.1072315587915, 1715.485354393677, 1748.8251174882537, 1795.6678014567347, 1801.3605170164665, 45731.5426845734, 58784.99999999957, 60887.391126088616, 67366.0, 70238.29761702368, 9206.401583897024, 9218.124278193562, 9598.616055357708, 9784.608615655436, 9816.411015339103, 13093.607191784262, 13137.080404371602, 13180.0, 13207.207567545978, 13267.203967761965, 7294.27057294277, 7404.333609975128, 7539.736109236151, 7554.622268886534, 7686.769396918102, 7338.633068346561, 7355.852882942419, 7390.5196162249285, 7451.1431185413285, 7470.991416158858, 5926.970365148147, 5992.191054207713, 6112.327643959161, 6122.938770612237, 6206.844828879314, 1726.464795913271, 1769.5222289981891, 1804.756357891694, 1807.403556826244, 1828.1955939386628, 900.5677274907949, 939.793245485992, 942.8962814090445, 942.9434233945985, 953.1469334945185, 17060.31758729637, 17411.390601328894, 17483.65032699339, 17576.648467030587, 17834.37579684705, 808.6441965535146, 855.8202777416813, 895.1451363947415, 901.5312037740339, 952.9083661363379, 9235.953820230856, 9323.953380233055, 9426.481543515036, 9490.572924218288, 9649.083337082966, 351415.0, 353527.0, 354424.0, 356140.0, 374215.2947101267, 57366.139507907414, 79068.60465697749, 80749.0, 83746.58126709328, 84749.0, 936.2229349639919, 942.6182396129578, 952.2001518724443, 974.4445665970329, 975.2831668723483, 14036.947228958074, 14078.507252246121, 15488.84511154874, 15615.891854599939, 16090.195490225677, 37145.25709485849, 37533.06167345838, 39314.606853931095, 39551.40672889967, 41809.37285940774, 54479.18281225706, 56559.15161272502, 57442.0, 57646.42353576578, 57816.710916446835, 6844.623545704835, 6898.689558969959, 7118.683043636944, 7179.389751871149, 7233.132024157135, 9048.276137909083, 9938.602455901682, 10027.849582256418, 10158.593656253963, 10270.6405275815, 9172.587233574372, 9312.394694344846, 9314.161725444743, 9341.532923353669, 9493.525323733647, 8967.417117887317, 8975.147361000694, 9239.676611318571, 9303.534823258675, 9509.096635819586, 9246.352755307063, 9304.209142222717, 9437.716868493957, 9479.146876781122, 9571.664991725256, 6853.760118395832, 6999.440044796506, 7022.473314501331, 7125.216226215009, 7139.250378710369, 7810.648520816463, 9290.16388525036, 9333.626654933727, 9438.480883551196, 9588.232941364813], "value": 8150.1433394881315, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1374.5463996881026, 1410.0, 1521.216573464665, 1684.6799108169455, 1709.2821015173627, 6689.8996515052195, 7517.323440890319, 7559.206283340252, 8043.075046369662, 8075.232852878982, 7633.0, 7846.529208247509, 7871.134175240719, 7888.290053895148, 7891.960540197291, 2207.1171531387495, 2249.0441562336023, 2250.1449449209276, 2250.167438047916, 2254.1546919905036, 2196.2752291743686, 2200.6919031335624, 2227.354067320475, 2249.055396733376, 2250.504888924434, 2162.643163877958, 2180.2260197629853, 2180.9890950545223, 2224.822014238857, 2242.6523888797183, 2200.4168895242774, 2211.5245222277126, 2220.311703371952, 2227.8440509164366, 2233.0732745910427, 2174.184680744721, 2174.64118420462, 2178.0743184146672, 2194.221051526701, 2198.1537108213292, 7987.960060199662, 7989.121196668362, 8021.478603890729, 8040.316573091294, 8054.43618946674, 4529.2526733089, 4642.234031384817, 4668.813247470097, 4676.181668208084, 4680.602148817321, 2774.3618967637353, 2935.8678859451375, 2943.043510858958, 2957.4085182963495, 2971.5988341573825, 822.8148666550038, 843.7468759372164, 857.8884744983112, 867.3668222197831, 871.1027641529236, 10638.893611063868, 10684.25210235276, 10691.144708423386, 10702.732431689192, 10743.785124297548, 4138.6482149017065, 4207.6633869291, 4295.140971805651, 4335.761533115646, 4337.891552711208, 9120.0, 9169.679061232824, 9177.90822091784, 9181.35730498872, 9215.0, 4778.617710583145, 4793.281007848781, 4796.712197268175, 4801.855944321676, 4820.39745031871, 3595.478655594924, 4199.68502362324, 4362.650987920959, 4370.2352088384405, 4395.978020109879, 3657.396529572644, 3693.5013773140818, 3732.496113024761, 3759.248150369937, 3819.6753275971296, 1196.7247533067268, 1233.6237447578396, 1241.3793103448277, 1241.4289426863563, 1243.9129260951647, 682.4165338635495, 803.2730379007008, 819.2954059508818, 842.3850589070013, 842.9789255268668, 5063.746812659426, 5263.421023687391, 5264.657797243243, 5358.705271210121, 5409.43200963901, 418.16367265469063, 421.652136986987, 425.4957874918232, 426.83353492138093, 429.03253164115347, 3427.246005878703, 3452.7755695879687, 3502.9824850875584, 3512.455569386749, 3520.119970007498, 9410.858837117448, 9651.131398174199, 9692.46691431978, 9746.415215087118, 9822.705318840446, 9098.681546145854, 9544.42733435996, 9643.517824108767, 9662.661806836726, 9757.707268781947, 7279.745208917769, 7395.445341599401, 7475.140358858801, 7519.887201691979, 7522.398208143335, 5163.199704045879, 5366.3560372753955, 5509.449055094458, 5511.476409741068, 5529.142982837667, 8576.571171441277, 8882.511461869659, 9032.729018129467, 9064.365494415328, 9130.132637399436, 8924.68763593271, 9203.76990575241, 9349.719508414759, 9359.15767580921, 9363.625454981724, 5668.858278543069, 6463.256725476443, 6670.7665231716655, 6854.691538880663, 6969.651517424007, 7509.9249007509225, 7516.736914207976, 7525.88711169322, 7536.208698086842, 7575.962120189364, 6468.0, 6700.162479690039, 6722.19333679942, 6750.1562304711915, 6776.966115169393, 6674.43267322283, 6726.39462448382, 6812.182538095461, 6842.144731908512, 6902.275261097512, 5724.198612194379, 5782.508486778671, 5789.131630255495, 5855.648661080349, 5866.266716660418, 4562.8018005052345, 4593.977030114828, 4671.532846715301, 4697.412823397075, 4700.905981880412, 4321.978390108029, 4487.977560112178, 4540.818367265405, 4584.977075114603, 4600.677952543289], "value": 4072.212340469663, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [290.40901764908415, 301.3265351938418, 305.38312608530754, 306.92480342316134, 308.3770783018303, 4876.658633895629, 4944.629152813535, 4999.200127979524, 5084.415292241389, 5116.692998420097, 4986.900261994758, 5003.374578177728, 5019.523145301199, 5041.890784027508, 5050.772715227814, 3960.6831453483796, 3961.8217180226957, 3972.3048466518244, 3984.780837053961, 3984.9203015939665, 3865.724310977371, 3929.44987701722, 3939.72421930465, 3966.821493032806, 3982.064214909494, 3890.8054597270025, 3910.1984093260958, 3922.8234729437245, 3929.390944403622, 3931.9213615727667, 3904.12157264616, 3905.7656540607654, 3915.686745060388, 3916.725829191958, 3933.3509970854775, 3300.966990330114, 3420.811855347955, 3424.8972530824117, 3435.381631306364, 3439.6216416194197, 5000.2749601307605, 5005.374328208974, 5014.724190169539, 5018.422881368653, 5028.170351891933, 4477.977610111961, 4506.932396014063, 4508.391367165424, 4522.819087236539, 4548.565832796251, 4977.875553111165, 5289.973550132263, 5323.361196656388, 5344.14493681013, 5344.91982620261, 3681.7054635629083, 3693.8522459101605, 3702.685271751904, 3708.554973403209, 3715.609860964587, 5506.834794956158, 5541.002619528484, 5542.778288868481, 5546.223528705985, 5568.777248910039, 3610.5306310180035, 3779.281936432124, 3819.0, 3819.1788765415567, 3819.312523745697, 3865.7873816939777, 3882.4176373544196, 3886.9805650971566, 3899.629535194152, 3903.746256493319, 4428.158649856581, 4455.1535208310315, 4463.553644635511, 4472.8210871565425, 4496.426250812189, 5158.926626398683, 5360.785568577213, 5365.946340536622, 5367.329083864517, 5380.596455265871, 1329.6144118205611, 1353.35715535122, 1354.1739538881275, 1355.735631551838, 1356.7625665508497, 818.8935438392971, 836.7991681996277, 842.1536355962219, 868.3877866104381, 874.0822136756381, 4075.735077219971, 4106.938395924063, 4109.773962432035, 4110.835566577363, 4135.875923722293, 4848.660593758474, 4853.4468969929985, 4860.975695121572, 4861.538153875376, 4879.243717223836, 4048.7570745755347, 4074.348104303297, 4079.8164082616354, 4116.58834116592, 4129.587041295907, 2494.663220465214, 2498.523331364435, 2589.2491177558295, 2593.6628238328894, 2595.8053146014126, 4482.305242687388, 4485.46174459067, 4504.117364886475, 4507.57178068083, 4508.887277818081, 4884.267359895973, 4934.8766280843265, 4956.926705442576, 4963.255511673278, 4968.925466118011, 4523.050159466483, 4734.621230301567, 5057.595392368528, 5084.1102807009365, 5108.2848401223855, 5471.151971444432, 5480.561555075664, 5490.176473529003, 5503.9174412383045, 5520.309961254843, 5222.4671034547455, 5341.305630268041, 5361.249425080414, 5376.892462150813, 5412.78348866041, 5009.749512524287, 5033.924491132562, 5084.720340381315, 5095.617828662939, 5115.232715092766, 3590.1742599202853, 3638.326909521747, 3731.552213734369, 3748.100455890621, 3805.8097095145686, 5460.071787796005, 5507.953488837108, 5518.2826232589505, 5519.530839878656, 5529.30883639545, 5281.498257665516, 5304.336957880265, 5330.520253177233, 5335.413104558418, 5360.973195133999, 5152.4847515248175, 5269.868253293698, 5287.9471205287455, 5296.232046353334, 5309.123994541012, 5179.171332586768, 5193.506616871391, 5200.713960732196, 5211.1922651989, 5243.764030618555, 5040.697558146523, 5254.894902102013, 5262.342362156061, 5271.71005594696, 5289.391719952101, 5189.558887494454, 5195.68825870449, 5211.739413029258, 5218.130028484243, 5262.0], "value": 3885.390987871277, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [660.3033799341694, 671.1778071861967, 697.1111832413669, 740.3484933258732, 773.3349319585158, 11731.530738770449, 12644.557440489585, 12731.872681273184, 12733.0, 13971.79042314366, 14584.635384115403, 15213.163276019815, 15287.082775033477, 15295.15876626785, 15324.310406031727, 621.2606997672755, 769.6228847864534, 788.1369899959535, 795.5306369242146, 795.7095660084057, 758.5865703191746, 784.6586734770393, 785.4423359414823, 786.0724345272577, 787.8345547435046, 824.8061705499202, 828.2587084559316, 829.7096016394244, 830.489249111795, 832.4755404095441, 825.9256666900008, 826.0005393473933, 826.8098337382405, 828.6436832162168, 828.7099515169702, 603.6559161278074, 603.8792241551707, 604.0245004318039, 604.1873679900526, 605.7576969212306, 14029.64925876851, 14063.0, 14068.507602233873, 14093.929530352385, 14095.50665726705, 13456.125351852099, 13527.797083043763, 13690.178589284675, 13717.862821371858, 13764.793528096987, 9911.950440247752, 10120.0, 10200.3369780964, 10246.333988290737, 10285.79428411435, 3245.578074850278, 3291.703746662788, 3309.7683162178655, 3317.1872891141584, 3317.3696997570382, 60913.695431523, 61433.385666143215, 61827.38172618261, 62464.37535624631, 62498.0, 9651.227901767841, 9941.552630131517, 10126.645567405105, 10199.490025498695, 10268.691939241835, 15871.841281587267, 18073.63852722938, 18080.457586272434, 18149.092545372943, 18179.0, 6933.341332573498, 7024.2273349931465, 7097.290270972861, 7099.07711997437, 7102.0, 3730.0488375464083, 3747.2130852521277, 3847.9038024049623, 3896.298666240047, 3923.941140882889, 2995.5356919677483, 3091.072678196577, 3105.3789242151206, 3106.5650808886776, 3109.766767492402, 533.8505218538737, 537.9220013098079, 538.2222688215569, 541.0585581088877, 549.1789774287466, 498.35463075316824, 583.3146053387253, 588.2705445247861, 603.101378945377, 615.2432508015077, 8622.568871556397, 8865.140506650614, 8908.599113039929, 8950.731478055668, 9169.220616247694, 583.3583058635467, 594.9315828679671, 617.6818938246806, 618.1191801682585, 642.7653906324158, 4019.5176578810147, 4196.454460920061, 4211.789410529461, 4220.11377610699, 4374.978125109354, 79042.6047869757, 81163.0, 82342.17657823465, 93135.53432232795, 104369.47815261027, 80456.0, 82877.0, 83029.16970830335, 83223.16776832154, 83406.0, 73648.63175684195, 75016.0, 76215.23784762081, 76339.0, 76715.61642191642, 8586.91413085886, 8963.731088067369, 9093.665048181887, 9164.0, 9381.671641492516, 41100.0, 43499.56500434955, 44424.555754442044, 44733.0, 46154.0, 55336.72331638316, 55904.0, 59251.40748592459, 62223.0, 63771.04343434759, 11431.428428578703, 11785.351805650771, 12020.459079341626, 12083.214591051554, 12090.576829810914, 13479.730405392034, 13737.175769453865, 13795.862041379458, 14053.578392648236, 14662.853371466148, 11754.353510557, 12113.69715757113, 12273.509059637514, 12382.938085309515, 12437.0, 12676.176048556814, 12829.0, 12829.93585032069, 12844.935775321064, 12855.1001429899, 11232.719182020515, 11403.429828508708, 11413.0, 11637.0, 11851.822222666839, 10598.735031624272, 10974.615888443866, 10999.34003959765, 11014.44927753625, 11098.667039988813, 10107.191424686154, 10275.383476991405, 10325.253987668864, 10411.796439489191, 10429.374237545771], "value": 6721.167209129878, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1568.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [107.0, 118.0, 108.0, 114.0, 115.0, 114.0, 116.0, 115.0, 114.0, 113.0], "value": 113.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 122.0, 145.0, 174.0, 129.0, 155.0, 150.0, 124.0, 182.0, 126.0], "value": 146.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 164.0, 162.0, 166.0, 169.0, 164.0, 163.0, 162.0, 164.0, 162.0], "value": 163.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 77.0, 77.0, 158.0, 77.0, 76.0, 75.0, 77.0, 156.0, 76.0], "value": 92.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 87.0, 142.0, 86.0, 86.0, 86.0, 139.0, 86.0, 89.0, 142.0], "value": 103.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 119.0, 118.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0], "value": 117.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [149.0, 149.0, 147.0, 147.0, 147.0, 147.0, 148.0, 148.0, 148.0, 148.0], "value": 147.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 97.0, 95.0], "value": 96.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 66.0, 69.0, 65.0, 66.0, 67.0, 67.0, 65.0, 65.0, 67.0], "value": 66.2, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 69.0, 64.0, 64.0, 65.0, 64.0, 64.0, 64.0, 65.0, 65.0], "value": 65.0, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 79.0, 80.0, 80.0, 80.0, 80.0, 89.0, 81.0, 86.0, 84.0], "value": 81.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 140.0, 135.0, 129.0, 145.0, 134.0, 134.0, 133.0, 194.0, 143.0], "value": 141.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 165.0, 166.0, 167.0, 164.0, 163.0, 165.0, 166.0, 167.0, 165.0], "value": 165.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 68.0, 70.0, 66.0, 67.0, 67.0, 66.0, 71.0], "value": 67.9, "unit": "score"}]}]} 10:39:24 INFO - Return code: 0 10:39:24 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:39:24 ERROR - # TBPL SUCCESS # 10:39:24 INFO - Running post-action listener: _resource_record_post_action 10:39:24 INFO - ##### 10:39:24 INFO - ##### Finished run-tests step (success) 10:39:24 INFO - ##### 10:39:24 INFO - Running post-run listener: _resource_record_post_run 10:39:24 INFO - Total resource usage - Wall time: 1198s; CPU: 13.0%; Read bytes: 4096; Write bytes: 562233344; Read time: 16; Write time: 514476 10:39:24 INFO - TinderboxPrint: CPU usage
13.4% 10:39:24 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 16 10:39:24 INFO - TinderboxPrint: I/O write bytes / time
562,233,344 / 514,476 10:39:24 INFO - TinderboxPrint: CPU idle
8,282.0 (86.6%) 10:39:24 INFO - TinderboxPrint: CPU user
1,220.6 (12.8%) 10:39:24 INFO - TinderboxPrint: Swap in / out
0 / 0 10:39:24 INFO - install - Wall time: 17s; CPU: 13.0%; Read bytes: 0; Write bytes: 246132736; Read time: 0; Write time: 234196 10:39:24 INFO - run-tests - Wall time: 1182s; CPU: 13.0%; Read bytes: 0; Write bytes: 299753472; Read time: 0; Write time: 275152 10:39:25 INFO - Running post-run listener: _upload_blobber_files 10:39:25 INFO - Blob upload gear active. 10:39:25 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:39:25 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 10:39:25 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'] 10:39:25 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 10:39:25 INFO - (blobuploader) - INFO - Open directory for files ... 10:39:25 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:39:25 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:25 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:39:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:26 INFO - (blobuploader) - INFO - Done attempting. 10:39:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:39:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:29 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:39:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:29 INFO - (blobuploader) - INFO - Done attempting. 10:39:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:39:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:39:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:39:30 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:39:30 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:39:30 INFO - (blobuploader) - INFO - Done attempting. 10:39:30 INFO - (blobuploader) - INFO - Iteration through files over. 10:39:30 INFO - Return code: 0 10:39:30 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:39:30 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:39:30 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fe49b7acbbadb09c28c874d1d4c8ab7eb150f0d4785d78145cd85fc28e10ee6a7e3c1b6905b73f156f843fff4db1f3ac30bf8646cec716bae6f1cb5c3fc76a60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1da9be801040d47598708dbd7de21ac94ecedd7c191c732944a55f128a54fb3897cdc9473a6a1b1ef7896e1299e54794f2861f8301d397729b8639301a34b0e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e758aac8e7eb01667f28444b50e1bf0dd605adf3192f59f409579a7ac0b3f927ef33c45506c0bd831e5730ed20a72d969d745d35ad79218205f888a749fd5b8"} 10:39:30 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:39:30 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:39:30 INFO - Contents: 10:39:30 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/fe49b7acbbadb09c28c874d1d4c8ab7eb150f0d4785d78145cd85fc28e10ee6a7e3c1b6905b73f156f843fff4db1f3ac30bf8646cec716bae6f1cb5c3fc76a60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1da9be801040d47598708dbd7de21ac94ecedd7c191c732944a55f128a54fb3897cdc9473a6a1b1ef7896e1299e54794f2861f8301d397729b8639301a34b0e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e758aac8e7eb01667f28444b50e1bf0dd605adf3192f59f409579a7ac0b3f927ef33c45506c0bd831e5730ed20a72d969d745d35ad79218205f888a749fd5b8"} 10:39:30 INFO - Running post-run listener: copy_logs_to_upload_dir 10:39:30 INFO - Copying logs to upload dir... 10:39:30 INFO - mkdir: /builds/slave/test/build/upload/logs 10:39:30 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1236.588670 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 36 secs) (at 2016-07-07 10:39:30.506875) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 10:39:30.510736) ========= 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=4300f881736b422476174874000001bc-1467911931.529568-1934334358 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/fe49b7acbbadb09c28c874d1d4c8ab7eb150f0d4785d78145cd85fc28e10ee6a7e3c1b6905b73f156f843fff4db1f3ac30bf8646cec716bae6f1cb5c3fc76a60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1da9be801040d47598708dbd7de21ac94ecedd7c191c732944a55f128a54fb3897cdc9473a6a1b1ef7896e1299e54794f2861f8301d397729b8639301a34b0e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e758aac8e7eb01667f28444b50e1bf0dd605adf3192f59f409579a7ac0b3f927ef33c45506c0bd831e5730ed20a72d969d745d35ad79218205f888a749fd5b8"} build_url:https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011377 build_url: 'https://queue.taskcluster.net/v1/task/JbtWWRLuQFmverP6BGTZJQ/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/fe49b7acbbadb09c28c874d1d4c8ab7eb150f0d4785d78145cd85fc28e10ee6a7e3c1b6905b73f156f843fff4db1f3ac30bf8646cec716bae6f1cb5c3fc76a60", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/1da9be801040d47598708dbd7de21ac94ecedd7c191c732944a55f128a54fb3897cdc9473a6a1b1ef7896e1299e54794f2861f8301d397729b8639301a34b0e1", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team-Non-PGO/sha512/2e758aac8e7eb01667f28444b50e1bf0dd605adf3192f59f409579a7ac0b3f927ef33c45506c0bd831e5730ed20a72d969d745d35ad79218205f888a749fd5b8"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-07 10:39:30.539914) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:39:30.540331) ========= 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=4300f881736b422476174874000001bc-1467911931.529568-1934334358 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004422 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-07 10:39:30.623487) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 10:39:30.623838) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-07 10:39:30.624256) ========= ========= Total master_lag: 0.19 =========