builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s-pgo slave: talos-linux64-ix-047 starttime: 1468861652.57 results: success (0) buildid: 20160718073057 builduid: 773a4b6febf445eab068aa4e2264db3a revision: fe6985c6e61601b6906304015de6695d25db9e4d ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:32.570903) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:32.571391) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:32.571665) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:32.586086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:32.586419) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2016-07-18 10:07:32-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 49.7M=0s 2016-07-18 10:07:32 (49.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.116591 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:32.732031) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:32.732361) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.018288 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:32.781873) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 10:07:32.785228) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev fe6985c6e61601b6906304015de6695d25db9e4d --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev fe6985c6e61601b6906304015de6695d25db9e4d --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=03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2016-07-18 10:07:33,070 truncating revision to first 12 chars 2016-07-18 10:07:33,070 Setting DEBUG logging. 2016-07-18 10:07:33,070 attempt 1/10 2016-07-18 10:07:33,070 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/fe6985c6e616?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-18 10:07:34,314 unpacking tar archive at: mozilla-central-fe6985c6e616/testing/mozharness/ program finished with exit code 0 elapsedTime=1.572535 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-18 10:07:34.370915) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:34.374247) ========= script_repo_revision: fe6985c6e61601b6906304015de6695d25db9e4d ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:34.374646) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:34.374904) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-18 10:07:34.384907) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-18 10:07:34.385167) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 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', 'Firefox', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] 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=03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 10:07:34 INFO - MultiFileLogger online at 20160718 10:07:34 in /builds/slave/test 10:07:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 10:07:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:07:34 INFO - {'append_to_log': False, 10:07:34 INFO - 'base_work_dir': '/builds/slave/test', 10:07:34 INFO - 'blob_upload_branch': 'Firefox', 10:07:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:07:34 INFO - 'branch': 'Firefox', 10:07:34 INFO - 'buildbot_json_path': 'buildprops.json', 10:07:34 INFO - 'config_files': ('talos/linux_config.py',), 10:07:34 INFO - 'default_actions': ('clobber', 10:07:34 INFO - 'read-buildbot-config', 10:07:34 INFO - 'download-and-extract', 10:07:34 INFO - 'populate-webroot', 10:07:34 INFO - 'create-virtualenv', 10:07:34 INFO - 'install', 10:07:34 INFO - 'run-tests'), 10:07:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:07:34 INFO - 'download_minidump_stackwalk': True, 10:07:34 INFO - 'download_symbols': 'ondemand', 10:07:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:07:34 INFO - 'tooltool.py': '/tools/tooltool.py', 10:07:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:07:34 INFO - '/tools/misc-python/virtualenv.py')}, 10:07:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:07:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:07:34 INFO - 'installer_path': 'installer.exe', 10:07:34 INFO - 'log_level': 'info', 10:07:34 INFO - 'log_name': 'talos', 10:07:34 INFO - 'log_to_console': True, 10:07:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 10:07:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 10:07:34 INFO - 'opt_config_files': (), 10:07:34 INFO - 'pip_index': False, 10:07:34 INFO - 'sps_profile': False, 10:07:34 INFO - 'sps_profile_interval': 0, 10:07:34 INFO - 'suite': 'dromaeojs-e10s', 10:07:34 INFO - 'system_bits': '32', 10:07:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:07:34 INFO - 'title': 'talos-linux64-ix-047', 10:07:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:07:34 INFO - 'use_talos_json': True, 10:07:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:07:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:07:34 INFO - 'work_dir': 'build'} 10:07:34 INFO - ##### 10:07:34 INFO - ##### Running clobber step. 10:07:34 INFO - ##### 10:07:34 INFO - Running pre-action listener: _resource_record_pre_action 10:07:34 INFO - Running main action method: clobber 10:07:34 INFO - rmtree: /builds/slave/test/build 10:07:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:07:35 INFO - Running post-action listener: _resource_record_post_action 10:07:35 INFO - ##### 10:07:35 INFO - ##### Finished clobber step (success) 10:07:35 INFO - ##### 10:07:35 INFO - ##### 10:07:35 INFO - ##### Running read-buildbot-config step. 10:07:35 INFO - ##### 10:07:35 INFO - Running pre-action listener: _resource_record_pre_action 10:07:35 INFO - Running main action method: read_buildbot_config 10:07:35 INFO - Using buildbot properties: 10:07:35 INFO - { 10:07:35 INFO - "project": "", 10:07:35 INFO - "product": "firefox", 10:07:35 INFO - "script_repo_revision": "production", 10:07:35 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 10:07:35 INFO - "repository": "", 10:07:35 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central pgo talos dromaeojs-e10s", 10:07:35 INFO - "buildid": "20160718073057", 10:07:35 INFO - "pgo_build": "True", 10:07:35 INFO - "basedir": "/builds/slave/test", 10:07:35 INFO - "buildnumber": 296, 10:07:35 INFO - "slavename": "talos-linux64-ix-047", 10:07:35 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 10:07:35 INFO - "platform": "ubuntu64_hw", 10:07:35 INFO - "scheduler": "tests-mozilla-central-linux64-pgo-talos", 10:07:35 INFO - "branch": "mozilla-central", 10:07:35 INFO - "repo_path": "mozilla-central", 10:07:35 INFO - "revision": "fe6985c6e61601b6906304015de6695d25db9e4d", 10:07:35 INFO - "stage_platform": "linux64-pgo", 10:07:35 INFO - "builduid": "773a4b6febf445eab068aa4e2264db3a", 10:07:35 INFO - "slavebuilddir": "test" 10:07:35 INFO - } 10:07:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2. 10:07:35 INFO - Running post-action listener: _resource_record_post_action 10:07:35 INFO - ##### 10:07:35 INFO - ##### Finished read-buildbot-config step (success) 10:07:35 INFO - ##### 10:07:35 INFO - ##### 10:07:35 INFO - ##### Running download-and-extract step. 10:07:35 INFO - ##### 10:07:35 INFO - Running pre-action listener: _resource_record_pre_action 10:07:35 INFO - Running main action method: download_and_extract 10:07:35 INFO - mkdir: /builds/slave/test/build/tests 10:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:35 INFO - https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json matches https://queue.taskcluster.net 10:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/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:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/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:07:35 INFO - Downloaded 1361 bytes. 10:07:35 INFO - Reading from file /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.test_packages.json 10:07:35 INFO - Using the following test package requirements: 10:07:35 INFO - {u'common': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:35 INFO - u'cppunittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 10:07:35 INFO - u'gtest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.gtest.tests.zip'], 10:07:35 INFO - u'jittest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:35 INFO - u'jsshell-linux-x86_64.zip'], 10:07:35 INFO - u'mochitest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 10:07:35 INFO - u'mozbase': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'], 10:07:35 INFO - u'reftest': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.reftest.tests.zip'], 10:07:35 INFO - u'talos': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip'], 10:07:35 INFO - u'web-platform': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 10:07:35 INFO - u'xpcshell': [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', 10:07:35 INFO - u'firefox-50.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 10:07:35 INFO - Downloading packages: [u'firefox-50.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 10:07:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:35 INFO - https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/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:07:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/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:07:37 INFO - Downloaded 24332152 bytes. 10:07:37 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:07:37 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:07:38 INFO - Return code: 0 10:07:38 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:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:38 INFO - https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 10:07:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip 10:07:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/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:07:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/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:07:39 INFO - Downloaded 24332152 bytes. 10:07:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 10:07:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-50.0a1.en-US.linux-x86_64.common.tests.zip -d /builds/slave/test/build/tests 10:07:40 INFO - Return code: 0 10:07:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:40 INFO - https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 10:07:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.talos.tests.zip 10:07:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/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:07:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/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:07:41 INFO - Downloaded 14403317 bytes. 10:07:41 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:07:41 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:07:42 INFO - Return code: 0 10:07: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:07:42 INFO - https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 10:07:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/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:07:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/C-FyW77_RrmWjL1rIB7ytw/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:07:43 INFO - Downloaded 60812359 bytes. 10:07:43 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:43 INFO - mkdir: /builds/slave/test/properties 10:07:43 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:07:43 INFO - Writing to file /builds/slave/test/properties/build_url 10:07:43 INFO - Contents: 10:07:43 INFO - build_url:https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 10:07:44 INFO - Running post-action listener: _resource_record_post_action 10:07:44 INFO - Running post-action listener: set_extra_try_arguments 10:07:44 INFO - ##### 10:07:44 INFO - ##### Finished download-and-extract step (success) 10:07:44 INFO - ##### 10:07:44 INFO - ##### 10:07:44 INFO - ##### Running populate-webroot step. 10:07:44 INFO - ##### 10:07:44 INFO - Running pre-action listener: _resource_record_pre_action 10:07:44 INFO - Running main action method: populate_webroot 10:07:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:07:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:07:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:07:44 INFO - '--tppagecycles', 10:07:44 INFO - '7'], 10:07:44 INFO - 'tests': ['tsvgm']}}, 10:07:44 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:07:44 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 10:07:44 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:07:44 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 10:07:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:07:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['damp', 'tps']}, 10:07:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'tests': ['damp', 'tps']}, 10:07:44 INFO - 'g3': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['dromaeo_dom']}, 10:07:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:07:44 INFO - 'g4': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['basic_compositor_video']}, 10:07:44 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 10:07:44 INFO - 'other': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'other-e10s': {'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'other-e10s_l64': {'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['a11yr', 10:07:44 INFO - 'ts_paint', 10:07:44 INFO - 'tpaint', 10:07:44 INFO - 'sessionrestore', 10:07:44 INFO - 'sessionrestore_no_auto_restore', 10:07:44 INFO - 'tabpaint']}, 10:07:44 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['tsvgx', 10:07:44 INFO - 'tsvgr_opacity', 10:07:44 INFO - 'tart', 10:07:44 INFO - 'tscrollx', 10:07:44 INFO - 'cart']}, 10:07:44 INFO - 'svgr-e10s': {'tests': ['tsvgx', 10:07:44 INFO - 'tsvgr_opacity', 10:07:44 INFO - 'tart', 10:07:44 INFO - 'tscrollx', 10:07:44 INFO - 'cart']}, 10:07:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'talos_options': ['--disable-e10s'], 10:07:44 INFO - 'tests': ['tp5o']}, 10:07:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'tests': ['tp5o']}, 10:07:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'talos_options': ['--disable-e10s', 10:07:44 INFO - '--xperf_path', 10:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:44 INFO - 'tests': ['tp5n']}, 10:07:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:07:44 INFO - 'talos_options': ['--xperf_path', 10:07:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:07:44 INFO - 'tests': ['tp5n']}}, 10:07:44 INFO - 'talos.zip': {'path': '', 10:07:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:07:44 INFO - Running post-action listener: _resource_record_post_action 10:07:44 INFO - ##### 10:07:44 INFO - ##### Finished populate-webroot step (success) 10:07:44 INFO - ##### 10:07:44 INFO - ##### 10:07:44 INFO - ##### Running create-virtualenv step. 10:07:44 INFO - ##### 10:07:44 INFO - Running pre-action listener: _resource_record_pre_action 10:07:44 INFO - Running main action method: create_virtualenv 10:07:44 INFO - Creating virtualenv /builds/slave/test/build/venv 10:07:44 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:07:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:07:44 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:07:44 INFO - Using real prefix '/usr' 10:07:44 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:07:44 INFO - Installing distribute.............................................................................................................................................................................................done. 10:07:46 INFO - Installing pip.................done. 10:07:46 INFO - Return code: 0 10:07:46 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:07:46 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:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:46 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:07:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:46 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 0xed9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11983b0>, '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 0x11992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1199740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', '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:07:46 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:07:46 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:07:46 INFO - Using env: {'DISPLAY': ':0', 10:07:46 INFO - 'HOME': '/home/cltbld', 10:07:46 INFO - 'LANG': 'en_US.UTF-8', 10:07:46 INFO - 'LANGUAGE': 'en_US:en', 10:07:46 INFO - 'LOGNAME': 'cltbld', 10:07:46 INFO - 'MAIL': '/var/mail/cltbld', 10:07:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:46 INFO - 'MOZ_NO_REMOTE': '1', 10:07:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:46 INFO - 'NO_EM_RESTART': '1', 10:07:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:46 INFO - 'PWD': '/builds/slave/test', 10:07:46 INFO - 'SHELL': '/bin/bash', 10:07:46 INFO - 'SHLVL': '1', 10:07:46 INFO - 'TERM': 'linux', 10:07:46 INFO - 'TMOUT': '86400', 10:07:46 INFO - 'USER': 'cltbld', 10:07:46 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', 10:07:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:46 INFO - '_': '/tools/buildbot/bin/python'} 10:07:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:46 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:07:46 INFO - Cleaning up... 10:07:46 INFO - Return code: 0 10:07:46 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 10:07:46 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:07:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xed9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11983b0>, '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 0x11992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1199740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', '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:07:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 10:07:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 10:07:47 INFO - Using env: {'DISPLAY': ':0', 10:07:47 INFO - 'HOME': '/home/cltbld', 10:07:47 INFO - 'LANG': 'en_US.UTF-8', 10:07:47 INFO - 'LANGUAGE': 'en_US:en', 10:07:47 INFO - 'LOGNAME': 'cltbld', 10:07:47 INFO - 'MAIL': '/var/mail/cltbld', 10:07:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:47 INFO - 'MOZ_NO_REMOTE': '1', 10:07:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:47 INFO - 'NO_EM_RESTART': '1', 10:07:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:47 INFO - 'PWD': '/builds/slave/test', 10:07:47 INFO - 'SHELL': '/bin/bash', 10:07:47 INFO - 'SHLVL': '1', 10:07:47 INFO - 'TERM': 'linux', 10:07:47 INFO - 'TMOUT': '86400', 10:07:47 INFO - 'USER': 'cltbld', 10:07:47 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', 10:07:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:47 INFO - '_': '/tools/buildbot/bin/python'} 10:07:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:47 INFO - Downloading/unpacking psutil>=3.1.1 10:07:47 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:07:47 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:07:47 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:07:47 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:07:47 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:07:47 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:07:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:07:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:49 INFO - Installing collected packages: psutil 10:07:49 INFO - Running setup.py install for psutil 10:07:49 INFO - building 'psutil._psutil_linux' extension 10:07:49 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:07:49 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:07:49 INFO - building 'psutil._psutil_posix' extension 10:07:49 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:07:49 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:07:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:07:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:07:49 INFO - Successfully installed psutil 10:07:49 INFO - Cleaning up... 10:07:49 INFO - Return code: 0 10:07:49 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 10:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0xed9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11983b0>, '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 0x11992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1199740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', '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:07:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 10:07:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 10:07:49 INFO - Using env: {'DISPLAY': ':0', 10:07:49 INFO - 'HOME': '/home/cltbld', 10:07:49 INFO - 'LANG': 'en_US.UTF-8', 10:07:49 INFO - 'LANGUAGE': 'en_US:en', 10:07:49 INFO - 'LOGNAME': 'cltbld', 10:07:49 INFO - 'MAIL': '/var/mail/cltbld', 10:07:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:49 INFO - 'MOZ_NO_REMOTE': '1', 10:07:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:49 INFO - 'NO_EM_RESTART': '1', 10:07:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:49 INFO - 'PWD': '/builds/slave/test', 10:07:49 INFO - 'SHELL': '/bin/bash', 10:07:49 INFO - 'SHLVL': '1', 10:07:49 INFO - 'TERM': 'linux', 10:07:49 INFO - 'TMOUT': '86400', 10:07:49 INFO - 'USER': 'cltbld', 10:07:49 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', 10:07:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:49 INFO - '_': '/tools/buildbot/bin/python'} 10:07:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 10:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 10:07:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:07:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 10:07:52 INFO - Installing collected packages: mozsystemmonitor 10:07:52 INFO - Running setup.py install for mozsystemmonitor 10:07:52 INFO - Successfully installed mozsystemmonitor 10:07:52 INFO - Cleaning up... 10:07:52 INFO - Return code: 0 10:07:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xed9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11983b0>, '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 0x11992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1199740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', '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:07:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 10:07:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 10:07:52 INFO - Using env: {'DISPLAY': ':0', 10:07:52 INFO - 'HOME': '/home/cltbld', 10:07:52 INFO - 'LANG': 'en_US.UTF-8', 10:07:52 INFO - 'LANGUAGE': 'en_US:en', 10:07:52 INFO - 'LOGNAME': 'cltbld', 10:07:52 INFO - 'MAIL': '/var/mail/cltbld', 10:07:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:52 INFO - 'MOZ_NO_REMOTE': '1', 10:07:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:52 INFO - 'NO_EM_RESTART': '1', 10:07:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:52 INFO - 'PWD': '/builds/slave/test', 10:07:52 INFO - 'SHELL': '/bin/bash', 10:07:52 INFO - 'SHLVL': '1', 10:07:52 INFO - 'TERM': 'linux', 10:07:52 INFO - 'TMOUT': '86400', 10:07:52 INFO - 'USER': 'cltbld', 10:07:52 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', 10:07:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:52 INFO - '_': '/tools/buildbot/bin/python'} 10:07:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:52 INFO - Downloading/unpacking jsonschema==2.5.1 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:54 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:07:54 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 10:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:54 INFO - Downloading functools32-3.2.3-2.tar.gz 10:07:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:07:54 INFO - warning: no files found matching '*.txt' 10:07:54 INFO - no previously-included directories found matching 'build' 10:07:54 INFO - no previously-included directories found matching 'dist' 10:07:54 INFO - no previously-included directories found matching '.git*' 10:07:54 INFO - Installing collected packages: jsonschema, functools32 10:07:54 INFO - Running setup.py install for functools32 10:07:54 INFO - warning: no files found matching '*.txt' 10:07:54 INFO - no previously-included directories found matching 'build' 10:07:54 INFO - no previously-included directories found matching 'dist' 10:07:54 INFO - no previously-included directories found matching '.git*' 10:07:54 INFO - Successfully installed jsonschema functools32 10:07:54 INFO - Cleaning up... 10:07:54 INFO - Return code: 0 10:07:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:07: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:07:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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:07:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0xed9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11983b0>, '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 0x11992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1199740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', '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:07:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 10:07:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 10:07:54 INFO - Using env: {'DISPLAY': ':0', 10:07:54 INFO - 'HOME': '/home/cltbld', 10:07:54 INFO - 'LANG': 'en_US.UTF-8', 10:07:54 INFO - 'LANGUAGE': 'en_US:en', 10:07:54 INFO - 'LOGNAME': 'cltbld', 10:07:54 INFO - 'MAIL': '/var/mail/cltbld', 10:07:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:54 INFO - 'MOZ_NO_REMOTE': '1', 10:07:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:54 INFO - 'NO_EM_RESTART': '1', 10:07:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:54 INFO - 'PWD': '/builds/slave/test', 10:07:54 INFO - 'SHELL': '/bin/bash', 10:07:54 INFO - 'SHLVL': '1', 10:07:54 INFO - 'TERM': 'linux', 10:07:54 INFO - 'TMOUT': '86400', 10:07:54 INFO - 'USER': 'cltbld', 10:07:54 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', 10:07:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:54 INFO - '_': '/tools/buildbot/bin/python'} 10:07:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:55 INFO - Downloading/unpacking blobuploader==1.2.4 10:07:55 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:07:55 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:07:55 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:07:55 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:07:55 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:07:55 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:07:56 INFO - Downloading blobuploader-1.2.4.tar.gz 10:07:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:07:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:07:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:07:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:07:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:07:57 INFO - Downloading docopt-0.6.1.tar.gz 10:07:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:07:57 INFO - Installing collected packages: blobuploader, requests, docopt 10:07:57 INFO - Running setup.py install for blobuploader 10:07:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:07:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:07:57 INFO - Running setup.py install for requests 10:07:58 INFO - Running setup.py install for docopt 10:07:58 INFO - Successfully installed blobuploader requests docopt 10:07:58 INFO - Cleaning up... 10:07:58 INFO - Return code: 0 10:07:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:07: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:07:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:07:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07: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:07:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:07:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:07:58 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 0xed9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11983b0>, '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 0x11992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1199740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', '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:07:58 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:07:58 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:07:58 INFO - Using env: {'DISPLAY': ':0', 10:07:58 INFO - 'HOME': '/home/cltbld', 10:07:58 INFO - 'LANG': 'en_US.UTF-8', 10:07:58 INFO - 'LANGUAGE': 'en_US:en', 10:07:58 INFO - 'LOGNAME': 'cltbld', 10:07:58 INFO - 'MAIL': '/var/mail/cltbld', 10:07:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:07:58 INFO - 'MOZ_NO_REMOTE': '1', 10:07:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:07:58 INFO - 'NO_EM_RESTART': '1', 10:07:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:07:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:07:58 INFO - 'PWD': '/builds/slave/test', 10:07:58 INFO - 'SHELL': '/bin/bash', 10:07:58 INFO - 'SHLVL': '1', 10:07:58 INFO - 'TERM': 'linux', 10:07:58 INFO - 'TMOUT': '86400', 10:07:58 INFO - 'USER': 'cltbld', 10:07:58 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', 10:07:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:07:58 INFO - '_': '/tools/buildbot/bin/python'} 10:07:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:07:58 INFO - Running setup.py (path:/tmp/pip-BJzUHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:07:58 INFO - Running setup.py (path:/tmp/pip-GVFRQN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:07:58 INFO - Running setup.py (path:/tmp/pip-L4rg9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:07:58 INFO - Running setup.py (path:/tmp/pip-X3vGkV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:07:58 INFO - Running setup.py (path:/tmp/pip-Og_7Sh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:07:58 INFO - Running setup.py (path:/tmp/pip-rz6atG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:07:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:07:58 INFO - Running setup.py (path:/tmp/pip-otuO7p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:07:59 INFO - Running setup.py (path:/tmp/pip-omwwnr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:07:59 INFO - Running setup.py (path:/tmp/pip-aDB7Vl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:07:59 INFO - Running setup.py (path:/tmp/pip-N_K0oE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:07:59 INFO - Running setup.py (path:/tmp/pip-q8xfox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:07:59 INFO - Running setup.py (path:/tmp/pip-_OowRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:07:59 INFO - Running setup.py (path:/tmp/pip-YRTckv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:07:59 INFO - Running setup.py (path:/tmp/pip-A18WCV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:59 INFO - Running setup.py (path:/tmp/pip-syjGCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:07:59 INFO - Running setup.py (path:/tmp/pip-2hgwOc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:07:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:07:59 INFO - Running setup.py (path:/tmp/pip-E3MxnC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:07:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:07:59 INFO - Running setup.py install for manifestparser 10:07:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:07:59 INFO - Running setup.py install for mozcrash 10:07:59 INFO - Running setup.py install for mozdebug 10:08:00 INFO - Running setup.py install for mozdevice 10:08:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozfile 10:08:00 INFO - Running setup.py install for mozhttpd 10:08:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozinfo 10:08:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozInstall 10:08:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozleak 10:08:00 INFO - Running setup.py install for mozlog 10:08:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for moznetwork 10:08:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:08:00 INFO - Running setup.py install for mozprocess 10:08:01 INFO - Running setup.py install for mozprofile 10:08:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Running setup.py install for mozrunner 10:08:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Running setup.py install for mozscreenshot 10:08:01 INFO - Running setup.py install for moztest 10:08:01 INFO - Running setup.py install for mozversion 10:08:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:08:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:08:01 INFO - Cleaning up... 10:08:01 INFO - Return code: 0 10:08:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:08:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:01 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 0xed9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11983b0>, '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 0x11992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1199740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', '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:08:01 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:08:01 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:08:01 INFO - Using env: {'DISPLAY': ':0', 10:08:01 INFO - 'HOME': '/home/cltbld', 10:08:01 INFO - 'LANG': 'en_US.UTF-8', 10:08:01 INFO - 'LANGUAGE': 'en_US:en', 10:08:01 INFO - 'LOGNAME': 'cltbld', 10:08:01 INFO - 'MAIL': '/var/mail/cltbld', 10:08:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:01 INFO - 'MOZ_NO_REMOTE': '1', 10:08:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:01 INFO - 'NO_EM_RESTART': '1', 10:08:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:01 INFO - 'PWD': '/builds/slave/test', 10:08:01 INFO - 'SHELL': '/bin/bash', 10:08:01 INFO - 'SHLVL': '1', 10:08:01 INFO - 'TERM': 'linux', 10:08:01 INFO - 'TMOUT': '86400', 10:08:01 INFO - 'USER': 'cltbld', 10:08:01 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', 10:08:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:01 INFO - '_': '/tools/buildbot/bin/python'} 10:08:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:08:01 INFO - Running setup.py (path:/tmp/pip-coXTvz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:08:01 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:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:08:01 INFO - Running setup.py (path:/tmp/pip-kZezuj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:08:01 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:08:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:08:01 INFO - Running setup.py (path:/tmp/pip-dSoUKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:08:02 INFO - Running setup.py (path:/tmp/pip-a1VR8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:08:02 INFO - Running setup.py (path:/tmp/pip-ILnqst-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:08:02 INFO - Running setup.py (path:/tmp/pip-wFanrs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:08:02 INFO - Running setup.py (path:/tmp/pip-upTBXb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:08:02 INFO - Running setup.py (path:/tmp/pip-OKUzWw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:08:02 INFO - Running setup.py (path:/tmp/pip-usZxmm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:08:02 INFO - Running setup.py (path:/tmp/pip-9zN2A4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:08:02 INFO - Running setup.py (path:/tmp/pip-LG9ua2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:08:02 INFO - Running setup.py (path:/tmp/pip-N9Q9Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:08:02 INFO - Running setup.py (path:/tmp/pip-bVOHlT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:08:02 INFO - Running setup.py (path:/tmp/pip-IuP9eu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:02 INFO - Running setup.py (path:/tmp/pip-JMnEtC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:08:02 INFO - Running setup.py (path:/tmp/pip-5GUXqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:08:02 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:08:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:08:02 INFO - Running setup.py (path:/tmp/pip-ksmwxy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:08:03 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:08:03 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:08:03 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:08:03 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:08:03 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:08:03 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:08:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.2->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:08:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:08:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:08:04 INFO - Downloading blessings-1.6.tar.gz 10:08:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:08:05 INFO - Installing collected packages: blessings 10:08:05 INFO - Running setup.py install for blessings 10:08:05 INFO - Successfully installed blessings 10:08:05 INFO - Cleaning up... 10:08:05 INFO - Return code: 0 10:08:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:05 INFO - Reading from file tmpfile_stdout 10:08:05 INFO - Current package versions: 10:08:05 INFO - argparse == 1.2.1 10:08:05 INFO - blessings == 1.6 10:08:05 INFO - blobuploader == 1.2.4 10:08:05 INFO - docopt == 0.6.1 10:08:05 INFO - functools32 == 3.2.3-2 10:08:05 INFO - jsonschema == 2.5.1 10:08:05 INFO - manifestparser == 1.1 10:08:05 INFO - mozInstall == 1.12 10:08:05 INFO - mozcrash == 0.17 10:08:05 INFO - mozdebug == 0.1 10:08:05 INFO - mozdevice == 0.48 10:08:05 INFO - mozfile == 1.2 10:08:05 INFO - mozhttpd == 0.7 10:08:05 INFO - mozinfo == 0.9 10:08:05 INFO - mozleak == 0.1 10:08:05 INFO - mozlog == 3.2 10:08:05 INFO - moznetwork == 0.27 10:08:05 INFO - mozprocess == 0.23 10:08:05 INFO - mozprofile == 0.28 10:08:05 INFO - mozrunner == 6.12 10:08:05 INFO - mozscreenshot == 0.1 10:08:05 INFO - mozsystemmonitor == 0.3 10:08:05 INFO - moztest == 0.7 10:08:05 INFO - mozversion == 1.4 10:08:05 INFO - psutil == 3.1.1 10:08:05 INFO - requests == 1.2.3 10:08:05 INFO - wsgiref == 0.1.2 10:08:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:08:05 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:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:05 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:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:05 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 0xed9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11983b0>, '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 0x11992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1199740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', '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:08:05 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:08:05 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:08:05 INFO - Using env: {'DISPLAY': ':0', 10:08:05 INFO - 'HOME': '/home/cltbld', 10:08:05 INFO - 'LANG': 'en_US.UTF-8', 10:08:05 INFO - 'LANGUAGE': 'en_US:en', 10:08:05 INFO - 'LOGNAME': 'cltbld', 10:08:05 INFO - 'MAIL': '/var/mail/cltbld', 10:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:05 INFO - 'MOZ_NO_REMOTE': '1', 10:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:05 INFO - 'NO_EM_RESTART': '1', 10:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:05 INFO - 'PWD': '/builds/slave/test', 10:08:05 INFO - 'SHELL': '/bin/bash', 10:08:05 INFO - 'SHLVL': '1', 10:08:05 INFO - 'TERM': 'linux', 10:08:05 INFO - 'TMOUT': '86400', 10:08:05 INFO - 'USER': 'cltbld', 10:08:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', 10:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:05 INFO - '_': '/tools/buildbot/bin/python'} 10:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:05 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:08:05 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:08:05 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:08:05 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:08:05 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:08:05 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:08:05 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:08:05 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:08:05 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:08:05 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:08:05 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:08:05 INFO - Cleaning up... 10:08:05 INFO - Return code: 0 10:08:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:08:05 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:08:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:08:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:05 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:08:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:08:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:08:05 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 0xed9030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x119a180>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11983b0>, '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 0x11992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1199740>, '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': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', '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:08:05 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:08:05 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:08:05 INFO - Using env: {'DISPLAY': ':0', 10:08:05 INFO - 'HOME': '/home/cltbld', 10:08:05 INFO - 'LANG': 'en_US.UTF-8', 10:08:05 INFO - 'LANGUAGE': 'en_US:en', 10:08:05 INFO - 'LOGNAME': 'cltbld', 10:08:05 INFO - 'MAIL': '/var/mail/cltbld', 10:08:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:05 INFO - 'MOZ_NO_REMOTE': '1', 10:08:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:05 INFO - 'NO_EM_RESTART': '1', 10:08:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:05 INFO - 'PWD': '/builds/slave/test', 10:08:05 INFO - 'SHELL': '/bin/bash', 10:08:05 INFO - 'SHLVL': '1', 10:08:05 INFO - 'TERM': 'linux', 10:08:05 INFO - 'TMOUT': '86400', 10:08:05 INFO - 'USER': 'cltbld', 10:08:05 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', 10:08:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:05 INFO - '_': '/tools/buildbot/bin/python'} 10:08:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:08:05 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 10:08:05 INFO - Cleaning up... 10:08:05 INFO - Return code: 0 10:08:05 INFO - Running post-action listener: _resource_record_post_action 10:08:05 INFO - Running post-action listener: _start_resource_monitoring 10:08:05 INFO - Starting resource monitoring. 10:08:05 INFO - ##### 10:08:05 INFO - ##### Finished create-virtualenv step (success) 10:08:05 INFO - ##### 10:08:05 INFO - ##### 10:08:05 INFO - ##### Running install step. 10:08:05 INFO - ##### 10:08:05 INFO - Running pre-action listener: _resource_record_pre_action 10:08:05 INFO - Running main action method: install 10:08:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:08:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:08:06 INFO - Reading from file tmpfile_stdout 10:08:06 INFO - Detecting whether we're running mozinstall >=1.0... 10:08:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:08:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:08:06 INFO - Reading from file tmpfile_stdout 10:08:06 INFO - Output received: 10:08:06 INFO - Usage: mozinstall [options] installer 10:08:06 INFO - Options: 10:08:06 INFO - -h, --help show this help message and exit 10:08:06 INFO - -d DEST, --destination=DEST 10:08:06 INFO - Directory to install application into. [default: 10:08:06 INFO - "/builds/slave/test"] 10:08:06 INFO - --app=APP Application being installed. [default: firefox] 10:08:06 INFO - mkdir: /builds/slave/test/build/application 10:08:06 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:08:06 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:08:23 INFO - Reading from file tmpfile_stdout 10:08:23 INFO - Output received: 10:08:23 INFO - /builds/slave/test/build/application/firefox/firefox 10:08:23 INFO - Running post-action listener: _resource_record_post_action 10:08:23 INFO - ##### 10:08:23 INFO - ##### Finished install step (success) 10:08:23 INFO - ##### 10:08:23 INFO - ##### 10:08:23 INFO - ##### Running run-tests step. 10:08:23 INFO - ##### 10:08:23 INFO - Running pre-action listener: _resource_record_pre_action 10:08:23 INFO - Running main action method: run_tests 10:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:08:23 INFO - Python 2.7.3 10:08:23 INFO - Return code: 0 10:08:23 INFO - grabbing minidump binary from tooltool 10:08:23 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:08:23 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 0x11983b0>, '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 0x11992b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1199740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:08:23 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:08:23 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:08:23 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:08:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:08:23 INFO - Return code: 0 10:08:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 10:08:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:08:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:08:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 10:08:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:08:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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:08:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --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:08:23 INFO - Using env: {'DISPLAY': ':0', 10:08:23 INFO - 'HOME': '/home/cltbld', 10:08:23 INFO - 'LANG': 'en_US.UTF-8', 10:08:23 INFO - 'LANGUAGE': 'en_US:en', 10:08:23 INFO - 'LOGNAME': 'cltbld', 10:08:23 INFO - 'MAIL': '/var/mail/cltbld', 10:08:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:08:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 10:08:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:08:23 INFO - 'MOZ_NO_REMOTE': '1', 10:08:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:08:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 10:08:23 INFO - 'NO_EM_RESTART': '1', 10:08:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 10:08:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:08:23 INFO - 'PWD': '/builds/slave/test', 10:08:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:08:23 INFO - 'SHELL': '/bin/bash', 10:08:23 INFO - 'SHLVL': '1', 10:08:23 INFO - 'TERM': 'linux', 10:08:23 INFO - 'TMOUT': '86400', 10:08:23 INFO - 'USER': 'cltbld', 10:08:23 INFO - 'XDG_SESSION_COOKIE': '03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472', 10:08:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:08:23 INFO - '_': '/tools/buildbot/bin/python'} 10:08:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--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:08:23 INFO - mozversion application_buildid: 20160718073057 10:08:23 INFO - mozversion application_changeset: fe6985c6e61601b6906304015de6695d25db9e4d 10:08:23 INFO - mozversion application_display_name: Nightly 10:08:23 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:08:23 INFO - mozversion application_name: Firefox 10:08:23 INFO - mozversion application_remotingname: firefox 10:08:23 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:08:23 INFO - mozversion application_vendor: Mozilla 10:08:23 INFO - mozversion application_version: 50.0a1 10:08:23 INFO - mozversion platform_buildid: 20160718073057 10:08:23 INFO - mozversion platform_changeset: fe6985c6e61601b6906304015de6695d25db9e4d 10:08:23 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:08:23 INFO - mozversion platform_version: 50.0a1 10:08:23 INFO - using testdate: 1468861703 10:08:23 INFO - actual date: 1468861703 10:08:23 INFO - starting webserver on 'localhost:43509' 10:08:23 INFO - SUITE-START | Running 2 tests 10:08:23 INFO - TEST-START | dromaeo_css 10:08:23 INFO - operating with platform_type : linux_ 10:08:23 INFO - Initialising browser for dromaeo_css test... 10:08:23 INFO - TEST-INFO | started process 16255 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnNoadz/profile http://localhost:43509/getInfo.html) 10:08:28 INFO - PROCESS | 16255 | __metrics Screen width/height:1600/1200 10:08:28 INFO - PROCESS | 16255 | colorDepth:24 10:08:28 INFO - PROCESS | 16255 | Browser inner width/height: 1024/697 10:08:28 INFO - PROCESS | 16255 | __metrics 10:08:28 ERROR - PROCESS | 16255 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:08:29 INFO - TEST-INFO | 16255: exit 0 10:08:29 INFO - Browser initialized. 10:08:29 INFO - Running cycle 1/1 for dromaeo_css test... 10:08:29 INFO - TEST-INFO | started process 16375 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnNoadz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:08:41 INFO - PROCESS | 16375 | RSS: Main: 168062976 10:08:41 INFO - PROCESS | 16375 | 10:09:31 INFO - PROCESS | 16375 | 1468861771144 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:11:38 INFO - PROCESS | 16375 | Cycle 1(1): loaded http://localhost:43509/tests/dromaeo/cssquery-dojo.html (next: http://localhost:43509/tests/dromaeo/cssquery-ext.html) 10:11:39 INFO - PROCESS | 16375 | RSS: Main: 172244992 10:11:39 INFO - PROCESS | 16375 | 10:14:41 INFO - PROCESS | 16375 | Cycle 1(1): loaded http://localhost:43509/tests/dromaeo/cssquery-ext.html (next: http://localhost:43509/tests/dromaeo/cssquery-jquery.html) 10:14:42 INFO - PROCESS | 16375 | RSS: Main: 169009152 10:14:42 INFO - PROCESS | 16375 | 10:17:44 INFO - PROCESS | 16375 | Cycle 1(1): loaded http://localhost:43509/tests/dromaeo/cssquery-jquery.html (next: http://localhost:43509/tests/dromaeo/cssquery-mootools.html) 10:17:45 INFO - PROCESS | 16375 | RSS: Main: 171900928 10:17:45 INFO - PROCESS | 16375 | 10:20:46 INFO - PROCESS | 16375 | Cycle 1(1): loaded http://localhost:43509/tests/dromaeo/cssquery-mootools.html (next: http://localhost:43509/tests/dromaeo/cssquery-prototype.html) 10:20:47 INFO - PROCESS | 16375 | RSS: Main: 166440960 10:20:47 INFO - PROCESS | 16375 | 10:23:49 INFO - PROCESS | 16375 | Cycle 1(1): loaded http://localhost:43509/tests/dromaeo/cssquery-prototype.html (next: http://localhost:43509/tests/dromaeo/cssquery-yui.html) 10:23:50 INFO - PROCESS | 16375 | RSS: Main: 168849408 10:23:50 INFO - PROCESS | 16375 | 10:26:53 INFO - PROCESS | 16375 | Cycle 1(1): loaded http://localhost:43509/tests/dromaeo/cssquery-yui.html (next: http://localhost:43509/tests/dromaeo/cssquery-dojo.html) 10:26:53 INFO - PROCESS | 16375 | RSS: Main: 169779200 10:26:53 INFO - PROCESS | 16375 | 10:26:53 INFO - PROCESS | 16375 | __start_tp_report 10:26:53 INFO - PROCESS | 16375 | _x_x_mozilla_page_load 10:26:53 INFO - PROCESS | 16375 | _x_x_mozilla_page_load_details 10:26:53 INFO - PROCESS | 16375 | |i|pagename|runs| 10:26:53 INFO - PROCESS | 16375 | |0;dojo.html;3089.8146111233327;3111.7977331473453;3123.39093876694;3150.243941454049;3156.384505021522;5483.341998960131;5518.365387980379;5540.612157149001;5600.831975040745;5608.186812912125;5465.344158700961;5512.476314750103;5514.862128446791;5515.889682206353;5531.834044978647;5005.12410328192;5034.42104158021;5139.58883289336;5184.922226166611;5192.584593232532;607.9795206898294;4997.4003119625695;5006.824761133361;5076.720780357079;5157.329547158864;5036.1438555445475;5044.1677123274985;5048.1670524363435;5057.393112826466;5080.441151473354;5097.413797413308;5097.949020509822;5103.540681338697;5107.514786095315;5121.897562048738;4967.975160124176;4986.5013498650205;5026.597872170254;5039.168537191359;5061.772220250097;5564.054110801174;5567.721613919288;5577.2191893135;5594.804181853616;5606.439356064361;5788.855278618026;5995.2206213192;5995.700214989277;6006.879862402771;6018.879622407528;5837.09525023622;5872.911906321408;5882.588218824684;5941.346451890288;5949.048152295655;5514.117741161395;5515.365732940683;5518.19986102013;5523.226748255248;5529.944700553024;5945.40545945402;6084;6134.5092392608485;6167.660778657217;6167.6916154193;5840.3575606683235;5845;5845.941540584625;5846.6784326862435;5889.087191485327;5972.432618901197;5996.580239383288;5998.940010599926;6005.609635373687;6014.308354539196;5888.646681199141;5898.587098903122;5937.584369094208;5945.940540594625;5999.880002399927;5959.940400596025;5967.820965370959;6008.429199226067;6011.939880601138;6014.1580178775;4479.440069991251;4548.7725613719185;4550.863474095782;4551.0215303709865;4593;3942.0933185366953;3989.3617021276455;4000.179963107556;4044.352903535479;4056.59434056592;5565.053940830068;5573.665580065209;5605.271314729141;5638.605297629127;5752.165935939265;6026.367231440723;6056.6971651418135;6059.424354686298;6074.42292982166;6075.544334174954;5560.888782224414;5646.632968857011;5689.118186681071;5690.601657883908;5729.369769325371;5114.872128196825;5149.2791009258735;5161.2516185152945;5162.303089082926;5163.97418012915;6029.125776762345;6163.876722465526;6167.537434692416;6169.136320914986;6200.534959878028;5910.881782364415;5963.135345374983;5982.0727787193055;6002.909956350571;6006.219191505076;6198.876022479435;6256.655883926245;6267.592606480564;6267.905981410191;6276.497880169484;5901.114832775118;5917.763289468373;5922.496587789914;5927.496162826208;5968.76124954997;5817.389174136655;5903.114532820111;5933.1396947443245;5947.405259474191;5968.46283834457;5815.098659707752;5844.824655260349;5853.502452291433;5868.237129173351;5874.060150375919;5701.344345400332;5810.041343178328;5856.092305692625;5862.882742345215;5875.059990401515;5680.602357834912;5685.857853553694;5739.62692424991;5763.366029736641;5779.306483221872;5753.252077229933;5807.274090738658;5821.38875418075;5839.124131380327;5845.18167456548;5597.328320601554;5723.7996670116345;5740.885182296414;5742.19609254713;5754.223179870663 10:26:53 INFO - PROCESS | 16375 | |1;ext.html;560.4862096023472;588.9941100588994;596.5198015597442;604.6341963112317;626.2547568393614;38673.80663096684;44050.33924491135;44118;44231.55768442315;44298;43749;44142.33786493205;44448.3332750009;44535.55464445354;44572.554274457245;8847;8966.237869781044;8968.103189681013;8970.775730606721;8980.64077436905;8909.554522273893;8924.643014279422;8957.417767845101;8968.865467018;9005.909940900572;8928.687495937644;8981.95509022454;9046.909530904706;9065.002849686529;9077.909220907806;8982.640694372218;9007;9037.457752534869;9056.501892395916;9067.183953444222;8845.557722113868;8861.379703420698;8929.508877011762;8932.64269429222;8933.687320943736;35246.823765881265;35306.29387412238;35333.29333413343;35358.292834143176;35423.4686479703;3563.429851223792;3698.408254679265;3742.8315725792404;3794.3739283018267;4143.357779544175;33011;33586.66413335884;33677.494837577455;33738.662613373795;34615.13462163441;4369.3009118541195;4401.515833258339;4411.801468933873;4480.910381792379;4519.028408892104;257243;257269;257826;257973;258817;34500.92730990191;35023.64976350204;35094.82452587721;55960;56639.71680141573;36830.263394731955;36932;36955.26089478195;37053.81473092617;37459.81270093632;15500.5349839505;15536.533903982898;15588.610284742972;15631.68736625261;15642.139682317582;13071.542496012595;13110.606681799562;13139.934300328438;13156.276404797636;13176.802347964789;8299.83400332002;8350.749477515685;8391.118932512121;8418.789530261793;8488.405811593253;3193.7924034937655;3218.839058047088;3224.3228921926657;3268.950965735516;3286.4084464796088;1022.6062965758088;1035.6168217759478;1047.8428235764695;1060.506864308085;1152.8040233160382;32292.515612265834;32388.83805580957;33002.339953200804;33048.834755826065;33092.3381532368;1103.9779204416027;1107;1117.6200091968608;1156.8438260834848;1196.6709154982275;17085.572860678334;17239.82760172407;17342.219600118024;17395.130243487776;17417.82582174162;576661;577134;578443;578835;583428;58061.70969145127;58816.70591647014;59109;59143;59319;1348.5077946549438;1359.6532884114488;1365.9317034148253;1369.2400717601627;1369.5891232630172;28444.85777571099;29297.853510733163;29736;29954.25114372158;30120.69879301179;52309.47690523046;52671;52773.47226527839;52876.65480142253;52915.735421324185;478640;479147;480163;483187;483439;27915.16254512368;28482.85758571194;28964.855175723987;28993;29021.854890726256;49601.25598116103;50009.749951250014;50143;50237.49762502474;50954.49045509497;42355.364669529365;42601.78699106609;42805;43480.13039739251;43610.345844811716;42333;42465.575344246165;43090.138197235254;43176;43468.56531434645;40983.59016409917;41339;41484.58515414807;41675;44549;35567;38352.42471362876;38501;39016.6098339013;39048;27974.3006424841;28161.295967600974;28204.71795282021;28219;28220 10:26:53 INFO - PROCESS | 16375 | |2;jquery.html;386.7853341395528;393.20180034529915;394.6783371552185;398.4362127589461;418.6985370533217;14206.36071376788;19125.521861953457;19145.71281430776;20092.59814803705;20098;19059.714104288447;19521;19687.310944116958;19752.70370944437;20050.598988020232;5658.971705141468;5777.62445441046;5831.096180092071;5837.9124313135335;5890.057590785475;5732.366275611452;5735.139729040657;5771.451712087345;5771.855703607402;5785.1033089870925;5626.662400255977;6108.786192483264;6410.711517981678;6438.5171112166545;6457;6012.609180403259;6023.45788879003;6025.6987150642735;6391.712372943229;6510.381513756186;5803.738831752581;5879.500242479395;5967.045272756382;5997.760089596411;6003;14448.855511444855;14645.19451430171;14785.334659940221;14812.333444995002;18657.906710466497;2316.2698157377604;2350.1656911796235;2412;2516.245126462072;2976.8836686242657;10428.165746740318;10681.572737090508;11344.14918881079;11603.883961160449;15362.924595278335;1902.8287454129195;1989.0850208903921;1990.5521257717044;2015.1939224310247;2046.8567200295986;81303;81663.18336816615;82016.58991705063;83833.16166838375;86472;10892.128629709605;10962.945185274022;11098.5560577576;11137.387443690513;11338.376389298668;15423.151726654918;15429.38282468711;15493.380264789508;15590.064596124043;15605.765913511306;8212.17878212174;8235.341172706168;8378.958105209556;8443.113473085361;8481.712827336993;8082.474639148554;8221.958890205511;8304.169583041768;8309.792255193668;8332.416730828905;4772.403449568804;4791.808327666924;4813.95186048142;4849.58778503824;4944.406671199479;1937.903104844752;1943.154727693458;1965.3809050149157;1989.8507611928874;1996.6406046911695;911.2983003087586;995.4922989275377;1015.6546774096843;1023.9129673977795;1026.9229807764448;19119.71320430195;19328.71006934897;19441.910998808955;19541.21835126579;19605.803941960683;946.1248345280588;984.5421878826237;991.8264303746815;1003.267614641316;1033.3696445168441;9509.619615215452;10816.621418250323;10840.945795270973;10899.83650245247;10988.670339889815;504046;511174;511328;518736;521739;91457.54271228601;92257.538712306;101882.49058754659;105042.4747876271;108984.82613803996;1031.8916513766096;1034.3225187502198;1066.9999999999845;1074.3178081918038;1074.4520294649785;17615.383461578782;17824;18433;18566.350177743716;18604.906975465037;39273.80363098166;40172.799136004134;44730.77634611806;44892.102157956004;45170;64634.67682661556;65292;65724.67137664281;66137;66445;8450.239478446969;8690.826738390237;8786.912130878609;8846.012019254604;8873.245774109273;9975.60097596117;13507.72984540284;13616.52342168059;13634;13846.10000349974;11777.470013849226;11837.638671552882;11900.642980710592;12050.09624278165;12099.092568057607;11700;11937.224080434744;12065.819012714992;12085.637430877088;12272.079594030662;11965.700857478632;11966.46150923193;11986.76026479448;12203.816942746043;12235.265884046985;8691.652333906826;8720.694775683074;8789.912100879164;8803.779905502413;9065.637374504946;11174.5416008478;11596.304221746723;11750.23623464472;12125;12364.381780910739 10:26:53 INFO - PROCESS | 16375 | |3;mootools.html;1464.2166440954093;1506.4124991253414;1625.3092435714818;1781.3676144968535;1795.1024487756122;7811.296983271504;8486.575671216446;8517.701880434179;9058.90941090589;9072;8633.3524985626;8807.64769409223;8895.93248810142;8897.1102889711;8910.955445222764;2268.5009297954507;2320.8027317678016;2321.8374713770045;2336.789688927996;2337.2637619149914;2286.2455389721435;2323.256557901472;2329.8252631052655;2340.2745149003777;2347.3310106619615;2324.755900630435;2345.2729653807287;2355.6702061711376;2362.492064206195;2366.7869891709743;2246.629306164481;2253.076238742116;2266.8073213776847;2275.4083938176027;2279.099755596547;2230.319752475494;2232.888355582231;2235.0724449353497;2241.9887900560557;2249.1790496468834;8794.164554367326;8951.23914467271;8964;8974.14745599167;8984.281257499384;5234.607404444682;5394.136938089887;5427.511523962862;5434.538064264542;5436.945630543683;3272.394606997689;3282.4748040313434;3326.135204846733;3354.714849237818;3358.647342029101;1028.460058469302;1043.1341986151476;1051.458498873081;1081.4754843900703;1088.0642647323295;12413.875861241453;12421.31682757439;12434.564790232389;12441.502339906392;12446.688832779253;4536.364908912755;4568.725876447424;4745.1221524018165;4751.762411879392;4770.880727981828;10430.53062612169;10464.21518386124;10472.790544189074;10485.737856553495;10491.895081049091;5382.4886635769535;5422.539084177889;5431.103867861759;5433.130699088127;5435.076037073707;4332.566743325705;4755.809767609257;4860.586850117709;4884.780184891617;4980.975095124501;3939.8424063037733;3945.901352466154;4001.15975645112;4066.9796651016554;4072.2873497137884;1225.4559255338338;1233.4572787973264;1241.615099319196;1253.6928452529007;1268.226381907036;998.4209158687944;1003.1272792670278;1018.7504061504978;1024.2983556263982;1028.4806172882647;5906.586538942232;6011.368806275365;6047.0929360596265;6181.660008699565;6453.386928241809;905.8912930448256;938.2447130060231;940.1773448232797;965.2422848064236;1003.19744204636;4001.3397789365013;4068.0236743182013;4091.85678501251;4115;4281.250781113293;10715.624953126604;11176.552937882394;11216.55133794639;11219.495122719334;11224.94387528057;10945.398003109745;11017.228793984505;11033.668989930315;11086.223964322582;11110.666679999613;8170;8279.130691277449;8316.417850750511;8347.66609335632;8358.164183581594;5701.717113649395;5881.882362352814;5896.115582662464;5953.880922381441;6060.515158787374;10010.799784004425;10191.643292484727;10257.640982565574;10269.897301027193;10310.484475776331;10151.390916545031;10279.537420815932;10294.948525257325;10299.227557933335;10307.226957978031;6900.447964162955;7062.964685176541;7230.349268565854;7490.812729681802;7689.42329325314;8738.69414570487;8756.868646970173;8757.562121893752;8780.692675756318;8801.207891289558;6908.378245957888;7136.785896423115;7141.857162856818;7148.249433809375;7243.167035790952;7797.390636991468;7921.960390198012;7998.080220774453;8029.4379393441895;8045.235702608243;7140.285971402818;7144.857102858018;7190.065291512279;7196.316349946746;7206.315400036988;5081.136206844772;5092.261622064706;5239.47605239473;5266.710330931835;5340.839774806762;5428.592855535771;5476;5496.422875598165;5563.610547261815;5597.160425936142 10:26:53 INFO - PROCESS | 16375 | |4;prototype.html;315.81682624078036;324.67208119799;327.616688474485;331.09610762618047;333.2119537294297;5409.404965453807;5545;5637.746301416436;5667.773289068437;5704.57215708822;5539.778408863641;5560.221568980336;5563.666180029201;5563.972180139103;5570.442955704428;4379.934300985487;4385.166818304528;4386.254336762758;4386.6929314947965;4392.34114882767;4136.751794892316;4324.740515569076;4368.410264614284;4404.69167158299;4412.51462339144;4272.42322286492;4295.334223195409;4310.568943105695;4319.76241306728;4338.2191205582985;4325.480942286914;4355.390245365667;4357.80160455874;4362.236608593484;4370.650347972186;3735.122246272124;3757.6805971492454;3812.275667623143;3821.808909554511;3823.885283441501;5426.240326354314;5458.017556839767;5470.91793623096;5471.127657979553;5500.257465242181;4899.608031357483;4909.288153217799;4910.312556242129;4917.877053073702;4941.604671626261;5639.915401268984;5723.427657234285;5801.970990145064;5825.592208545403;5873.177755114288;4093.89765255871;4115.670746340285;4123.195976784528;4132.028973191298;4147.419361289422;6021.157038014681;6040.637561746265;6042.978510744628;6059.18201042858;6062.363161946249;4094.1811637672586;4188.057687020457;4190.769507677107;4192.916141677149;4212.19968206046;4244.405783190356;4257.552956939477;4270.0605866709275;4272.145570885836;4317.352397140391;4947.950520494821;4950.43070046942;4979.925301120486;4979.950200498021;5002.474740152305;5799.971000144972;5886.676232807151;5963.761449541969;5976.760929562855;5989.64062156272;1436.2459708652832;1448.5659197394505;1449.2681195995954;1449.7680371140566;1451.7659989009258;909.4043401571981;914.5290175559592;930.776613612728;936.3866667332908;947.4840255590999;4991.675541089818;5031.798728050837;5045.174702166798;5066.442691303953;5096.923546146811;5333.946660533423;5356.276902618175;5382.973085134628;5401.839923644633;5451.836444906659;4908.134908734658;5009.724465154379;5058.266551350107;5095.668781529189;5099.97450012755;2800.915972520828;2832.504311745436;2857.2999615094436;2874.3245337345707;2885.8268503889835;5450.727463626803;5472.589555783332;5488.588355873326;5536.640118392292;5573.386927437979;5390.326209223847;5728.427157284238;6166.630002199882;6205.627662340274;6231.813045608639;6232.597665525312;6257.8748425031245;6301.015180218216;6313.179286692701;6326.778562750374;5890.558208134493;5984.665980267786;6051.697415129314;6053.274816677226;6092.268927728701;5955.434233747787;5975.910361344497;5990;5992.610480318765;5996.70016499182;5686.2607860977805;6296.583268764492;6320.209973753281;6324.525660575568;6366;4197.937030944599;4201.18076974987;4222.59885310895;4233.364995250737;4233.407322974725;6098.176746139392;6106.198671391861;6116.969415152896;6120.3267640558615;6125.448709616156;5725.6850873202375;5883;5886.470217680429;5887.911681324698;5976.462118409364;5807.709614519342;5859.267591551056;5868.354481007171;5869.53043756507;5892.292924849045;5752.827415177551;5785.30576330843;5800.361960184461;5807.796727114531;5830.358660547421;5680.4319568042865;5981.850453738692;5998.220231369894;6036.788712395045;6050.364711705383;5843.649381037151;5859.853503662443;5890.1164825276555;5891.793787217598;5911.261092363455 10:26:53 INFO - PROCESS | 16375 | |5;yui.html;741.695904679082;773.8568364852503;781.2070748190584;781.3046388714046;812.3014207781309;15490.148041857694;16174.514764557052;16980.830191698096;16986.49040528783;17055.40306089287;15238.695226095499;15404.69190616187;15440.227988600582;15471.613209669764;15475.535733927973;649.9350064993498;801.3469022746472;825.3438516379463;828.2504333578122;828.3745771942175;793.6269953122053;793.7817100297407;797.9122296547375;798.0622768247315;798.1579433697447;833.4082801211117;833.5415521463201;838.907720150786;841.7348535211389;842.4524059361403;830.90444598871;831.7546323834483;833.8790875323105;834.9749507514754;836.1638361638362;603.0803025386277;603.1013789453726;605.2827399531525;607.3076692570473;609.2901769438598;15321.157336346496;15354.385824567004;15363.308651110727;15379.846201537954;15381.769273460906;15540.689186216325;15631;15736.111666599967;15914.76127858083;16245.912100183472;11074.390908500029;11081.113510919187;11228.719282017933;11311.773764524745;11374;3994.720369574131;4013.337799263118;4023.537293211289;4071.6946229032646;4076.1440097579543;78560.21439785586;80164.59917700432;80188.59905700492;80550.59724701339;80686.5965670168;11164.725622772241;11341.659750207507;11573.594924177612;11643.010344120676;12080.637580872588;23254.883725581265;23444.64833027506;23446;23452.765472345058;23901.685407302764;9035.277177825757;9057.139571740674;9258.583363748647;9341.532923353805;9352.719418417459;4347.152305300436;4513.796879140381;4515.480719717275;4550.795214215368;4592.127495775792;3553;3645.3438381091128;3648.543932008499;3652.415613501827;3654.524911761454;645.2128403347908;653.4935425045628;655.3708439897656;672.8553361027305;673.8483841135803;685.8216863615396;759.9278068583476;766.2720415605197;772.9188435214221;792.5482474989201;10297.9485102574;10350.689479315633;10369.637062702921;10415.583376665;10424.68725938223;628.6102616377875;639.9232092148972;646.0954663471084;676.5534747066912;777.4645075974904;4750.287456881426;5145;5158.8968220636125;5251.743918770387;5289.418164001957;68467.65766171138;68738.31261687419;73542;118310;118525;104889;105123;105253.47373263085;105558.47220764;107690;87068.5646571763;89529.55235223782;94329.5283523578;94530;94818.36271460932;9876.901230987598;10084.596616135272;10193.643222487177;10211.84682229782;10225.9488702559;50758;51180.48819511757;51409.48590514196;51477;52375.47624523706;68074.5962701853;76534;76534;76583.61708191647;81888;12397.132200746222;12430.12989090755;12431.564895228623;12494.875051249735;12701.618951431472;14966.17686027279;15157.621059473602;15401.537953861402;15983.280752366403;16204;14120.717585648435;14295.92852035733;14666.706665866835;15110.622234444227;15609.687806243584;12826.55107071248;13277.40251688657;13892.305384730926;13930.303484825921;13934.233617151154;14130.50543230982;14280.428782848985;14445.277736113363;14748.483803066842;15141.318640660977;11424.828627570427;11540.94229528847;11583.362915039754;12234.449449774604;12755.234685918875;11800.2329848563;12201.816972745593;12211.816822747489;12446.626601201979;12641.683957901127 10:26:53 INFO - PROCESS | 16375 | __end_tp_report 10:26:53 INFO - PROCESS | 16375 | __start_cc_report 10:26:53 INFO - PROCESS | 16375 | _x_x_mozilla_cycle_collect,349 10:26:53 INFO - PROCESS | 16375 | __end_cc_report 10:26:53 INFO - PROCESS | 16375 | __startTimestamp1468862813385__endTimestamp 10:26:53 INFO - PROCESS | 16375 | 10:26:53 INFO - PROCESS | 16375 | ------- Summary: start ------- 10:26:53 INFO - PROCESS | 16375 | Number of tests: 6 10:26:53 INFO - PROCESS | 16375 | 10:26:53 INFO - PROCESS | 16375 | [#0] dojo.html Cycles:165 Average:5505.12 Median:5753.25 stddev:751.58 (13.1%) stddev-sans-first:729.61 10:26:53 INFO - PROCESS | 16375 | Values: 3089.8 3111.8 3123.4 3150.2 3156.4 5483.3 5518.4 5540.6 5600.8 5608.2 5465.3 5512.5 5514.9 5515.9 5531.8 5005.1 5034.4 5139.6 5184.9 5192.6 608.0 4997.4 5006.8 5076.7 5157.3 5036.1 5044.2 5048.2 5057.4 5080.4 5097.4 5097.9 5103.5 5107.5 5121.9 4968.0 4986.5 5026.6 5039.2 5061.8 5564.1 5567.7 5577.2 5594.8 5606.4 5788.9 5995.2 5995.7 6006.9 6018.9 5837.1 5872.9 5882.6 5941.3 5949.0 5514.1 5515.4 5518.2 5523.2 5529.9 5945.4 6084.0 6134.5 6167.7 6167.7 5840.4 5845.0 5845.9 5846.7 5889.1 5972.4 5996.6 5998.9 6005.6 6014.3 5888.6 5898.6 5937.6 5945.9 5999.9 5959.9 5967.8 6008.4 6011.9 6014.2 4479.4 4548.8 4550.9 4551.0 4593.0 3942.1 3989.4 4000.2 4044.4 4056.6 5565.1 5573.7 5605.3 5638.6 5752.2 6026.4 6056.7 6059.4 6074.4 6075.5 5560.9 5646.6 5689.1 5690.6 5729.4 5114.9 5149.3 5161.3 5162.3 5164.0 6029.1 6163.9 6167.5 6169.1 6200.5 5910.9 5963.1 5982.1 6002.9 6006.2 6198.9 6256.7 6267.6 6267.9 6276.5 5901.1 5917.8 5922.5 5927.5 5968.8 5817.4 5903.1 5933.1 5947.4 5968.5 5815.1 5844.8 5853.5 5868.2 5874.1 5701.3 5810.0 5856.1 5862.9 5875.1 5680.6 5685.9 5739.6 5763.4 5779.3 5753.3 5807.3 5821.4 5839.1 5845.2 5597.3 5723.8 5740.9 5742.2 5754.2 10:26:53 INFO - PROCESS | 16375 | 10:26:53 INFO - PROCESS | 16375 | [#1] ext.html Cycles:180 Average:58786.10 Median:22813.97 stddev:122648.55 (537.6%) stddev-sans-first:122914.70 10:26:53 INFO - PROCESS | 16375 | Values: 560.5 589.0 596.5 604.6 626.3 38673.8 44050.3 44118.0 44231.6 44298.0 43749.0 44142.3 44448.3 44535.6 44572.6 8847.0 8966.2 8968.1 8970.8 8980.6 8909.6 8924.6 8957.4 8968.9 9005.9 8928.7 8982.0 9046.9 9065.0 9077.9 8982.6 9007.0 9037.5 9056.5 9067.2 8845.6 8861.4 8929.5 8932.6 8933.7 35246.8 35306.3 35333.3 35358.3 35423.5 3563.4 3698.4 3742.8 3794.4 4143.4 33011.0 33586.7 33677.5 33738.7 34615.1 4369.3 4401.5 4411.8 4480.9 4519.0 257243.0 257269.0 257826.0 257973.0 258817.0 34500.9 35023.6 35094.8 55960.0 56639.7 36830.3 36932.0 36955.3 37053.8 37459.8 15500.5 15536.5 15588.6 15631.7 15642.1 13071.5 13110.6 13139.9 13156.3 13176.8 8299.8 8350.7 8391.1 8418.8 8488.4 3193.8 3218.8 3224.3 3269.0 3286.4 1022.6 1035.6 1047.8 1060.5 1152.8 32292.5 32388.8 33002.3 33048.8 33092.3 1104.0 1107.0 1117.6 1156.8 1196.7 17085.6 17239.8 17342.2 17395.1 17417.8 576661.0 577134.0 578443.0 578835.0 583428.0 58061.7 58816.7 59109.0 59143.0 59319.0 1348.5 1359.7 1365.9 1369.2 1369.6 28444.9 29297.9 29736.0 29954.3 30120.7 52309.5 52671.0 52773.5 52876.7 52915.7 478640.0 479147.0 480163.0 483187.0 483439.0 27915.2 28482.9 28964.9 28993.0 29021.9 49601.3 50009.7 50143.0 50237.5 50954.5 42355.4 42601.8 42805.0 43480.1 43610.3 42333.0 42465.6 43090.1 43176.0 43468.6 40983.6 41339.0 41484.6 41675.0 44549.0 35567.0 38352.4 38501.0 39016.6 39048.0 27974.3 28161.3 28204.7 28219.0 28220.0 10:26:53 INFO - PROCESS | 16375 | 10:26:53 INFO - PROCESS | 16375 | [#2] jquery.html Cycles:180 Average:30131.09 Median:2181.56 stddev:84823.91 (3888.2%) stddev-sans-first:85032.46 10:26:53 INFO - PROCESS | 16375 | Values: 386.8 393.2 394.7 398.4 418.7 14206.4 19125.5 19145.7 20092.6 20098.0 19059.7 19521.0 19687.3 19752.7 20050.6 5659.0 5777.6 5831.1 5837.9 5890.1 5732.4 5735.1 5771.5 5771.9 5785.1 5626.7 6108.8 6410.7 6438.5 6457.0 6012.6 6023.5 6025.7 6391.7 6510.4 5803.7 5879.5 5967.0 5997.8 6003.0 14448.9 14645.2 14785.3 14812.3 18657.9 2316.3 2350.2 2412.0 2516.2 2976.9 10428.2 10681.6 11344.1 11603.9 15362.9 1902.8 1989.1 1990.6 2015.2 2046.9 81303.0 81663.2 82016.6 83833.2 86472.0 10892.1 10962.9 11098.6 11137.4 11338.4 15423.2 15429.4 15493.4 15590.1 15605.8 8212.2 8235.3 8379.0 8443.1 8481.7 8082.5 8222.0 8304.2 8309.8 8332.4 4772.4 4791.8 4814.0 4849.6 4944.4 1937.9 1943.2 1965.4 1989.9 1996.6 911.3 995.5 1015.7 1023.9 1026.9 19119.7 19328.7 19441.9 19541.2 19605.8 946.1 984.5 991.8 1003.3 1033.4 9509.6 10816.6 10840.9 10899.8 10988.7 504046.0 511174.0 511328.0 518736.0 521739.0 91457.5 92257.5 101882.5 105042.5 108984.8 1031.9 1034.3 1067.0 1074.3 1074.5 17615.4 17824.0 18433.0 18566.4 18604.9 39273.8 40172.8 44730.8 44892.1 45170.0 64634.7 65292.0 65724.7 66137.0 66445.0 8450.2 8690.8 8786.9 8846.0 8873.2 9975.6 13507.7 13616.5 13634.0 13846.1 11777.5 11837.6 11900.6 12050.1 12099.1 11700.0 11937.2 12065.8 12085.6 12272.1 11965.7 11966.5 11986.8 12203.8 12235.3 8691.7 8720.7 8789.9 8803.8 9065.6 11174.5 11596.3 11750.2 12125.0 12364.4 10:26:53 INFO - PROCESS | 16375 | 10:26:53 INFO - PROCESS | 16375 | [#3] mootools.html Cycles:180 Average:5840.97 Median:4434.47 stddev:3331.29 (75.1%) stddev-sans-first:3324.40 10:26:53 INFO - PROCESS | 16375 | Values: 1464.2 1506.4 1625.3 1781.4 1795.1 7811.3 8486.6 8517.7 9058.9 9072.0 8633.4 8807.6 8895.9 8897.1 8911.0 2268.5 2320.8 2321.8 2336.8 2337.3 2286.2 2323.3 2329.8 2340.3 2347.3 2324.8 2345.3 2355.7 2362.5 2366.8 2246.6 2253.1 2266.8 2275.4 2279.1 2230.3 2232.9 2235.1 2242.0 2249.2 8794.2 8951.2 8964.0 8974.1 8984.3 5234.6 5394.1 5427.5 5434.5 5436.9 3272.4 3282.5 3326.1 3354.7 3358.6 1028.5 1043.1 1051.5 1081.5 1088.1 12413.9 12421.3 12434.6 12441.5 12446.7 4536.4 4568.7 4745.1 4751.8 4770.9 10430.5 10464.2 10472.8 10485.7 10491.9 5382.5 5422.5 5431.1 5433.1 5435.1 4332.6 4755.8 4860.6 4884.8 4981.0 3939.8 3945.9 4001.2 4067.0 4072.3 1225.5 1233.5 1241.6 1253.7 1268.2 998.4 1003.1 1018.8 1024.3 1028.5 5906.6 6011.4 6047.1 6181.7 6453.4 905.9 938.2 940.2 965.2 1003.2 4001.3 4068.0 4091.9 4115.0 4281.3 10715.6 11176.6 11216.6 11219.5 11224.9 10945.4 11017.2 11033.7 11086.2 11110.7 8170.0 8279.1 8316.4 8347.7 8358.2 5701.7 5881.9 5896.1 5953.9 6060.5 10010.8 10191.6 10257.6 10269.9 10310.5 10151.4 10279.5 10294.9 10299.2 10307.2 6900.4 7063.0 7230.3 7490.8 7689.4 8738.7 8756.9 8757.6 8780.7 8801.2 6908.4 7136.8 7141.9 7148.2 7243.2 7797.4 7922.0 7998.1 8029.4 8045.2 7140.3 7144.9 7190.1 7196.3 7206.3 5081.1 5092.3 5239.5 5266.7 5340.8 5428.6 5476.0 5496.4 5563.6 5597.2 10:26:53 INFO - PROCESS | 16375 | 10:26:53 INFO - PROCESS | 16375 | [#4] prototype.html Cycles:180 Average:4850.54 Median:5471.02 stddev:1454.78 (26.6%) stddev-sans-first:1418.49 10:26:53 INFO - PROCESS | 16375 | Values: 315.8 324.7 327.6 331.1 333.2 5409.4 5545.0 5637.7 5667.8 5704.6 5539.8 5560.2 5563.7 5564.0 5570.4 4379.9 4385.2 4386.3 4386.7 4392.3 4136.8 4324.7 4368.4 4404.7 4412.5 4272.4 4295.3 4310.6 4319.8 4338.2 4325.5 4355.4 4357.8 4362.2 4370.7 3735.1 3757.7 3812.3 3821.8 3823.9 5426.2 5458.0 5470.9 5471.1 5500.3 4899.6 4909.3 4910.3 4917.9 4941.6 5639.9 5723.4 5802.0 5825.6 5873.2 4093.9 4115.7 4123.2 4132.0 4147.4 6021.2 6040.6 6043.0 6059.2 6062.4 4094.2 4188.1 4190.8 4192.9 4212.2 4244.4 4257.6 4270.1 4272.1 4317.4 4948.0 4950.4 4979.9 4980.0 5002.5 5800.0 5886.7 5963.8 5976.8 5989.6 1436.2 1448.6 1449.3 1449.8 1451.8 909.4 914.5 930.8 936.4 947.5 4991.7 5031.8 5045.2 5066.4 5096.9 5333.9 5356.3 5383.0 5401.8 5451.8 4908.1 5009.7 5058.3 5095.7 5100.0 2800.9 2832.5 2857.3 2874.3 2885.8 5450.7 5472.6 5488.6 5536.6 5573.4 5390.3 5728.4 6166.6 6205.6 6231.8 6232.6 6257.9 6301.0 6313.2 6326.8 5890.6 5984.7 6051.7 6053.3 6092.3 5955.4 5975.9 5990.0 5992.6 5996.7 5686.3 6296.6 6320.2 6324.5 6366.0 4197.9 4201.2 4222.6 4233.4 4233.4 6098.2 6106.2 6117.0 6120.3 6125.4 5725.7 5883.0 5886.5 5887.9 5976.5 5807.7 5859.3 5868.4 5869.5 5892.3 5752.8 5785.3 5800.4 5807.8 5830.4 5680.4 5981.9 5998.2 6036.8 6050.4 5843.6 5859.9 5890.1 5891.8 5911.3 10:26:53 INFO - PROCESS | 16375 | 10:26:53 INFO - PROCESS | 16375 | [#5] yui.html Cycles:180 Average:20912.78 Median:3824.62 stddev:29337.49 (767.1%) stddev-sans-first:29380.69 10:26:53 INFO - PROCESS | 16375 | Values: 741.7 773.9 781.2 781.3 812.3 15490.1 16174.5 16980.8 16986.5 17055.4 15238.7 15404.7 15440.2 15471.6 15475.5 649.9 801.3 825.3 828.3 828.4 793.6 793.8 797.9 798.1 798.2 833.4 833.5 838.9 841.7 842.5 830.9 831.8 833.9 835.0 836.2 603.1 603.1 605.3 607.3 609.3 15321.2 15354.4 15363.3 15379.8 15381.8 15540.7 15631.0 15736.1 15914.8 16245.9 11074.4 11081.1 11228.7 11311.8 11374.0 3994.7 4013.3 4023.5 4071.7 4076.1 78560.2 80164.6 80188.6 80550.6 80686.6 11164.7 11341.7 11573.6 11643.0 12080.6 23254.9 23444.6 23446.0 23452.8 23901.7 9035.3 9057.1 9258.6 9341.5 9352.7 4347.2 4513.8 4515.5 4550.8 4592.1 3553.0 3645.3 3648.5 3652.4 3654.5 645.2 653.5 655.4 672.9 673.8 685.8 759.9 766.3 772.9 792.5 10297.9 10350.7 10369.6 10415.6 10424.7 628.6 639.9 646.1 676.6 777.5 4750.3 5145.0 5158.9 5251.7 5289.4 68467.7 68738.3 73542.0 118310.0 118525.0 104889.0 105123.0 105253.5 105558.5 107690.0 87068.6 89529.6 94329.5 94530.0 94818.4 9876.9 10084.6 10193.6 10211.8 10225.9 50758.0 51180.5 51409.5 51477.0 52375.5 68074.6 76534.0 76534.0 76583.6 81888.0 12397.1 12430.1 12431.6 12494.9 12701.6 14966.2 15157.6 15401.5 15983.3 16204.0 14120.7 14295.9 14666.7 15110.6 15609.7 12826.6 13277.4 13892.3 13930.3 13934.2 14130.5 14280.4 14445.3 14748.5 15141.3 11424.8 11540.9 11583.4 12234.4 12755.2 11800.2 12201.8 12211.8 12446.6 12641.7 10:26:53 INFO - PROCESS | 16375 | -------- Summary: end -------- 10:26:53 INFO - PROCESS | 16375 | 10:26:54 INFO - TEST-INFO | 16375: exit 0 10:26:54 INFO - TEST-OK | dromaeo_css | took 1110333ms 10:26:54 INFO - TEST-START | kraken 10:26:54 INFO - operating with platform_type : linux_ 10:26:54 INFO - Initialising browser for kraken test... 10:26:54 INFO - TEST-INFO | started process 16626 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0DRNcE/profile http://localhost:43509/getInfo.html) 10:26:58 INFO - PROCESS | 16626 | __metrics Screen width/height:1600/1200 10:26:58 INFO - PROCESS | 16626 | colorDepth:24 10:26:58 INFO - PROCESS | 16626 | Browser inner width/height: 1024/697 10:26:58 INFO - PROCESS | 16626 | __metrics 10:26:59 ERROR - PROCESS | 16626 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2967: TypeError: this.tabs is undefined 10:26:59 INFO - TEST-INFO | 16626: exit 0 10:26:59 INFO - Browser initialized. 10:26:59 INFO - Running cycle 1/1 for kraken test... 10:26:59 INFO - TEST-INFO | started process 16745 (/builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp0DRNcE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:27:11 INFO - PROCESS | 16745 | RSS: Main: 167833600 10:27:11 INFO - PROCESS | 16745 | 10:27:14 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:43509/tests/kraken/driver.html?testName=audio-beat-detection) 10:27:15 INFO - PROCESS | 16745 | RSS: Main: 172990464 10:27:15 INFO - PROCESS | 16745 | 10:27:17 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:43509/tests/kraken/driver.html?testName=audio-dft) 10:27:18 INFO - PROCESS | 16745 | RSS: Main: 172171264 10:27:18 INFO - PROCESS | 16745 | 10:27:21 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:43509/tests/kraken/driver.html?testName=audio-fft) 10:27:21 INFO - PROCESS | 16745 | RSS: Main: 167059456 10:27:21 INFO - PROCESS | 16745 | 10:27:23 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:43509/tests/kraken/driver.html?testName=audio-oscillator) 10:27:24 INFO - PROCESS | 16745 | RSS: Main: 168443904 10:27:24 INFO - PROCESS | 16745 | 10:27:26 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:43509/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:27:27 INFO - PROCESS | 16745 | RSS: Main: 168349696 10:27:27 INFO - PROCESS | 16745 | 10:27:30 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:43509/tests/kraken/driver.html?testName=imaging-darkroom) 10:27:31 INFO - PROCESS | 16745 | RSS: Main: 167981056 10:27:31 INFO - PROCESS | 16745 | 10:27:34 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:43509/tests/kraken/driver.html?testName=imaging-desaturate) 10:27:35 INFO - PROCESS | 16745 | RSS: Main: 166318080 10:27:35 INFO - PROCESS | 16745 | 10:27:37 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:43509/tests/kraken/driver.html?testName=json-parse-financial) 10:27:38 INFO - PROCESS | 16745 | RSS: Main: 168284160 10:27:38 INFO - PROCESS | 16745 | 10:27:40 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:43509/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:27:40 INFO - PROCESS | 16745 | RSS: Main: 168153088 10:27:40 INFO - PROCESS | 16745 | 10:27:42 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:43509/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:27:43 INFO - PROCESS | 16745 | RSS: Main: 168009728 10:27:43 INFO - PROCESS | 16745 | 10:27:45 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:43509/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:27:45 INFO - PROCESS | 16745 | RSS: Main: 168914944 10:27:45 INFO - PROCESS | 16745 | 10:27:48 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:43509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:27:49 INFO - PROCESS | 16745 | RSS: Main: 169021440 10:27:49 INFO - PROCESS | 16745 | 10:27:51 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:43509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:27:52 INFO - PROCESS | 16745 | RSS: Main: 169246720 10:27:52 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | Cycle 1(1): loaded http://localhost:43509/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:43509/tests/kraken/driver.html?testName=ai-astar) 10:27:54 INFO - PROCESS | 16745 | RSS: Main: 169754624 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | __start_tp_report 10:27:54 INFO - PROCESS | 16745 | _x_x_mozilla_page_load 10:27:54 INFO - PROCESS | 16745 | _x_x_mozilla_page_load_details 10:27:54 INFO - PROCESS | 16745 | |i|pagename|runs| 10:27:54 INFO - PROCESS | 16745 | |0;ai-astar;103;112;105;113;112;113;112;113;111;112 10:27:54 INFO - PROCESS | 16745 | |1;audio-beat-detection;160;116;144;175;119;146;144;124;178;120 10:27:54 INFO - PROCESS | 16745 | |2;audio-dft;162;162;162;163;163;163;171;165;162;161 10:27:54 INFO - PROCESS | 16745 | |3;audio-fft;86;76;75;157;78;78;79;75;169;77 10:27:54 INFO - PROCESS | 16745 | |4;audio-oscillator;89;84;143;83;84;84;146;85;84;141 10:27:54 INFO - PROCESS | 16745 | |5;imaging-gaussian-blur;118;117;118;118;117;117;118;118;117;118 10:27:54 INFO - PROCESS | 16745 | |6;imaging-darkroom;147;147;148;148;148;146;148;149;148;147 10:27:54 INFO - PROCESS | 16745 | |7;imaging-desaturate;95;96;97;96;96;95;96;96;100;96 10:27:54 INFO - PROCESS | 16745 | |8;json-parse-financial;53;54;53;53;53;56;53;52;52;54 10:27:54 INFO - PROCESS | 16745 | |9;json-stringify-tinderbox;70;63;62;61;63;62;62;61;66;63 10:27:54 INFO - PROCESS | 16745 | |10;stanford-crypto-aes;77;76;82;77;76;75;75;75;86;82 10:27:54 INFO - PROCESS | 16745 | |11;stanford-crypto-ccm;121;122;139;125;133;123;129;122;167;124 10:27:54 INFO - PROCESS | 16745 | |12;stanford-crypto-pbkdf2;162;164;154;154;161;160;159;155;155;154 10:27:54 INFO - PROCESS | 16745 | |13;stanford-crypto-sha256-iterative;66;63;65;65;73;64;63;63;63;64 10:27:54 INFO - PROCESS | 16745 | __end_tp_report 10:27:54 INFO - PROCESS | 16745 | __start_cc_report 10:27:54 INFO - PROCESS | 16745 | _x_x_mozilla_cycle_collect,890 10:27:54 INFO - PROCESS | 16745 | __end_cc_report 10:27:54 INFO - PROCESS | 16745 | __startTimestamp1468862874378__endTimestamp 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | ------- Summary: start ------- 10:27:54 INFO - PROCESS | 16745 | Number of tests: 14 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#0] ai-astar Cycles:10 Average:110.60 Median:112.00 stddev:3.57 (3.2%) stddev-sans-first:2.51 10:27:54 INFO - PROCESS | 16745 | Values: 103.0 112.0 105.0 113.0 112.0 113.0 112.0 113.0 111.0 112.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#1] audio-beat-detection Cycles:10 Average:142.60 Median:145.00 stddev:22.96 (15.8%) stddev-sans-first:23.47 10:27:54 INFO - PROCESS | 16745 | Values: 160.0 116.0 144.0 175.0 119.0 146.0 144.0 124.0 178.0 120.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#2] audio-dft Cycles:10 Average:163.40 Median:163.00 stddev:2.88 (1.8%) stddev-sans-first:3.00 10:27:54 INFO - PROCESS | 16745 | Values: 162.0 162.0 162.0 163.0 163.0 163.0 171.0 165.0 162.0 161.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#3] audio-fft Cycles:10 Average:95.00 Median:77.50 stddev:36.09 (46.6%) stddev-sans-first:38.13 10:27:54 INFO - PROCESS | 16745 | Values: 86.0 76.0 75.0 157.0 78.0 78.0 79.0 75.0 169.0 77.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#4] audio-oscillator Cycles:10 Average:102.30 Median:84.00 stddev:28.39 (33.8%) stddev-sans-first:29.70 10:27:54 INFO - PROCESS | 16745 | Values: 89.0 84.0 143.0 83.0 84.0 84.0 146.0 85.0 84.0 141.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#5] imaging-gaussian-blur Cycles:10 Average:117.60 Median:118.00 stddev:0.52 (0.4%) stddev-sans-first:0.53 10:27:54 INFO - PROCESS | 16745 | Values: 118.0 117.0 118.0 118.0 117.0 117.0 118.0 118.0 117.0 118.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#6] imaging-darkroom Cycles:10 Average:147.60 Median:148.00 stddev:0.84 (0.6%) stddev-sans-first:0.87 10:27:54 INFO - PROCESS | 16745 | Values: 147.0 147.0 148.0 148.0 148.0 146.0 148.0 149.0 148.0 147.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:1.42 (1.5%) stddev-sans-first:1.42 10:27:54 INFO - PROCESS | 16745 | Values: 95.0 96.0 97.0 96.0 96.0 95.0 96.0 96.0 100.0 96.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#8] json-parse-financial Cycles:10 Average:53.30 Median:53.00 stddev:1.16 (2.2%) stddev-sans-first:1.22 10:27:54 INFO - PROCESS | 16745 | Values: 53.0 54.0 53.0 53.0 53.0 56.0 53.0 52.0 52.0 54.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#9] json-stringify-tinderbox Cycles:10 Average:63.30 Median:63.00 stddev:2.75 (4.4%) stddev-sans-first:1.51 10:27:54 INFO - PROCESS | 16745 | Values: 70.0 63.0 62.0 61.0 63.0 62.0 62.0 61.0 66.0 63.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#10] stanford-crypto-aes Cycles:10 Average:78.10 Median:77.00 stddev:3.84 (5.0%) stddev-sans-first:4.06 10:27:54 INFO - PROCESS | 16745 | Values: 77.0 76.0 82.0 77.0 76.0 75.0 75.0 75.0 86.0 82.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#11] stanford-crypto-ccm Cycles:10 Average:130.50 Median:127.00 stddev:14.05 (11.1%) stddev-sans-first:14.48 10:27:54 INFO - PROCESS | 16745 | Values: 121.0 122.0 139.0 125.0 133.0 123.0 129.0 122.0 167.0 124.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:157.80 Median:159.50 stddev:3.82 (2.4%) stddev-sans-first:3.74 10:27:54 INFO - PROCESS | 16745 | Values: 162.0 164.0 154.0 154.0 161.0 160.0 159.0 155.0 155.0 154.0 10:27:54 INFO - PROCESS | 16745 | 10:27:54 INFO - PROCESS | 16745 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:64.90 Median:64.50 stddev:3.03 (4.7%) stddev-sans-first:3.19 10:27:54 INFO - PROCESS | 16745 | Values: 66.0 63.0 65.0 65.0 73.0 64.0 63.0 63.0 63.0 64.0 10:27:54 INFO - PROCESS | 16745 | -------- Summary: end -------- 10:27:54 INFO - PROCESS | 16745 | 10:27:55 INFO - TEST-INFO | 16745: exit 0 10:27:55 INFO - TEST-OK | kraken | took 61313ms 10:27:55 INFO - SUITE-END | took 1171s 10:27:55 INFO - Completed test suite (00:19:31) 10:27:55 INFO - javascript benchmark 10:27:55 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": ["e10s"], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7313.264589693558, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3089.8146111233327, 3111.7977331473453, 3123.39093876694, 3150.243941454049, 3156.384505021522, 5483.341998960131, 5518.365387980379, 5540.612157149001, 5600.831975040745, 5608.186812912125, 5465.344158700961, 5512.476314750103, 5514.862128446791, 5515.889682206353, 5531.834044978647, 5005.12410328192, 5034.42104158021, 5139.58883289336, 5184.922226166611, 5192.584593232532, 607.9795206898294, 4997.4003119625695, 5006.824761133361, 5076.720780357079, 5157.329547158864, 5036.1438555445475, 5044.1677123274985, 5048.1670524363435, 5057.393112826466, 5080.441151473354, 5097.413797413308, 5097.949020509822, 5103.540681338697, 5107.514786095315, 5121.897562048738, 4967.975160124176, 4986.5013498650205, 5026.597872170254, 5039.168537191359, 5061.772220250097, 5564.054110801174, 5567.721613919288, 5577.2191893135, 5594.804181853616, 5606.439356064361, 5788.855278618026, 5995.2206213192, 5995.700214989277, 6006.879862402771, 6018.879622407528, 5837.09525023622, 5872.911906321408, 5882.588218824684, 5941.346451890288, 5949.048152295655, 5514.117741161395, 5515.365732940683, 5518.19986102013, 5523.226748255248, 5529.944700553024, 5945.40545945402, 6084.0, 6134.5092392608485, 6167.660778657217, 6167.6916154193, 5840.3575606683235, 5845.0, 5845.941540584625, 5846.6784326862435, 5889.087191485327, 5972.432618901197, 5996.580239383288, 5998.940010599926, 6005.609635373687, 6014.308354539196, 5888.646681199141, 5898.587098903122, 5937.584369094208, 5945.940540594625, 5999.880002399927, 5959.940400596025, 5967.820965370959, 6008.429199226067, 6011.939880601138, 6014.1580178775, 4479.440069991251, 4548.7725613719185, 4550.863474095782, 4551.0215303709865, 4593.0, 3942.0933185366953, 3989.3617021276455, 4000.179963107556, 4044.352903535479, 4056.59434056592, 5565.053940830068, 5573.665580065209, 5605.271314729141, 5638.605297629127, 5752.165935939265, 6026.367231440723, 6056.6971651418135, 6059.424354686298, 6074.42292982166, 6075.544334174954, 5560.888782224414, 5646.632968857011, 5689.118186681071, 5690.601657883908, 5729.369769325371, 5114.872128196825, 5149.2791009258735, 5161.2516185152945, 5162.303089082926, 5163.97418012915, 6029.125776762345, 6163.876722465526, 6167.537434692416, 6169.136320914986, 6200.534959878028, 5910.881782364415, 5963.135345374983, 5982.0727787193055, 6002.909956350571, 6006.219191505076, 6198.876022479435, 6256.655883926245, 6267.592606480564, 6267.905981410191, 6276.497880169484, 5901.114832775118, 5917.763289468373, 5922.496587789914, 5927.496162826208, 5968.76124954997, 5817.389174136655, 5903.114532820111, 5933.1396947443245, 5947.405259474191, 5968.46283834457, 5815.098659707752, 5844.824655260349, 5853.502452291433, 5868.237129173351, 5874.060150375919, 5701.344345400332, 5810.041343178328, 5856.092305692625, 5862.882742345215, 5875.059990401515, 5680.602357834912, 5685.857853553694, 5739.62692424991, 5763.366029736641, 5779.306483221872, 5753.252077229933, 5807.274090738658, 5821.38875418075, 5839.124131380327, 5845.18167456548, 5597.328320601554, 5723.7996670116345, 5740.885182296414, 5742.19609254713, 5754.223179870663], "value": 5454.29044097777, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [560.4862096023472, 588.9941100588994, 596.5198015597442, 604.6341963112317, 626.2547568393614, 38673.80663096684, 44050.33924491135, 44118.0, 44231.55768442315, 44298.0, 43749.0, 44142.33786493205, 44448.3332750009, 44535.55464445354, 44572.554274457245, 8847.0, 8966.237869781044, 8968.103189681013, 8970.775730606721, 8980.64077436905, 8909.554522273893, 8924.643014279422, 8957.417767845101, 8968.865467018, 9005.909940900572, 8928.687495937644, 8981.95509022454, 9046.909530904706, 9065.002849686529, 9077.909220907806, 8982.640694372218, 9007.0, 9037.457752534869, 9056.501892395916, 9067.183953444222, 8845.557722113868, 8861.379703420698, 8929.508877011762, 8932.64269429222, 8933.687320943736, 35246.823765881265, 35306.29387412238, 35333.29333413343, 35358.292834143176, 35423.4686479703, 3563.429851223792, 3698.408254679265, 3742.8315725792404, 3794.3739283018267, 4143.357779544175, 33011.0, 33586.66413335884, 33677.494837577455, 33738.662613373795, 34615.13462163441, 4369.3009118541195, 4401.515833258339, 4411.801468933873, 4480.910381792379, 4519.028408892104, 257243.0, 257269.0, 257826.0, 257973.0, 258817.0, 34500.92730990191, 35023.64976350204, 35094.82452587721, 55960.0, 56639.71680141573, 36830.263394731955, 36932.0, 36955.26089478195, 37053.81473092617, 37459.81270093632, 15500.5349839505, 15536.533903982898, 15588.610284742972, 15631.68736625261, 15642.139682317582, 13071.542496012595, 13110.606681799562, 13139.934300328438, 13156.276404797636, 13176.802347964789, 8299.83400332002, 8350.749477515685, 8391.118932512121, 8418.789530261793, 8488.405811593253, 3193.7924034937655, 3218.839058047088, 3224.3228921926657, 3268.950965735516, 3286.4084464796088, 1022.6062965758088, 1035.6168217759478, 1047.8428235764695, 1060.506864308085, 1152.8040233160382, 32292.515612265834, 32388.83805580957, 33002.339953200804, 33048.834755826065, 33092.3381532368, 1103.9779204416027, 1107.0, 1117.6200091968608, 1156.8438260834848, 1196.6709154982275, 17085.572860678334, 17239.82760172407, 17342.219600118024, 17395.130243487776, 17417.82582174162, 576661.0, 577134.0, 578443.0, 578835.0, 583428.0, 58061.70969145127, 58816.70591647014, 59109.0, 59143.0, 59319.0, 1348.5077946549438, 1359.6532884114488, 1365.9317034148253, 1369.2400717601627, 1369.5891232630172, 28444.85777571099, 29297.853510733163, 29736.0, 29954.25114372158, 30120.69879301179, 52309.47690523046, 52671.0, 52773.47226527839, 52876.65480142253, 52915.735421324185, 478640.0, 479147.0, 480163.0, 483187.0, 483439.0, 27915.16254512368, 28482.85758571194, 28964.855175723987, 28993.0, 29021.854890726256, 49601.25598116103, 50009.749951250014, 50143.0, 50237.49762502474, 50954.49045509497, 42355.364669529365, 42601.78699106609, 42805.0, 43480.13039739251, 43610.345844811716, 42333.0, 42465.575344246165, 43090.138197235254, 43176.0, 43468.56531434645, 40983.59016409917, 41339.0, 41484.58515414807, 41675.0, 44549.0, 35567.0, 38352.42471362876, 38501.0, 39016.6098339013, 39048.0, 27974.3006424841, 28161.295967600974, 28204.71795282021, 28219.0, 28220.0], "value": 18884.908603784006, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [386.7853341395528, 393.20180034529915, 394.6783371552185, 398.4362127589461, 418.6985370533217, 14206.36071376788, 19125.521861953457, 19145.71281430776, 20092.59814803705, 20098.0, 19059.714104288447, 19521.0, 19687.310944116958, 19752.70370944437, 20050.598988020232, 5658.971705141468, 5777.62445441046, 5831.096180092071, 5837.9124313135335, 5890.057590785475, 5732.366275611452, 5735.139729040657, 5771.451712087345, 5771.855703607402, 5785.1033089870925, 5626.662400255977, 6108.786192483264, 6410.711517981678, 6438.5171112166545, 6457.0, 6012.609180403259, 6023.45788879003, 6025.6987150642735, 6391.712372943229, 6510.381513756186, 5803.738831752581, 5879.500242479395, 5967.045272756382, 5997.760089596411, 6003.0, 14448.855511444855, 14645.19451430171, 14785.334659940221, 14812.333444995002, 18657.906710466497, 2316.2698157377604, 2350.1656911796235, 2412.0, 2516.245126462072, 2976.8836686242657, 10428.165746740318, 10681.572737090508, 11344.14918881079, 11603.883961160449, 15362.924595278335, 1902.8287454129195, 1989.0850208903921, 1990.5521257717044, 2015.1939224310247, 2046.8567200295986, 81303.0, 81663.18336816615, 82016.58991705063, 83833.16166838375, 86472.0, 10892.128629709605, 10962.945185274022, 11098.5560577576, 11137.387443690513, 11338.376389298668, 15423.151726654918, 15429.38282468711, 15493.380264789508, 15590.064596124043, 15605.765913511306, 8212.17878212174, 8235.341172706168, 8378.958105209556, 8443.113473085361, 8481.712827336993, 8082.474639148554, 8221.958890205511, 8304.169583041768, 8309.792255193668, 8332.416730828905, 4772.403449568804, 4791.808327666924, 4813.95186048142, 4849.58778503824, 4944.406671199479, 1937.903104844752, 1943.154727693458, 1965.3809050149157, 1989.8507611928874, 1996.6406046911695, 911.2983003087586, 995.4922989275377, 1015.6546774096843, 1023.9129673977795, 1026.9229807764448, 19119.71320430195, 19328.71006934897, 19441.910998808955, 19541.21835126579, 19605.803941960683, 946.1248345280588, 984.5421878826237, 991.8264303746815, 1003.267614641316, 1033.3696445168441, 9509.619615215452, 10816.621418250323, 10840.945795270973, 10899.83650245247, 10988.670339889815, 504046.0, 511174.0, 511328.0, 518736.0, 521739.0, 91457.54271228601, 92257.538712306, 101882.49058754659, 105042.4747876271, 108984.82613803996, 1031.8916513766096, 1034.3225187502198, 1066.9999999999845, 1074.3178081918038, 1074.4520294649785, 17615.383461578782, 17824.0, 18433.0, 18566.350177743716, 18604.906975465037, 39273.80363098166, 40172.799136004134, 44730.77634611806, 44892.102157956004, 45170.0, 64634.67682661556, 65292.0, 65724.67137664281, 66137.0, 66445.0, 8450.239478446969, 8690.826738390237, 8786.912130878609, 8846.012019254604, 8873.245774109273, 9975.60097596117, 13507.72984540284, 13616.52342168059, 13634.0, 13846.10000349974, 11777.470013849226, 11837.638671552882, 11900.642980710592, 12050.09624278165, 12099.092568057607, 11700.0, 11937.224080434744, 12065.819012714992, 12085.637430877088, 12272.079594030662, 11965.700857478632, 11966.46150923193, 11986.76026479448, 12203.816942746043, 12235.265884046985, 8691.652333906826, 8720.694775683074, 8789.912100879164, 8803.779905502413, 9065.637374504946, 11174.5416008478, 11596.304221746723, 11750.23623464472, 12125.0, 12364.381780910739], "value": 9403.22055007235, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1464.2166440954093, 1506.4124991253414, 1625.3092435714818, 1781.3676144968535, 1795.1024487756122, 7811.296983271504, 8486.575671216446, 8517.701880434179, 9058.90941090589, 9072.0, 8633.3524985626, 8807.64769409223, 8895.93248810142, 8897.1102889711, 8910.955445222764, 2268.5009297954507, 2320.8027317678016, 2321.8374713770045, 2336.789688927996, 2337.2637619149914, 2286.2455389721435, 2323.256557901472, 2329.8252631052655, 2340.2745149003777, 2347.3310106619615, 2324.755900630435, 2345.2729653807287, 2355.6702061711376, 2362.492064206195, 2366.7869891709743, 2246.629306164481, 2253.076238742116, 2266.8073213776847, 2275.4083938176027, 2279.099755596547, 2230.319752475494, 2232.888355582231, 2235.0724449353497, 2241.9887900560557, 2249.1790496468834, 8794.164554367326, 8951.23914467271, 8964.0, 8974.14745599167, 8984.281257499384, 5234.607404444682, 5394.136938089887, 5427.511523962862, 5434.538064264542, 5436.945630543683, 3272.394606997689, 3282.4748040313434, 3326.135204846733, 3354.714849237818, 3358.647342029101, 1028.460058469302, 1043.1341986151476, 1051.458498873081, 1081.4754843900703, 1088.0642647323295, 12413.875861241453, 12421.31682757439, 12434.564790232389, 12441.502339906392, 12446.688832779253, 4536.364908912755, 4568.725876447424, 4745.1221524018165, 4751.762411879392, 4770.880727981828, 10430.53062612169, 10464.21518386124, 10472.790544189074, 10485.737856553495, 10491.895081049091, 5382.4886635769535, 5422.539084177889, 5431.103867861759, 5433.130699088127, 5435.076037073707, 4332.566743325705, 4755.809767609257, 4860.586850117709, 4884.780184891617, 4980.975095124501, 3939.8424063037733, 3945.901352466154, 4001.15975645112, 4066.9796651016554, 4072.2873497137884, 1225.4559255338338, 1233.4572787973264, 1241.615099319196, 1253.6928452529007, 1268.226381907036, 998.4209158687944, 1003.1272792670278, 1018.7504061504978, 1024.2983556263982, 1028.4806172882647, 5906.586538942232, 6011.368806275365, 6047.0929360596265, 6181.660008699565, 6453.386928241809, 905.8912930448256, 938.2447130060231, 940.1773448232797, 965.2422848064236, 1003.19744204636, 4001.3397789365013, 4068.0236743182013, 4091.85678501251, 4115.0, 4281.250781113293, 10715.624953126604, 11176.552937882394, 11216.55133794639, 11219.495122719334, 11224.94387528057, 10945.398003109745, 11017.228793984505, 11033.668989930315, 11086.223964322582, 11110.666679999613, 8170.0, 8279.130691277449, 8316.417850750511, 8347.66609335632, 8358.164183581594, 5701.717113649395, 5881.882362352814, 5896.115582662464, 5953.880922381441, 6060.515158787374, 10010.799784004425, 10191.643292484727, 10257.640982565574, 10269.897301027193, 10310.484475776331, 10151.390916545031, 10279.537420815932, 10294.948525257325, 10299.227557933335, 10307.226957978031, 6900.447964162955, 7062.964685176541, 7230.349268565854, 7490.812729681802, 7689.42329325314, 8738.69414570487, 8756.868646970173, 8757.562121893752, 8780.692675756318, 8801.207891289558, 6908.378245957888, 7136.785896423115, 7141.857162856818, 7148.249433809375, 7243.167035790952, 7797.390636991468, 7921.960390198012, 7998.080220774453, 8029.4379393441895, 8045.235702608243, 7140.285971402818, 7144.857102858018, 7190.065291512279, 7196.316349946746, 7206.315400036988, 5081.136206844772, 5092.261622064706, 5239.47605239473, 5266.710330931835, 5340.839774806762, 5428.592855535771, 5476.0, 5496.422875598165, 5563.610547261815, 5597.160425936142], "value": 4664.93388746056, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [315.81682624078036, 324.67208119799, 327.616688474485, 331.09610762618047, 333.2119537294297, 5409.404965453807, 5545.0, 5637.746301416436, 5667.773289068437, 5704.57215708822, 5539.778408863641, 5560.221568980336, 5563.666180029201, 5563.972180139103, 5570.442955704428, 4379.934300985487, 4385.166818304528, 4386.254336762758, 4386.6929314947965, 4392.34114882767, 4136.751794892316, 4324.740515569076, 4368.410264614284, 4404.69167158299, 4412.51462339144, 4272.42322286492, 4295.334223195409, 4310.568943105695, 4319.76241306728, 4338.2191205582985, 4325.480942286914, 4355.390245365667, 4357.80160455874, 4362.236608593484, 4370.650347972186, 3735.122246272124, 3757.6805971492454, 3812.275667623143, 3821.808909554511, 3823.885283441501, 5426.240326354314, 5458.017556839767, 5470.91793623096, 5471.127657979553, 5500.257465242181, 4899.608031357483, 4909.288153217799, 4910.312556242129, 4917.877053073702, 4941.604671626261, 5639.915401268984, 5723.427657234285, 5801.970990145064, 5825.592208545403, 5873.177755114288, 4093.89765255871, 4115.670746340285, 4123.195976784528, 4132.028973191298, 4147.419361289422, 6021.157038014681, 6040.637561746265, 6042.978510744628, 6059.18201042858, 6062.363161946249, 4094.1811637672586, 4188.057687020457, 4190.769507677107, 4192.916141677149, 4212.19968206046, 4244.405783190356, 4257.552956939477, 4270.0605866709275, 4272.145570885836, 4317.352397140391, 4947.950520494821, 4950.43070046942, 4979.925301120486, 4979.950200498021, 5002.474740152305, 5799.971000144972, 5886.676232807151, 5963.761449541969, 5976.760929562855, 5989.64062156272, 1436.2459708652832, 1448.5659197394505, 1449.2681195995954, 1449.7680371140566, 1451.7659989009258, 909.4043401571981, 914.5290175559592, 930.776613612728, 936.3866667332908, 947.4840255590999, 4991.675541089818, 5031.798728050837, 5045.174702166798, 5066.442691303953, 5096.923546146811, 5333.946660533423, 5356.276902618175, 5382.973085134628, 5401.839923644633, 5451.836444906659, 4908.134908734658, 5009.724465154379, 5058.266551350107, 5095.668781529189, 5099.97450012755, 2800.915972520828, 2832.504311745436, 2857.2999615094436, 2874.3245337345707, 2885.8268503889835, 5450.727463626803, 5472.589555783332, 5488.588355873326, 5536.640118392292, 5573.386927437979, 5390.326209223847, 5728.427157284238, 6166.630002199882, 6205.627662340274, 6231.813045608639, 6232.597665525312, 6257.8748425031245, 6301.015180218216, 6313.179286692701, 6326.778562750374, 5890.558208134493, 5984.665980267786, 6051.697415129314, 6053.274816677226, 6092.268927728701, 5955.434233747787, 5975.910361344497, 5990.0, 5992.610480318765, 5996.70016499182, 5686.2607860977805, 6296.583268764492, 6320.209973753281, 6324.525660575568, 6366.0, 4197.937030944599, 4201.18076974987, 4222.59885310895, 4233.364995250737, 4233.407322974725, 6098.176746139392, 6106.198671391861, 6116.969415152896, 6120.3267640558615, 6125.448709616156, 5725.6850873202375, 5883.0, 5886.470217680429, 5887.911681324698, 5976.462118409364, 5807.709614519342, 5859.267591551056, 5868.354481007171, 5869.53043756507, 5892.292924849045, 5752.827415177551, 5785.30576330843, 5800.361960184461, 5807.796727114531, 5830.358660547421, 5680.4319568042865, 5981.850453738692, 5998.220231369894, 6036.788712395045, 6050.364711705383, 5843.649381037151, 5859.853503662443, 5890.1164825276555, 5891.793787217598, 5911.261092363455], "value": 4376.689385065901, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [741.695904679082, 773.8568364852503, 781.2070748190584, 781.3046388714046, 812.3014207781309, 15490.148041857694, 16174.514764557052, 16980.830191698096, 16986.49040528783, 17055.40306089287, 15238.695226095499, 15404.69190616187, 15440.227988600582, 15471.613209669764, 15475.535733927973, 649.9350064993498, 801.3469022746472, 825.3438516379463, 828.2504333578122, 828.3745771942175, 793.6269953122053, 793.7817100297407, 797.9122296547375, 798.0622768247315, 798.1579433697447, 833.4082801211117, 833.5415521463201, 838.907720150786, 841.7348535211389, 842.4524059361403, 830.90444598871, 831.7546323834483, 833.8790875323105, 834.9749507514754, 836.1638361638362, 603.0803025386277, 603.1013789453726, 605.2827399531525, 607.3076692570473, 609.2901769438598, 15321.157336346496, 15354.385824567004, 15363.308651110727, 15379.846201537954, 15381.769273460906, 15540.689186216325, 15631.0, 15736.111666599967, 15914.76127858083, 16245.912100183472, 11074.390908500029, 11081.113510919187, 11228.719282017933, 11311.773764524745, 11374.0, 3994.720369574131, 4013.337799263118, 4023.537293211289, 4071.6946229032646, 4076.1440097579543, 78560.21439785586, 80164.59917700432, 80188.59905700492, 80550.59724701339, 80686.5965670168, 11164.725622772241, 11341.659750207507, 11573.594924177612, 11643.010344120676, 12080.637580872588, 23254.883725581265, 23444.64833027506, 23446.0, 23452.765472345058, 23901.685407302764, 9035.277177825757, 9057.139571740674, 9258.583363748647, 9341.532923353805, 9352.719418417459, 4347.152305300436, 4513.796879140381, 4515.480719717275, 4550.795214215368, 4592.127495775792, 3553.0, 3645.3438381091128, 3648.543932008499, 3652.415613501827, 3654.524911761454, 645.2128403347908, 653.4935425045628, 655.3708439897656, 672.8553361027305, 673.8483841135803, 685.8216863615396, 759.9278068583476, 766.2720415605197, 772.9188435214221, 792.5482474989201, 10297.9485102574, 10350.689479315633, 10369.637062702921, 10415.583376665, 10424.68725938223, 628.6102616377875, 639.9232092148972, 646.0954663471084, 676.5534747066912, 777.4645075974904, 4750.287456881426, 5145.0, 5158.8968220636125, 5251.743918770387, 5289.418164001957, 68467.65766171138, 68738.31261687419, 73542.0, 118310.0, 118525.0, 104889.0, 105123.0, 105253.47373263085, 105558.47220764, 107690.0, 87068.5646571763, 89529.55235223782, 94329.5283523578, 94530.0, 94818.36271460932, 9876.901230987598, 10084.596616135272, 10193.643222487177, 10211.84682229782, 10225.9488702559, 50758.0, 51180.48819511757, 51409.48590514196, 51477.0, 52375.47624523706, 68074.5962701853, 76534.0, 76534.0, 76583.61708191647, 81888.0, 12397.132200746222, 12430.12989090755, 12431.564895228623, 12494.875051249735, 12701.618951431472, 14966.17686027279, 15157.621059473602, 15401.537953861402, 15983.280752366403, 16204.0, 14120.717585648435, 14295.92852035733, 14666.706665866835, 15110.622234444227, 15609.687806243584, 12826.55107071248, 13277.40251688657, 13892.305384730926, 13930.303484825921, 13934.233617151154, 14130.50543230982, 14280.428782848985, 14445.277736113363, 14748.483803066842, 15141.318640660977, 11424.828627570427, 11540.94229528847, 11583.362915039754, 12234.449449774604, 12755.234685918875, 11800.2329848563, 12201.816972745593, 12211.816822747489, 12446.626601201979, 12641.683957901127], "value": 7735.809594298124, "unit": "score"}]}, {"extraOptions": ["e10s"], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1523.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [103.0, 112.0, 105.0, 113.0, 112.0, 113.0, 112.0, 113.0, 111.0, 112.0], "value": 110.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [160.0, 116.0, 144.0, 175.0, 119.0, 146.0, 144.0, 124.0, 178.0, 120.0], "value": 142.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 162.0, 162.0, 163.0, 163.0, 163.0, 171.0, 165.0, 162.0, 161.0], "value": 163.4, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 76.0, 75.0, 157.0, 78.0, 78.0, 79.0, 75.0, 169.0, 77.0], "value": 95.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 84.0, 143.0, 83.0, 84.0, 84.0, 146.0, 85.0, 84.0, 141.0], "value": 102.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [118.0, 117.0, 118.0, 118.0, 117.0, 117.0, 118.0, 118.0, 117.0, 118.0], "value": 117.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 147.0, 148.0, 148.0, 148.0, 146.0, 148.0, 149.0, 148.0, 147.0], "value": 147.6, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 96.0, 96.0, 95.0, 96.0, 96.0, 100.0, 96.0], "value": 96.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 54.0, 53.0, 53.0, 53.0, 56.0, 53.0, 52.0, 52.0, 54.0], "value": 53.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 63.0, 62.0, 61.0, 63.0, 62.0, 62.0, 61.0, 66.0, 63.0], "value": 63.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [77.0, 76.0, 82.0, 77.0, 76.0, 75.0, 75.0, 75.0, 86.0, 82.0], "value": 78.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [121.0, 122.0, 139.0, 125.0, 133.0, 123.0, 129.0, 122.0, 167.0, 124.0], "value": 130.5, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [162.0, 164.0, 154.0, 154.0, 161.0, 160.0, 159.0, 155.0, 155.0, 154.0], "value": 157.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 63.0, 65.0, 65.0, 73.0, 64.0, 63.0, 63.0, 63.0, 64.0], "value": 64.9, "unit": "score"}]}]} 10:27:55 INFO - Return code: 0 10:27:55 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 10:27:55 ERROR - # TBPL SUCCESS # 10:27:55 INFO - Running post-action listener: _resource_record_post_action 10:27:55 INFO - ##### 10:27:55 INFO - ##### Finished run-tests step (success) 10:27:55 INFO - ##### 10:27:55 INFO - Running post-run listener: _resource_record_post_run 10:27:55 INFO - Total resource usage - Wall time: 1189s; CPU: 13.0%; Read bytes: 4096; Write bytes: 571240448; Read time: 12; Write time: 430736 10:27:55 INFO - TinderboxPrint: CPU usage
13.3% 10:27:55 INFO - TinderboxPrint: I/O read bytes / time
4,096 / 12 10:27:55 INFO - TinderboxPrint: I/O write bytes / time
571,240,448 / 430,736 10:27:55 INFO - TinderboxPrint: CPU idle
8,220.3 (86.6%) 10:27:55 INFO - TinderboxPrint: CPU user
1,212.8 (12.8%) 10:27:55 INFO - TinderboxPrint: Swap in / out
0 / 0 10:27:55 INFO - install - Wall time: 18s; CPU: 13.0%; Read bytes: 0; Write bytes: 257544192; Read time: 0; Write time: 217052 10:27:55 INFO - run-tests - Wall time: 1172s; CPU: 13.0%; Read bytes: 0; Write bytes: 297955328; Read time: 0; Write time: 210180 10:27:56 INFO - Running post-run listener: _upload_blobber_files 10:27:56 INFO - Blob upload gear active. 10:27:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:27:56 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:27:56 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:27:56 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:27:56 INFO - (blobuploader) - INFO - Open directory for files ... 10:27:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 10:27:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:27:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 10:28:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:10 INFO - (blobuploader) - INFO - Done attempting. 10:28:10 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:28:10 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:10 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:11 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:28:11 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:11 INFO - (blobuploader) - INFO - Done attempting. 10:28:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:28:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:28:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:28:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:28:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:28:12 INFO - (blobuploader) - INFO - Done attempting. 10:28:12 INFO - (blobuploader) - INFO - Iteration through files over. 10:28:12 INFO - Return code: 0 10:28:12 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:28:12 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:28:12 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c99eab849697ed9e24912dfd7ed063a7e3bba1530d93089f2ded775dd4d918657ecdbfdcbfffd21b308f5ced35ca664bf2d5425c8fa6c0197de57dd70c692acb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee38d09a9e97cb8acc73c5596e754e8cb4380ed91d70b4bd11c5509a6e3867fe4be33cbf4d833e11e382525fdaf86daade5aa0f07d0c0658738e36e9bf40da9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7980ee487d4ca46b0105086f9a53f1ea2fcefac2c9cf420f8e1ea170742f43ddd283c13749a3674b9e468237affd0b48aa882be4d08773669aadeb7e64457f1e"} 10:28:12 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:28:12 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:28:12 INFO - Contents: 10:28:12 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c99eab849697ed9e24912dfd7ed063a7e3bba1530d93089f2ded775dd4d918657ecdbfdcbfffd21b308f5ced35ca664bf2d5425c8fa6c0197de57dd70c692acb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee38d09a9e97cb8acc73c5596e754e8cb4380ed91d70b4bd11c5509a6e3867fe4be33cbf4d833e11e382525fdaf86daade5aa0f07d0c0658738e36e9bf40da9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7980ee487d4ca46b0105086f9a53f1ea2fcefac2c9cf420f8e1ea170742f43ddd283c13749a3674b9e468237affd0b48aa882be4d08773669aadeb7e64457f1e"} 10:28:12 INFO - Running post-run listener: copy_logs_to_upload_dir 10:28:12 INFO - Copying logs to upload dir... 10:28:12 INFO - mkdir: /builds/slave/test/build/upload/logs 10:28:12 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1237.689277 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 37 secs) (at 2016-07-18 10:28:12.093244) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 10:28:12.096565) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472 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/Firefox/sha512/c99eab849697ed9e24912dfd7ed063a7e3bba1530d93089f2ded775dd4d918657ecdbfdcbfffd21b308f5ced35ca664bf2d5425c8fa6c0197de57dd70c692acb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee38d09a9e97cb8acc73c5596e754e8cb4380ed91d70b4bd11c5509a6e3867fe4be33cbf4d833e11e382525fdaf86daade5aa0f07d0c0658738e36e9bf40da9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7980ee487d4ca46b0105086f9a53f1ea2fcefac2c9cf420f8e1ea170742f43ddd283c13749a3674b9e468237affd0b48aa882be4d08773669aadeb7e64457f1e"} build_url:https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/artifacts/public/build/firefox-50.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/C-FyW77_RrmWjL1rIB7ytw/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/Firefox/sha512/c99eab849697ed9e24912dfd7ed063a7e3bba1530d93089f2ded775dd4d918657ecdbfdcbfffd21b308f5ced35ca664bf2d5425c8fa6c0197de57dd70c692acb", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0ee38d09a9e97cb8acc73c5596e754e8cb4380ed91d70b4bd11c5509a6e3867fe4be33cbf4d833e11e382525fdaf86daade5aa0f07d0c0658738e36e9bf40da9", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7980ee487d4ca46b0105086f9a53f1ea2fcefac2c9cf420f8e1ea170742f43ddd283c13749a3674b9e468237affd0b48aa882be4d08773669aadeb7e64457f1e"}' ========= master_lag: 0.01 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-07-18 10:28:12.121026) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 10:28:12.121328) ========= 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=03627c79f6bb3d1578c4a402000001ba-1468861651.226774-1199811472 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004543 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-18 10:28:12.203973) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 10:28:12.204288) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-18 10:28:12.204562) ========= ========= Total master_lag: 0.18 =========